builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0147 starttime: 1491400530.29 results: success (0) buildid: 20170405053423 builduid: 454d188142224191861ca95f9f74d963 revision: 3854bcf837a729374b4d345910c274fed12cffe4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.294848) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.295316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.295599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.322327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.322871) ========= 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.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-05 06:55:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2017-04-05 06:55:30 (145 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.205945 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.553907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.554216) ========= 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.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.038987 ========= master_lag: 0.30 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:30.890645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 06:55:30.891181) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3854bcf837a729374b4d345910c274fed12cffe4 --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 3854bcf837a729374b4d345910c274fed12cffe4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-05 06:55:30,997 truncating revision to first 12 chars 2017-04-05 06:55:30,998 Setting DEBUG logging. 2017-04-05 06:55:30,998 attempt 1/10 2017-04-05 06:55:30,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3854bcf837a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 06:55:31,964 unpacking tar archive at: mozilla-central-3854bcf837a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 06:55:32.161799) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:32.162113) ========= script_repo_revision: 3854bcf837a729374b4d345910c274fed12cffe4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:32.162578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:32.162930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 06:55:32.197949) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-05 06:55:32.198298) ========= /tools/buildbot/bin/python -u 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', '-u', '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:55:32 INFO - MultiFileLogger online at 20170405 06:55:32 in /builds/slave/test 06:55:32 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 06:55:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:55:32 INFO - {'append_to_log': False, 06:55:32 INFO - 'base_work_dir': '/builds/slave/test', 06:55:32 INFO - 'blob_upload_branch': 'Firefox', 06:55:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:55:32 INFO - 'branch': 'Firefox', 06:55:32 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:32 INFO - 'config_files': ('talos/mac_config.py',), 06:55:32 INFO - 'default_actions': ('clobber', 06:55:32 INFO - 'read-buildbot-config', 06:55:32 INFO - 'download-and-extract', 06:55:32 INFO - 'populate-webroot', 06:55:32 INFO - 'create-virtualenv', 06:55:32 INFO - 'install', 06:55:32 INFO - 'run-tests'), 06:55:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:32 INFO - 'download_minidump_stackwalk': True, 06:55:32 INFO - 'download_symbols': 'ondemand', 06:55:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:32 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:32 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:32 INFO - 'gecko_profile': False, 06:55:32 INFO - 'gecko_profile_interval': 0, 06:55:32 INFO - 'installer_path': 'installer.exe', 06:55:32 INFO - 'log_level': 'info', 06:55:32 INFO - 'log_name': 'talos', 06:55:32 INFO - 'log_to_console': True, 06:55:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:55:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:55:32 INFO - 'opt_config_files': (), 06:55:32 INFO - 'pip_index': False, 06:55:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:55:32 INFO - 'cmd': ('bash', 06:55:32 INFO - '-c', 06:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:55:32 INFO - 'enabled': True, 06:55:32 INFO - 'halt_on_failure': False, 06:55:32 INFO - 'name': 'check_screen_resolution'},), 06:55:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:55:32 INFO - 'cmd': ('bash', 06:55:32 INFO - '-c', 06:55:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:55:32 INFO - 'enabled': True, 06:55:32 INFO - 'halt_on_failure': False, 06:55:32 INFO - 'name': 'check_screen_resolution'},), 06:55:32 INFO - 'run_cmd_checks_enabled': True, 06:55:32 INFO - 'suite': 'dromaeojs-e10s', 06:55:32 INFO - 'system_bits': '32', 06:55:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:32 INFO - 'title': 't-yosemite-r7-0147', 06:55:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:32 INFO - 'use_talos_json': True, 06:55:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:55:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:32 INFO - 'work_dir': 'build'} 06:55:32 INFO - [mozharness: 2017-04-05 13:55:32.420265Z] Running clobber step. 06:55:32 INFO - Running pre-action listener: _resource_record_pre_action 06:55:32 INFO - Running main action method: clobber 06:55:32 INFO - rmtree: /builds/slave/test/build 06:55:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:55:35 INFO - Running post-action listener: _resource_record_post_action 06:55:35 INFO - [mozharness: 2017-04-05 13:55:35.054725Z] Finished clobber step (success) 06:55:35 INFO - [mozharness: 2017-04-05 13:55:35.054863Z] Running read-buildbot-config step. 06:55:35 INFO - Running pre-action listener: _resource_record_pre_action 06:55:35 INFO - Running main action method: read_buildbot_config 06:55:35 INFO - Using buildbot properties: 06:55:35 INFO - { 06:55:35 INFO - "project": "", 06:55:35 INFO - "product": "firefox", 06:55:35 INFO - "script_repo_revision": "production", 06:55:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:55:35 INFO - "repository": "", 06:55:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:55:35 INFO - "buildid": "20170405053423", 06:55:35 INFO - "pgo_build": "False", 06:55:35 INFO - "basedir": "/builds/slave/test", 06:55:35 INFO - "buildnumber": 138, 06:55:35 INFO - "slavename": "t-yosemite-r7-0147", 06:55:35 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:55:35 INFO - "platform": "yosemite_r7", 06:55:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:55:35 INFO - "branch": "mozilla-central", 06:55:35 INFO - "repo_path": "mozilla-central", 06:55:35 INFO - "revision": "3854bcf837a729374b4d345910c274fed12cffe4", 06:55:35 INFO - "stage_platform": "macosx64", 06:55:35 INFO - "builduid": "454d188142224191861ca95f9f74d963", 06:55:35 INFO - "slavebuilddir": "test" 06:55:35 INFO - } 06:55:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:55:35 INFO - Running post-action listener: _resource_record_post_action 06:55:35 INFO - [mozharness: 2017-04-05 13:55:35.058226Z] Finished read-buildbot-config step (success) 06:55:35 INFO - [mozharness: 2017-04-05 13:55:35.058340Z] Running download-and-extract step. 06:55:35 INFO - Running pre-action listener: _resource_record_pre_action 06:55:35 INFO - Running main action method: download_and_extract 06:55:35 INFO - mkdir: /builds/slave/test/build/tests 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:55:35 INFO - trying https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:55:35 INFO - Downloading https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 06:55:35 INFO - Downloaded 1325 bytes. 06:55:35 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:55:35 INFO - Using the following test package requirements: 06:55:35 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 06:55:35 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:55:35 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:55:35 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:55:35 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'jsshell-mac.zip'], 06:55:35 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:55:35 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:55:35 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:55:35 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:55:35 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:55:35 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:55:35 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:55:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:55:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:55:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:55:35 INFO - Fetch https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:55:37 INFO - Expected file size: 52517825 06:55:37 INFO - Obtained file size: 52517825 06:55:53 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:55:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:55:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:55:53 INFO - Fetch https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:55:55 INFO - Expected file size: 52517825 06:55:55 INFO - Obtained file size: 52517825 06:56:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:56:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:56:10 INFO - Fetch https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:56:11 INFO - Expected file size: 14404152 06:56:11 INFO - Obtained file size: 14404152 06:56: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')]} 06:56:11 INFO - trying https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:56:11 INFO - Downloading https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:56:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 06:56:13 INFO - Downloaded 70749930 bytes. 06:56:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:56:13 INFO - mkdir: /builds/slave/test/properties 06:56:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:56:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:56:13 INFO - Contents: 06:56:13 INFO - build_url:https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:56:16 INFO - Running post-action listener: _resource_record_post_action 06:56:16 INFO - Running post-action listener: set_extra_try_arguments 06:56:16 INFO - [mozharness: 2017-04-05 13:56:16.687050Z] Finished download-and-extract step (success) 06:56:16 INFO - [mozharness: 2017-04-05 13:56:16.687205Z] Running populate-webroot step. 06:56:16 INFO - Running pre-action listener: _resource_record_pre_action 06:56:16 INFO - Running main action method: populate_webroot 06:56:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:56:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:56:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:56:16 INFO - '--tppagecycles', 06:56:16 INFO - '7'], 06:56:16 INFO - 'tests': ['tsvgm']}}, 06:56:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:56:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:56:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:56:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:56:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['damp', 'tps']}, 06:56:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'tests': ['damp', 'tps']}, 06:56:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['dromaeo_dom']}, 06:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:56:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['basic_compositor_video']}, 06:56:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:56:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['a11yr', 06:56:16 INFO - 'ts_paint', 06:56:16 INFO - 'tpaint', 06:56:16 INFO - 'sessionrestore', 06:56:16 INFO - 'sessionrestore_no_auto_restore', 06:56:16 INFO - 'tabpaint']}, 06:56:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['tsvgx', 06:56:16 INFO - 'tsvgr_opacity', 06:56:16 INFO - 'tart', 06:56:16 INFO - 'tscrollx', 06:56:16 INFO - 'cart', 06:56:16 INFO - 'tsvg_static']}, 06:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:56:16 INFO - 'tsvgr_opacity', 06:56:16 INFO - 'tart', 06:56:16 INFO - 'tscrollx', 06:56:16 INFO - 'cart', 06:56:16 INFO - 'tsvg_static']}, 06:56:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'talos_options': ['--disable-e10s'], 06:56:16 INFO - 'tests': ['tp5o']}, 06:56:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:56:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'talos_options': ['--disable-e10s', 06:56:16 INFO - '--xperf_path', 06:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:16 INFO - 'tests': ['tp5n']}, 06:56:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:56:16 INFO - 'talos_options': ['--xperf_path', 06:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:56:16 INFO - 'tests': ['tp5n']}}, 06:56:16 INFO - 'talos.zip': {'path': '', 06:56:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:56:16 INFO - Running post-action listener: _resource_record_post_action 06:56:16 INFO - [mozharness: 2017-04-05 13:56:16.706088Z] Finished populate-webroot step (success) 06:56:16 INFO - [mozharness: 2017-04-05 13:56:16.706179Z] Running create-virtualenv step. 06:56:16 INFO - Running pre-action listener: _resource_record_pre_action 06:56:16 INFO - Running main action method: create_virtualenv 06:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:56:16 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 06:56:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:56:16 INFO - Using real prefix '/tools/python27' 06:56:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:56:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:56:20 INFO - Installing pip.................done. 06:56:20 INFO - Return code: 0 06:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:56:20 INFO - Reading from file tmpfile_stdout 06:56:20 INFO - Output received: 06:56:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:56:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:56:20 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')]} 06:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:20 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')]} 06:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:20 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:20 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 06:56:20 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 06:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:20 INFO - 'HOME': '/Users/cltbld', 06:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:20 INFO - 'LOGNAME': 'cltbld', 06:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:20 INFO - 'MOZ_NO_REMOTE': '1', 06:56:20 INFO - 'NO_EM_RESTART': '1', 06:56:20 INFO - 'PAGER': '/bin/cat', 06:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:20 INFO - 'PWD': '/builds/slave/test', 06:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:20 INFO - 'SHELL': '/bin/bash', 06:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:20 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:20 INFO - 'USER': 'cltbld', 06:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:20 INFO - 'XPC_FLAGS': '0x0', 06:56:20 INFO - 'XPC_SERVICE_NAME': '0', 06:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:20 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 06:56:20 INFO - Cleaning up... 06:56:20 INFO - Return code: 0 06:56:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:56:20 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')]} 06:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:20 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')]} 06:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:20 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:20 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 06:56:20 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 06:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:20 INFO - 'HOME': '/Users/cltbld', 06:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:20 INFO - 'LOGNAME': 'cltbld', 06:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:20 INFO - 'MOZ_NO_REMOTE': '1', 06:56:20 INFO - 'NO_EM_RESTART': '1', 06:56:20 INFO - 'PAGER': '/bin/cat', 06:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:20 INFO - 'PWD': '/builds/slave/test', 06:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:20 INFO - 'SHELL': '/bin/bash', 06:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:20 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:20 INFO - 'USER': 'cltbld', 06:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:20 INFO - 'XPC_FLAGS': '0x0', 06:56:20 INFO - 'XPC_SERVICE_NAME': '0', 06:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:21 INFO - Downloading/unpacking psutil>=3.1.1 06:56:21 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 06:56:21 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 06:56:21 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 06:56:21 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 06:56:21 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 06:56:21 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 06:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:56:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:24 INFO - Installing collected packages: psutil 06:56:24 INFO - Running setup.py install for psutil 06:56:24 INFO - building 'psutil._psutil_osx' extension 06:56:24 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 06:56:25 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 06:56:25 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 06:56:25 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 06:56:25 INFO - building 'psutil._psutil_posix' extension 06:56:25 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 06:56:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:56:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:56:25 INFO - ^ 06:56:25 INFO - 1 warning generated. 06:56:25 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 06:56:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:56:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:56:25 INFO - Successfully installed psutil 06:56:25 INFO - Cleaning up... 06:56:25 INFO - Return code: 0 06:56:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:56: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')]} 06:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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')]} 06:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:27 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:27 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 06:56:27 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 06:56:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:27 INFO - 'HOME': '/Users/cltbld', 06:56:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:27 INFO - 'LOGNAME': 'cltbld', 06:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:27 INFO - 'MOZ_NO_REMOTE': '1', 06:56:27 INFO - 'NO_EM_RESTART': '1', 06:56:27 INFO - 'PAGER': '/bin/cat', 06:56:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:27 INFO - 'PWD': '/builds/slave/test', 06:56:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:27 INFO - 'SHELL': '/bin/bash', 06:56:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:27 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:27 INFO - 'USER': 'cltbld', 06:56:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:27 INFO - 'XPC_FLAGS': '0x0', 06:56:27 INFO - 'XPC_SERVICE_NAME': '0', 06:56:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:56:27 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 06:56:27 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 06:56:27 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 06:56:27 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 06:56:27 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 06:56:27 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 06:56:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:56:30 INFO - Installing collected packages: mozsystemmonitor 06:56:30 INFO - Running setup.py install for mozsystemmonitor 06:56:30 INFO - Successfully installed mozsystemmonitor 06:56:30 INFO - Cleaning up... 06:56:30 INFO - Return code: 0 06:56:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:30 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:30 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 06:56:30 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 06:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:30 INFO - 'HOME': '/Users/cltbld', 06:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:30 INFO - 'LOGNAME': 'cltbld', 06:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:30 INFO - 'MOZ_NO_REMOTE': '1', 06:56:30 INFO - 'NO_EM_RESTART': '1', 06:56:30 INFO - 'PAGER': '/bin/cat', 06:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:30 INFO - 'PWD': '/builds/slave/test', 06:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:30 INFO - 'SHELL': '/bin/bash', 06:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:30 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:30 INFO - 'USER': 'cltbld', 06:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:30 INFO - 'XPC_FLAGS': '0x0', 06:56:30 INFO - 'XPC_SERVICE_NAME': '0', 06:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:30 INFO - Downloading/unpacking jsonschema==2.5.1 06:56:30 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 06:56:30 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 06:56:30 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 06:56:30 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 06:56:30 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 06:56:30 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 06:56:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:56:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:56:33 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 06:56:33 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 06:56:33 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 06:56:33 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 06:56:33 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 06:56:33 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 06:56:33 INFO - Downloading functools32-3.2.3-2.tar.gz 06:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:56:33 INFO - warning: no files found matching '*.txt' 06:56:33 INFO - no previously-included directories found matching 'build' 06:56:33 INFO - no previously-included directories found matching 'dist' 06:56:33 INFO - no previously-included directories found matching '.git*' 06:56:33 INFO - Installing collected packages: jsonschema, functools32 06:56:33 INFO - Running setup.py install for functools32 06:56:33 INFO - warning: no files found matching '*.txt' 06:56:33 INFO - no previously-included directories found matching 'build' 06:56:33 INFO - no previously-included directories found matching 'dist' 06:56:33 INFO - no previously-included directories found matching '.git*' 06:56:34 INFO - Successfully installed jsonschema functools32 06:56:34 INFO - Cleaning up... 06:56:34 INFO - Return code: 0 06:56:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:56: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')]} 06:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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')]} 06:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:34 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:34 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 06:56:34 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 06:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:34 INFO - 'HOME': '/Users/cltbld', 06:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:34 INFO - 'LOGNAME': 'cltbld', 06:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:34 INFO - 'MOZ_NO_REMOTE': '1', 06:56:34 INFO - 'NO_EM_RESTART': '1', 06:56:34 INFO - 'PAGER': '/bin/cat', 06:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:34 INFO - 'PWD': '/builds/slave/test', 06:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:34 INFO - 'SHELL': '/bin/bash', 06:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:34 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:34 INFO - 'USER': 'cltbld', 06:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:34 INFO - 'XPC_FLAGS': '0x0', 06:56:34 INFO - 'XPC_SERVICE_NAME': '0', 06:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:56:34 INFO - Cleaning up... 06:56:34 INFO - Return code: 0 06:56:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:56: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')]} 06:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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')]} 06:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:34 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:34 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 06:56:34 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 06:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:34 INFO - 'HOME': '/Users/cltbld', 06:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:34 INFO - 'LOGNAME': 'cltbld', 06:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:34 INFO - 'MOZ_NO_REMOTE': '1', 06:56:34 INFO - 'NO_EM_RESTART': '1', 06:56:34 INFO - 'PAGER': '/bin/cat', 06:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:34 INFO - 'PWD': '/builds/slave/test', 06:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:34 INFO - 'SHELL': '/bin/bash', 06:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:34 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:34 INFO - 'USER': 'cltbld', 06:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:34 INFO - 'XPC_FLAGS': '0x0', 06:56:34 INFO - 'XPC_SERVICE_NAME': '0', 06:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:34 INFO - Downloading/unpacking blobuploader==1.2.4 06:56:34 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 06:56:34 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 06:56:34 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 06:56:34 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 06:56:34 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 06:56:34 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 06:56:37 INFO - Downloading blobuploader-1.2.4.tar.gz 06:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:56:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:56:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:56:38 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 06:56:38 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 06:56:38 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 06:56:38 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 06:56:38 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 06:56:38 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 06:56:38 INFO - Downloading docopt-0.6.1.tar.gz 06:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:56:38 INFO - Installing collected packages: blobuploader, requests, docopt 06:56:38 INFO - Running setup.py install for blobuploader 06:56:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:56:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:56:38 INFO - Running setup.py install for requests 06:56:39 INFO - Running setup.py install for docopt 06:56:39 INFO - Successfully installed blobuploader requests docopt 06:56:39 INFO - Cleaning up... 06:56:39 INFO - Return code: 0 06:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:39 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:39 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 06:56:39 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 06:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:39 INFO - 'HOME': '/Users/cltbld', 06:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:39 INFO - 'LOGNAME': 'cltbld', 06:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:39 INFO - 'MOZ_NO_REMOTE': '1', 06:56:39 INFO - 'NO_EM_RESTART': '1', 06:56:39 INFO - 'PAGER': '/bin/cat', 06:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:39 INFO - 'PWD': '/builds/slave/test', 06:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:39 INFO - 'SHELL': '/bin/bash', 06:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:39 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:39 INFO - 'USER': 'cltbld', 06:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:39 INFO - 'XPC_FLAGS': '0x0', 06:56:39 INFO - 'XPC_SERVICE_NAME': '0', 06:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:39 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-jqgcd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:39 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-QCgSCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:39 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-0oTSgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:39 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-hTJwHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-UYIUAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-eEHyyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-sPXgQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-XqAEdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-skh751-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-F5AORP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-fN9xrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-7_wJfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:40 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-V6S9Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:41 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OjdYth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:41 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WBJ878-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:41 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ckEVYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:41 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-bi0lgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:56:41 INFO - Running setup.py install for manifestparser 06:56:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:56:41 INFO - Running setup.py install for mozcrash 06:56:41 INFO - Running setup.py install for mozdebug 06:56:41 INFO - Running setup.py install for mozdevice 06:56:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Running setup.py install for mozfile 06:56:42 INFO - Running setup.py install for mozhttpd 06:56:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Running setup.py install for mozinfo 06:56:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Running setup.py install for mozInstall 06:56:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Running setup.py install for mozleak 06:56:42 INFO - Running setup.py install for mozlog 06:56:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:56:42 INFO - Running setup.py install for moznetwork 06:56:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Running setup.py install for mozprocess 06:56:43 INFO - Running setup.py install for mozprofile 06:56:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Running setup.py install for mozrunner 06:56:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Running setup.py install for mozscreenshot 06:56:43 INFO - Running setup.py install for moztest 06:56:43 INFO - Running setup.py install for mozversion 06:56:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:56:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:56:43 INFO - Cleaning up... 06:56:43 INFO - Return code: 0 06:56:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56: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')]} 06:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56: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')]} 06:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:43 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:43 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 06:56:43 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 06:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:43 INFO - 'HOME': '/Users/cltbld', 06:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:43 INFO - 'LOGNAME': 'cltbld', 06:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:43 INFO - 'MOZ_NO_REMOTE': '1', 06:56:43 INFO - 'NO_EM_RESTART': '1', 06:56:43 INFO - 'PAGER': '/bin/cat', 06:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:43 INFO - 'PWD': '/builds/slave/test', 06:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:43 INFO - 'SHELL': '/bin/bash', 06:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:43 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:43 INFO - 'USER': 'cltbld', 06:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:43 INFO - 'XPC_FLAGS': '0x0', 06:56:43 INFO - 'XPC_SERVICE_NAME': '0', 06:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Ee3Qbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:56:44 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)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8PFW5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OZkI3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:56:44 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)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-u4hsf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-SA2b0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:56:44 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)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-BxNans-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:56:44 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)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-6A7ziT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:56:44 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)) 06:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:56:44 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-SiwPWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:56:45 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-ykQ04Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:56:45 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-0yvEoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-DdQduh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:56:45 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-YTr4lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-aUf4wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:56:45 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-_EdcIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-z6WGZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:56:45 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)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Squ5jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:56:45 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-4DnIGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:56:46 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)) 06:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:56:46 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)) 06:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:56:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:48 INFO - Downloading blessings-1.6.tar.gz 06:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:56:48 INFO - Installing collected packages: blessings 06:56:48 INFO - Running setup.py install for blessings 06:56:48 INFO - Successfully installed blessings 06:56:48 INFO - Cleaning up... 06:56:49 INFO - Return code: 0 06:56:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:49 INFO - Reading from file tmpfile_stdout 06:56:49 INFO - Current package versions: 06:56:49 INFO - blessings == 1.6 06:56:49 INFO - blobuploader == 1.2.4 06:56:49 INFO - docopt == 0.6.1 06:56:49 INFO - functools32 == 3.2.3-2 06:56:49 INFO - jsonschema == 2.5.1 06:56:49 INFO - manifestparser == 1.1 06:56:49 INFO - mozInstall == 1.12 06:56:49 INFO - mozcrash == 1.0 06:56:49 INFO - mozdebug == 0.1 06:56:49 INFO - mozdevice == 0.49 06:56:49 INFO - mozfile == 1.2 06:56:49 INFO - mozhttpd == 0.7 06:56:49 INFO - mozinfo == 0.9 06:56:49 INFO - mozleak == 0.1 06:56:49 INFO - mozlog == 3.4 06:56:49 INFO - moznetwork == 0.27 06:56:49 INFO - mozprocess == 0.25 06:56:49 INFO - mozprofile == 0.28 06:56:49 INFO - mozrunner == 6.13 06:56:49 INFO - mozscreenshot == 0.1 06:56:49 INFO - mozsystemmonitor == 0.3 06:56:49 INFO - moztest == 0.8 06:56:49 INFO - mozversion == 1.4 06:56:49 INFO - psutil == 3.1.1 06:56:49 INFO - requests == 1.2.3 06:56:49 INFO - wsgiref == 0.1.2 06:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:49 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 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:49 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 06:56:49 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 06:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:49 INFO - 'HOME': '/Users/cltbld', 06:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:49 INFO - 'LOGNAME': 'cltbld', 06:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:49 INFO - 'MOZ_NO_REMOTE': '1', 06:56:49 INFO - 'NO_EM_RESTART': '1', 06:56:49 INFO - 'PAGER': '/bin/cat', 06:56:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:49 INFO - 'PWD': '/builds/slave/test', 06:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:49 INFO - 'SHELL': '/bin/bash', 06:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:49 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:49 INFO - 'USER': 'cltbld', 06:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:49 INFO - 'XPC_FLAGS': '0x0', 06:56:49 INFO - 'XPC_SERVICE_NAME': '0', 06:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 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)) 06:56:49 INFO - Cleaning up... 06:56:49 INFO - Return code: 0 06:56:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1099a6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099a9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff393df1b70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, '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.ZOXnval7hh/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.GDDzsOqTZW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 06:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:49 INFO - 'HOME': '/Users/cltbld', 06:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:49 INFO - 'LOGNAME': 'cltbld', 06:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:49 INFO - 'MOZ_NO_REMOTE': '1', 06:56:49 INFO - 'NO_EM_RESTART': '1', 06:56:49 INFO - 'PAGER': '/bin/cat', 06:56:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:49 INFO - 'PWD': '/builds/slave/test', 06:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:49 INFO - 'SHELL': '/bin/bash', 06:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:56:49 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:49 INFO - 'USER': 'cltbld', 06:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:49 INFO - 'XPC_FLAGS': '0x0', 06:56:49 INFO - 'XPC_SERVICE_NAME': '0', 06:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:56:49 INFO - Cleaning up... 06:56:49 INFO - Return code: 0 06:56:49 INFO - Running post-action listener: _resource_record_post_action 06:56:49 INFO - Running post-action listener: _start_resource_monitoring 06:56:49 INFO - Starting resource monitoring. 06:56:49 INFO - [mozharness: 2017-04-05 13:56:49.854876Z] Finished create-virtualenv step (success) 06:56:49 INFO - [mozharness: 2017-04-05 13:56:49.855816Z] Running install step. 06:56:49 INFO - Running pre-action listener: _resource_record_pre_action 06:56:49 INFO - Running main action method: install 06:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:50 INFO - Reading from file tmpfile_stdout 06:56:50 INFO - Detecting whether we're running mozinstall >=1.0... 06:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:56:50 INFO - Reading from file tmpfile_stdout 06:56:50 INFO - Output received: 06:56:50 INFO - Usage: mozinstall [options] installer 06:56:50 INFO - Options: 06:56:50 INFO - -h, --help show this help message and exit 06:56:50 INFO - -d DEST, --destination=DEST 06:56:50 INFO - Directory to install application into. [default: 06:56:50 INFO - "/builds/slave/test"] 06:56:50 INFO - --app=APP Application being installed. [default: firefox] 06:56:50 INFO - mkdir: /builds/slave/test/build/application 06:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:57:10 INFO - Reading from file tmpfile_stdout 06:57:10 INFO - Output received: 06:57:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:57:10 INFO - Running post-action listener: _resource_record_post_action 06:57:10 INFO - [mozharness: 2017-04-05 13:57:10.236960Z] Finished install step (success) 06:57:10 INFO - [mozharness: 2017-04-05 13:57:10.237123Z] Running run-tests step. 06:57:10 INFO - Running pre-action listener: _resource_record_pre_action 06:57:10 INFO - Running main action method: run_tests 06:57:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:57:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:57:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:57:10 INFO - 2017-04-05 06:57:10.251 screenresolution[1623:7386] starting screenresolution argv=screenresolution get 06:57:10 INFO - 2017-04-05 06:57:10.254 screenresolution[1623:7386] Display 0: 1600x1200x32@60 06:57:10 INFO - 2017-04-05 06:57:10.260 screenresolution[1624:7389] starting screenresolution argv=screenresolution list 06:57:10 INFO - Available Modes on Display 0 06:57:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:57:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:57:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:57:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:57:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:57:10 INFO - Intel Iris: 06:57:10 INFO - Chipset Model: Intel Iris 06:57:10 INFO - Type: GPU 06:57:10 INFO - Bus: Built-In 06:57:10 INFO - VRAM (Dynamic, Max): 1536 MB 06:57:10 INFO - Vendor: Intel (0x8086) 06:57:10 INFO - Device ID: 0x0a2e 06:57:10 INFO - Revision ID: 0x0009 06:57:10 INFO - Displays: 06:57:10 INFO - Display: 06:57:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:57:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:57:10 INFO - Display Serial Number: 1600x1200 60 06:57:10 INFO - Main Display: Yes 06:57:10 INFO - Mirror: Off 06:57:10 INFO - Online: Yes 06:57:10 INFO - Rotation: Supported 06:57:10 INFO - Return code: 0 06:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:57:10 INFO - Python 2.7.3 06:57:10 INFO - Return code: 0 06:57:10 INFO - grabbing minidump binary from tooltool 06:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:10 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 0x109784d30>, '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 0x1096abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109779be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:57:10 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 06:57:10 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 06:57:10 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 06:57:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:57:10 INFO - Return code: 0 06:57:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:57:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:57:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:57:10 INFO - ENV: RUST_BACKTRACE is now 1 06:57:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:57:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:57:10 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/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 06:57:10 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/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --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 06:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZOXnval7hh/Render', 06:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:57:10 INFO - 'HOME': '/Users/cltbld', 06:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:57:10 INFO - 'LOGNAME': 'cltbld', 06:57:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:57:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:10 INFO - 'MOZ_NO_REMOTE': '1', 06:57:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:57:10 INFO - 'NO_EM_RESTART': '1', 06:57:10 INFO - 'PAGER': '/bin/cat', 06:57:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:10 INFO - 'PWD': '/builds/slave/test', 06:57:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:57:10 INFO - 'RUST_BACKTRACE': '1', 06:57:10 INFO - 'SHELL': '/bin/bash', 06:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GDDzsOqTZW/Listeners', 06:57:10 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 06:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:57:10 INFO - 'USER': 'cltbld', 06:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:10 INFO - 'XPC_FLAGS': '0x0', 06:57:10 INFO - 'XPC_SERVICE_NAME': '0', 06:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:57:10 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/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 06:57:10 INFO - mozversion application_buildid: 20170405053423 06:57:10 INFO - mozversion application_changeset: 3854bcf837a729374b4d345910c274fed12cffe4 06:57:10 INFO - mozversion application_display_name: Nightly 06:57:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:57:10 INFO - mozversion application_name: Firefox 06:57:10 INFO - mozversion application_remotingname: firefox 06:57:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:57:10 INFO - mozversion application_vendor: Mozilla 06:57:10 INFO - mozversion application_version: 55.0a1 06:57:10 INFO - mozversion platform_buildid: 20170405053423 06:57:10 INFO - mozversion platform_changeset: 3854bcf837a729374b4d345910c274fed12cffe4 06:57:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:57:10 INFO - mozversion platform_version: 55.0a1 06:57:10 INFO - using testdate: 1491400630 06:57:10 INFO - actual date: 1491400630 06:57:10 INFO - starting webserver on 'localhost:49239' 06:57:10 INFO - SUITE-START | Running 2 tests 06:57:10 INFO - TEST-START | dromaeo_css 06:57:10 INFO - operating with platform_type : mac_ 06:57:10 INFO - Initialising browser for dromaeo_css test... 06:57:10 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpagpFur/profile http://localhost:49239/getInfo.html) 06:57:13 INFO - PID 1634 | 2017-04-05 06:57:13.882 plugin-container[1636:7568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 06:57:13 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:13 INFO - PID 1634 | 2017-04-05 06:57:13.886 plugin-container[1636:7568] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d0b, name = 'com.apple.CFPasteboardClient' 06:57:13 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:13 INFO - PID 1634 | 2017-04-05 06:57:13.887 plugin-container[1636:7568] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:57:13 INFO - PID 1634 | __metrics Screen width/height:1600/1200 06:57:13 INFO - PID 1634 | colorDepth:24 06:57:13 INFO - PID 1634 | Browser inner width/height: 1024/689 06:57:13 INFO - PID 1634 | __metrics 06:57:14 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 06:57:14 INFO - TEST-INFO | 1634: exit 0 06:57:14 INFO - Browser initialized. 06:57:14 INFO - Running cycle 1/1 for dromaeo_css test... 06:57:14 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpagpFur/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:57:17 INFO - PID 1637 | 2017-04-05 06:57:17.559 plugin-container[1638:7701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 06:57:17 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:17 INFO - PID 1637 | 2017-04-05 06:57:17.560 plugin-container[1638:7701] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 06:57:17 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:57:17 INFO - PID 1637 | 2017-04-05 06:57:17.560 plugin-container[1638:7701] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:57:27 INFO - PID 1637 | RSS: Main: 234811392 06:57:27 INFO - PID 1637 | 07:00:32 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 07:00:34 INFO - PID 1637 | RSS: Main: 257908736 07:00:34 INFO - PID 1637 | 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 07:02:15 INFO - PID 1637 | 07:02:15 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:02:15 INFO - PID 1637 | Full stack: 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 07:02:15 INFO - PID 1637 | 07:02:15 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:02:15 INFO - PID 1637 | Full stack: 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 07:02:15 INFO - PID 1637 | 07:02:15 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:02:15 INFO - PID 1637 | Full stack: 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | ************************* 07:02:15 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 07:02:15 INFO - PID 1637 | 07:02:15 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:02:15 INFO - PID 1637 | Full stack: 07:02:15 INFO - PID 1637 | ************************* 07:03:36 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 07:03:37 INFO - PID 1637 | RSS: Main: 264105984 07:03:37 INFO - PID 1637 | 07:06:38 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 07:06:39 INFO - PID 1637 | RSS: Main: 276664320 07:06:39 INFO - PID 1637 | 07:09:41 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 07:09:41 INFO - PID 1637 | RSS: Main: 269209600 07:09:41 INFO - PID 1637 | 07:12:44 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 07:12:45 INFO - PID 1637 | RSS: Main: 279502848 07:12:45 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 07:15:48 INFO - PID 1637 | RSS: Main: 273121280 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | __start_tp_report 07:15:48 INFO - PID 1637 | _x_x_mozilla_page_load 07:15:48 INFO - PID 1637 | _x_x_mozilla_page_load_details 07:15:48 INFO - PID 1637 | |i|pagename|runs| 07:15:48 INFO - PID 1637 | |0;dojo.html;3575.427931530954;3580.6419358064195;3601.477785721072;3619.511365965595;3627.691646210072;6143.235544005193;6199.442050215474;6238.313785483599;6240.531960102993;6298.905516417258;6222.284437289713;6232.719527621257;6265.404786545282;6290.905636415458;6333.936660633392;5463.945360546383;5522.420145884695;5546.278983732109;5583.162525621169;5634.633748806335;5470.890582188354;5558.305211848519;5612.803551875685;5618.91571626426;5646.491815736583;5403.891922161535;5433.8369848904595;5576.470235327637;5594.720263986785;5639.746211420496;4575.862724118282;5459.617826752129;5462.344518657746;5553.389127196006;5572.60991730579;5469.507744302992;5473.28847249859;5476.644018138808;5491.533219676332;5525.944740552583;6032.095185722133;6343.397377249154;6343.636118234602;6344.6827658616885;6352.968235158841;6559.278479367265;6657.367550082734;6717.966410167966;6803.081583986148;6809.931900680979;6937.826554336182;6951.7566885159285;6964.059851919977;6969.860602787916;6974.895376569356;6339.397757213057;6346.397092276226;6418.871622567569;6421.518386121013;6427.228732552124;6810.727570897108;6918.8962165567555;6954.7218111276;6996.19543752475;7036.437085033185;6513.837154071186;6531.575447595891;6609.20689517261;6711.161104861892;6743.898841517381;6822.829429264209;6830.8633827324165;6859.451243900476;6889.448844092461;6921.273266307066;6792.626405547742;6810.659467026629;6815.727370905108;6825.9317406826285;6839.350261725128;6521.250056243498;6558.967205164039;6664.067030615718;6776.3833371544615;6818.727250910008;5442.2108794225405;5454.509094181542;5501.532369748536;5515.834524964257;5525.696086715269;4105.281575724236;4857.101436234308;4866.537678920497;4880.487548807324;4891.095147397743;6395.072714456471;6436.8390790230615;6437.967810160919;6467.602030619224;6514.218293804774;6686.030525573862;6799.252082270947;6887.483438742114;6902.965485172643;6948.513604047769;4943.382077240345;5811.79658711943;6161.106639537332;6466.191726034246;6483.643399613066;5385.6230063895155;6059.182010428536;6077.36187700294;6131.509479241739;6163.137160797492;6912.239653638197;7044.8591028178125;7093.042439270633;7114.288571142844;7226.458015648953;6918.481113916376;6936.930630693831;6942.271061538466;6961.89557156633;6967.686454109476;7040.225575186623;7160.248173941661;7196.136463624399;7206.783796486114;7224.927750722425;5926.822195334147;6228.968855155877;6456.838579035561;6796.456283497209;6825.931740682729;6768.898466523105;6837.076994605664;6921.342472465108;6933.791986240421;6956.130483689539;6386;6577.440917522064;6663.267040625624;6665.333466653296;6671.833204169935;5368.731563421891;6498.220213574401;6518.934810652023;6525.347465253437;6585.1439312889015;5594.216809646734;6543.574667646588;6565.441937435371;6570.868582628416;6586.868262634816;5565.693886836101;6696.933030669631;6702.798916032527;6704.6982885769285;6705.2959439258175;6212.968935155295;6287;6407.711652975534;6515.12045873801;6553.082568440517 07:15:48 INFO - PID 1637 | |1;ext.html;724.9452047271221;790.2887401338795;814.5804910471109;1269.4985480735104;1279.2132838304433;34831.129221769435;36873.07817304569;38587.61412385875;39122;39351.60648393515;38614.8069259654;38836.80581597088;38857;38967.22065558687;38983;8007.879881801763;8155.266026057654;8513.702020429286;8735.868961965576;8747.95626021869;8702.782430439227;8747.431416957877;8815.118488151198;8830.11698830115;8838;8738.257248133916;8745.300375969908;8794.560271986407;8841.867371989392;8865.290776737878;8794.912050879473;8808.867866982;8819.162179592993;8836.337274704423;8848.823023539557;8683.13168683133;8733.694320698809;8741.431806932529;8747.343949203836;8751.212390884852;31455.37089258202;38137.42793858094;38396.80801596002;38397.424038639445;38484.61515384867;3483.756137070406;3488.4069708149677;3523.964760352415;3525.347810655037;3529.0824385659657;30269.394612107855;30391.696083039107;30540.862139650235;30609.38781224363;30654.386912261853;3103.3948380065895;3109.300407408338;3113.315070684446;3138.137012321607;3145.213696575856;208208;278071;332046;333667;340405.29797351104;52113.7394313026;52398;52445;52652.736736316074;52916;54680.72659636677;55155.44844551583;55391.44608553863;55603.88792224133;55641.44358556443;13867.514636987657;13975.02174847751;14003.579892603238;14011.71976560463;14026;11106.44467776608;11151.442427878574;11208.66374008781;11271.774564508827;11274.210805243718;12629.93685031569;14206.147631142165;14241.572752817225;14278;14339.784903226251;5823.30120385548;6229.408206220402;6233.875322493615;6248.812535623939;6251.749930002749;845.966161353539;906.2704522859029;946.1153821177221;986.1469828598355;1005.6178652112151;21129.577408451743;22216.777832221793;24177.75822241755;24252.87873560621;24301.906414211404;1049.1239814754765;1055.461714525582;1060.3584831177027;1088.7332603512032;1088.8693356797235;12077.335746534025;15851.365945362288;16104.75842862358;16206.432774852823;16286.592835179215;449158;450193;452377;454251;455599;58223.41776582265;58519.41480585225;58541.70729146327;58623;58668.41331586715;1398.9860101399058;1471.6615178509003;1471.7939488471836;1473.8452462491284;1492.8656420922168;23953.880230599432;28078.455684937526;29753.85123074371;29768.350933875878;29923.401531969674;31984.84007579947;37556.87329380123;37590.248195036496;37845.62154378531;37914.8104259477;389498;393853;394082;395516;395659;32248.516272256406;35175.42719446456;35635.643643563235;35667.82166089153;35745.82127089348;43633;43862.78068609637;44098.11803763843;44354.11291774211;44426;28641.713582863904;29077.41845163127;30310.84844575763;31204.063878083693;31246.68753312529;28846.855765721037;30251.546226806175;30722.539161913035;30959.380812384075;31063.689363106983;36225.45661815022;36917;36928.81535592305;37035;37053.81473092617;29408;30504.08487745371;30984.535231971087;31351.05946821599;31545.053648390585;19774;24422.63366049475;24502.387440314134;24565.89453474562;24600.43078361854 07:15:48 INFO - PID 1637 | |2;jquery.html;415.8897892058603;422.5812028197692;426.8143357639427;442.7520588470457;447.60834270013737;20236.59526809463;21893.890530547345;22650.88674556629;22819.42951426213;22831.543369132607;21973.90130493473;22663.206787762432;23149.537009259806;23397.94709238084;24049.398765030885;5935.703214839263;6068.362821903703;6253.030780229072;6255.968720156393;6257.687115644222;6095.939040609582;6176.258848938133;6240.906386404207;6247.687615619224;6290.842728931791;5503.257060296869;5967.910481342783;6160.691965401735;6214.223222097238;6227.003679411295;6225.564210505244;6264.467520260783;6271;6284.937150628503;6303.873922521547;5491.28613280271;5517.310336207974;5520.144377621435;5575.1915972184215;5584.944150558483;25393.984240630536;25584.592847393385;27422.314442138908;28118.859405703046;28328.71671283302;1804.0168108380965;2029.0869108901054;2038.2865996901114;2208.3374987503844;2214.368904862107;17404.912975435043;17649.911750441293;18464.076796160272;18577.814221857745;18659;2067.400453868376;2070.2133189388087;2078.5842831433774;2130.5099827039867;2135.0392323454507;123728;142958;156985.8602827937;163769.3623063778;166845;12313.815292770616;12857.721281073267;12933.54732584355;12966.935165324114;12982.35088245584;16337.509874703777;16610.169491525616;16659.083750393846;16690.916545417436;16718.331266749436;8666.956665216634;8851.69019084342;8867.556622168866;8955;8996.460212387277;8295.917040829514;8296.585170741439;8302.8339433211;8438.789030274293;8475;7992.080910695228;8085.312748416332;8128.431009829374;8153.225443582969;8157.306628936488;2212.402651284144;2216.5456081503253;2220.7446143693683;2222.377734234417;2391.0674836813655;909.4316052467208;929.4051806843626;939.3659279986118;941.9387739796891;976.6142373762466;20510.589788204154;20941.267055653283;20976.580468390548;20993.37019889406;21151.576968460544;945.4658118163353;978.2076518020426;986.5363279258737;988.9901100988898;992.7959928957703;10520.473976301155;10753.408562529135;10882.29265097766;10903.509342079467;10906.836397453886;713541;721480;721578;727135;732969;156899.21550392176;157072;164216;164320;167189;1117.6200091968608;1152.4065106470175;1169.9473523691454;1174.671092094215;1176.517627772609;14625.513662677584;17641.735373969143;17797.822021779615;18110;18247.361342352953;45182;52739.73630131825;61899.83350582708;65410.672946634964;65934.35164120936;74424.13939651551;84923.5753821227;85952.71070933816;86031.13968860482;86289.13710862811;7897.802554936173;8706.651733930825;8843.91156088431;8905.421147625384;8918.643254269757;13539.458421663023;13849.653758656113;13853.792193117313;13880.652983675489;14044.227567483886;11507.884921150682;11524.711882203012;11891.702707432383;11928.940355298168;11983.161178717406;10814.405207713651;10859.619913302997;10886.891131088587;11085.722856928642;11209.383483908463;11080.61217857371;11572.826407604061;11718.765624687288;11894.048476122063;11907.285562866256;7626.618669066635;8331.250187483156;8594.699185528476;8611.870821937551;8614.61234244448;9700.126988571063;11438;11456.484458199568;11489.82765258505;11793.351365674971 07:15:48 INFO - PID 1637 | |3;mootools.html;1180.3390101543137;1415.81594392729;1422.054333867978;1426.7360538300416;1462.5758530026294;11403.885961140386;11795.764084718301;11811.940940295297;11832.171747977634;12143.57497487588;11680.941595292012;11938.462769175387;11962.282263064222;11973.700657483545;11997.100217483701;2502.56205164096;2561.1164148368784;2562.988488525984;2564.217913536371;2565.525377805112;2081.895905204741;2479.8884050217694;2518.6725725655638;2526.7978561715017;2530.127106148376;2495.0643508684243;2504.111040580595;2522.2811498722867;2537.784288335494;2545.1346542175656;2000.7895223389858;2136.540643761591;2461.2862269941697;2504.5241404133158;2515.2454263720992;2402.5675378431874;2406.38637147528;2410.758924107593;2412.2039726890084;2498.675172227617;11449.141314401453;11510.827337589943;11565.13261505382;11593.594224202112;11614.012808911253;6615.735370585219;6867.862642747167;6868.553544019623;6872.896906546406;6875.5530890491955;4145.937810932838;4336.262835318003;4412.84555040572;4436.977815110936;4506.188886000518;957.1959553974694;1082.7942690888785;1212.4483360071147;1269.1686945051006;1277.2783377391745;15418.306176222097;15632.687346253011;15705;16432.671346573123;16524.925879817773;4671.5328467153695;4729.36153619257;5845.532357411397;5879.52963762898;5885.852853678693;10258.846117308247;11062.336259824437;12197.32914689683;12426.937865310616;12457.875421245853;6644.900326495106;6646.86706265872;6651;6659.567128136656;6665.500087493458;5874.324452687995;6064.0297552392285;6218.31598524162;6221.4089661482085;6282.905756413657;4070.063885306396;4366.126774645084;4461.732296062247;4466.9106617867465;4474.977625111854;1217.397388292783;1222.3582619124852;1256.1772039314264;1313.5271302331153;1337.1575907178415;748.3227678950558;755.0863455219246;776.6660336055551;780.3990926986189;805.7864665863551;6854.314568543105;7221.097362829646;7250.238724933912;7359.816004599821;7425.62871856405;894.3828758156851;899.2266650680409;922.3497434308796;926.5645146781002;946.1012038563255;3629.237860049366;4307.483102027777;4323.935140972888;4357.213542447581;4453.75504347264;14897.627559310888;15324.923375383052;15483.148426836633;15511.844881551266;15533.844661553467;14815.777763333559;15066.698666026618;15407.46073887431;15418.152001640017;15426.305816238297;10646.307989980782;10697.732556686145;10734.087602553871;10850.80641129475;10851.67444976652;6979.232284448605;7006.248437890527;7168.2831716827895;7207.5675459472595;7309.634518274172;13287.13633613812;13828.723425531232;13998.370073346927;14083.225422601856;14203.289835507976;13867.930660346634;13971.231582263074;14004.229767362485;14163.716725665636;14214.857851421768;10699.679009629723;10732.73168170802;10775.245732798629;10828.729281767704;10912.181586380895;10405.635802746867;10612.310199836986;10667.093297069836;10722.410267435365;10853.620123295646;7579.393648508217;8776.824463510566;8780.473171609723;9156.359054866096;9241.537923103953;7613.961930190314;8870.068642792414;9010.013337845608;9089.727308180765;9259.398139120936;8113.716019939274;8232.053313868983;8344.499330040217;8364.6235919385;8458.703945361884;6087.421694938974;6108.75564977396;6246.906296405648;6291.433770960635;6344.30212676596;6044.697765111815;6116.755329786759;6172.938270617236;6275.090111933835;6291.307956124731 07:15:48 INFO - PID 1637 | |4;prototype.html;380.3154322220005;384.15102623202705;395.2293028594241;403.75844278842567;407.1226506877676;5056.393232812063;5319.547838433728;5963.55273354498;6329.145565348676;6339.034899181257;4913.533214344631;5642.520385767215;5835.153902684108;6115.633062016271;6123.846903827406;4002.359622460407;4624.653151013687;4649.349870573775;4661.9067618647605;4705.176594096037;4682.484926658065;4691.997121842024;4699.624030077603;4702.224133018048;4708.623310135181;3828.693704503647;4245.893852653678;4427.71219870709;4478;4667.416572928384;4025.3156963316305;4065.7763822989723;4448.466184057917;4460.843870464518;4475.753833539154;3209.9679003209903;3797.240551889633;3847.153626202231;3849.30712471755;3867.3425517662067;4812.879678008043;5183.637145399824;5751.913721294184;5912.763489460416;5987.491063259628;4608.700434471749;4658.836940707059;5352.866178345534;5394.595405344576;5432.239486471897;6497.902531461985;6531.967340163316;6543.93456065438;6579.111819904348;6585.835354116138;3452.8273586320583;4256.87229383119;4327.5239723630375;4390.9022744313925;4418.9337159942625;6624.503162262801;6779;6811.092893989691;6904.447644188504;6993.335633114897;4269.807858646368;4441.289393696993;4455.420795296591;4486.887827804331;4490.640748740093;4170.395292682544;4434.490033646172;4555.453345598549;4556.476005259371;4565.155446242456;4524.819007239739;5240.633155679142;5338.932213557304;5396.163594642837;5400.703831080591;5368.785248590091;5726.713664316768;6512.479001679854;6536.607803531803;6554.934450655433;1397.8956624266716;1464.648484363745;1503.3911265937313;1524.7103050420385;1531.7242896278776;983.8720966274482;1008.324422636835;1012.4988130875116;1014.8224060789332;1027.3784360461814;5670.971645141748;6175.62946223228;6182.814515564541;6203.565750397519;6227.377262273827;6385;6508.9023664645065;6730.764423245163;6757.662116894136;6814.863702725917;5905.852353691193;6163.630182189083;6220.03589443637;6251.718672659741;6281.497480201573;3206.551082848403;3523.224890524081;3536.504889315498;3556.7332450066347;3568.3933731265747;6361.268454127742;6770.187577490733;6869.931300687029;7112.822179445452;7133.53762478701;6350.904736428957;6383.138276332728;7109.146902371645;7123.857522849514;7136.607486588287;6916.308369163144;7086.255943126001;7117.861142217221;7153.964230178815;7203.279672032964;5497.92790405867;5587.552995760248;6733.69698363565;6938.548994315353;6942.166939967236;5589.133684278943;6409.71156297977;6570.605763654196;6719.428848547928;6756.256811750605;6339.429451349401;7173.390261827594;7189.209186989531;7203.883398073307;7204.53170543913;4423.535528769433;4479.440069991251;4483.237849565647;4506.211413002777;4515.074409745928;6666.633335166613;6808;6864.725410983505;6905.654717264217;6937.479689023445;5349.57203423733;6619.966900165468;6625.768098116543;6672.9666351669875;6699.39705426514;5148.3564554430695;5909.852253693692;6110.816675499742;6135.907961380493;6612.173478315211;6483.578567393104;6544.509161812788;6554.344565543408;6563.803085907431;6569.751747168023;5306.681599104066;5871.7651293949475;6449.7420103195345;6638.601683898982;6656.700448479927;5596.552275817843;6389.648569328731;6400.551961362846;6415.294317624965;6447.677616119269 07:15:48 INFO - PID 1637 | |5;yui.html;739.4343327354575;784.917583653716;831.9642045653159;837.2757564706528;843.2031730015138;12764.936175319122;15419.306131224093;15952.521424357274;16493.17534123295;16547.66904661906;14894.180820054893;14964.578365055302;14999.550013499613;15074.924625376858;15251.847481525181;938.8686632607709;966.9274804389664;969.1955676788284;971.2327261463436;971.9854202186973;957.6169532187112;979.9608015679364;983.4787562591838;996.392200757541;997.5311603546357;1045.9581616735322;1048.7849990751915;1054.4200689620716;1061.9522121504513;1064.5050051725946;1044.185535282477;1050.9894901051007;1057.7091299892513;1059.4861492176287;1061.1881910338598;767.6507189228944;771.4831063187678;781.3788038509399;782.6634547144726;783.115079959642;16429;16575.585610359718;16711.331546738114;17046.659066818716;17193.7420938686;14825.55523334291;14841.699536571849;14847.331870065873;14906.850931490655;14989.550313490503;12249.387530623522;12507.312097834616;13509.256990865499;13546.119502232323;13596.320183990762;3203.951940720891;3361.5629968104236;3372.460406334975;3374.898753037413;3383.9661603383897;97490;99496;112769.87230127757;114909.46756169977;119479.80520194773;10952.561897524169;11350.035247003932;11525;11554.711132221762;11885.702857428634;20806.79193208079;25105.24684259475;25497.490050198892;25547;25757.484850303263;7666;7734.303912647776;7859.960700196462;7892.960535197287;8009.839803203903;3981.3828856526707;4109.219248342805;4113.197926404382;4156.9792151039055;4174.91650167001;4259.2759230930815;4291.592298731678;4346.891327716832;4367.497737760134;4372.234858899744;933.3000249812641;939.3049143633798;954.7994921066515;955.3885513271512;957.9233661307079;610.6366711806468;613.4938675592654;624.9031400132986;636.4367534731704;655.9635775474834;8645.610947507377;9531.714048578553;10159.516033623178;10275.588976441008;10318.845217321747;581.8225441240462;605.5155875299743;649.4804156674642;650.4536189600758;659.3406593406594;4178.435911152016;4524.660650451164;4862.8784280392565;5172.741362931838;5256.421793602701;97373.53939690911;105184;105637.47181264198;106330;106468;95227.57158642626;95503.52248238854;95953.5202323998;97271;97849.51075244579;59076;70281.64859175672;73519;74608;75659.24340756632;10794.19043571751;10822.51298691545;11019.944900275448;11035.39305338182;11064.612738554433;37390.25219495649;38151.046223843514;38953;39050.21899561936;40094.99762505961;68508;68628.6568567154;69793;70015;71666.64166679133;13473;14060.648483787987;14103.506377276746;14152.716945661236;14533.857850512553;12719.745605088032;14587.635309117357;14746.686362184846;14884.925575372054;15097.698046039237;12067.517299307929;13595.728085438433;13965.58103256904;14169.362378692776;14558.908081894113;13768.380422880795;13879.930600347338;13880.958928080232;13940.58178254654;13968.37142328618;13200.471981120647;13334.866651333363;13366.064375493623;13650.726985460036;14141.717165656424;9159;9332.440053596805;9411.717648470556;9446;9676.661316853877;10671.57313707474;10933.83599246028;11021.560040272967;11263.605773797877;11324.263922844988 07:15:48 INFO - PID 1637 | __end_tp_report 07:15:48 INFO - PID 1637 | __start_cc_report 07:15:48 INFO - PID 1637 | _x_x_mozilla_cycle_collect,430 07:15:48 INFO - PID 1637 | __end_cc_report 07:15:48 INFO - PID 1637 | __startTimestamp1491401748333__endTimestamp 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | ------- Summary: start ------- 07:15:48 INFO - PID 1637 | Number of tests: 6 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6239.99 Median:6467.60 stddev:775.82 (12.0%) stddev-sans-first:749.51 07:15:48 INFO - PID 1637 | Values: 3575.4 3580.6 3601.5 3619.5 3627.7 6143.2 6199.4 6238.3 6240.5 6298.9 6222.3 6232.7 6265.4 6290.9 6333.9 5463.9 5522.4 5546.3 5583.2 5634.6 5470.9 5558.3 5612.8 5618.9 5646.5 5403.9 5433.8 5576.5 5594.7 5639.7 4575.9 5459.6 5462.3 5553.4 5572.6 5469.5 5473.3 5476.6 5491.5 5525.9 6032.1 6343.4 6343.6 6344.7 6353.0 6559.3 6657.4 6718.0 6803.1 6809.9 6937.8 6951.8 6964.1 6969.9 6974.9 6339.4 6346.4 6418.9 6421.5 6427.2 6810.7 6918.9 6954.7 6996.2 7036.4 6513.8 6531.6 6609.2 6711.2 6743.9 6822.8 6830.9 6859.5 6889.4 6921.3 6792.6 6810.7 6815.7 6825.9 6839.4 6521.3 6559.0 6664.1 6776.4 6818.7 5442.2 5454.5 5501.5 5515.8 5525.7 4105.3 4857.1 4866.5 4880.5 4891.1 6395.1 6436.8 6438.0 6467.6 6514.2 6686.0 6799.3 6887.5 6903.0 6948.5 4943.4 5811.8 6161.1 6466.2 6483.6 5385.6 6059.2 6077.4 6131.5 6163.1 6912.2 7044.9 7093.0 7114.3 7226.5 6918.5 6936.9 6942.3 6961.9 6967.7 7040.2 7160.2 7196.1 7206.8 7224.9 5926.8 6229.0 6456.8 6796.5 6825.9 6768.9 6837.1 6921.3 6933.8 6956.1 6386.0 6577.4 6663.3 6665.3 6671.8 5368.7 6498.2 6518.9 6525.3 6585.1 5594.2 6543.6 6565.4 6570.9 6586.9 5565.7 6696.9 6702.8 6704.7 6705.3 6213.0 6287.0 6407.7 6515.1 6553.1 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:52467.16 Median:35985.64 stddev:102805.10 (285.7%) stddev-sans-first:103020.10 07:15:48 INFO - PID 1637 | Values: 724.9 790.3 814.6 1269.5 1279.2 34831.1 36873.1 38587.6 39122.0 39351.6 38614.8 38836.8 38857.0 38967.2 38983.0 8007.9 8155.3 8513.7 8735.9 8748.0 8702.8 8747.4 8815.1 8830.1 8838.0 8738.3 8745.3 8794.6 8841.9 8865.3 8794.9 8808.9 8819.2 8836.3 8848.8 8683.1 8733.7 8741.4 8747.3 8751.2 31455.4 38137.4 38396.8 38397.4 38484.6 3483.8 3488.4 3524.0 3525.3 3529.1 30269.4 30391.7 30540.9 30609.4 30654.4 3103.4 3109.3 3113.3 3138.1 3145.2 208208.0 278071.0 332046.0 333667.0 340405.3 52113.7 52398.0 52445.0 52652.7 52916.0 54680.7 55155.4 55391.4 55603.9 55641.4 13867.5 13975.0 14003.6 14011.7 14026.0 11106.4 11151.4 11208.7 11271.8 11274.2 12629.9 14206.1 14241.6 14278.0 14339.8 5823.3 6229.4 6233.9 6248.8 6251.7 846.0 906.3 946.1 986.1 1005.6 21129.6 22216.8 24177.8 24252.9 24301.9 1049.1 1055.5 1060.4 1088.7 1088.9 12077.3 15851.4 16104.8 16206.4 16286.6 449158.0 450193.0 452377.0 454251.0 455599.0 58223.4 58519.4 58541.7 58623.0 58668.4 1399.0 1471.7 1471.8 1473.8 1492.9 23953.9 28078.5 29753.9 29768.4 29923.4 31984.8 37556.9 37590.2 37845.6 37914.8 389498.0 393853.0 394082.0 395516.0 395659.0 32248.5 35175.4 35635.6 35667.8 35745.8 43633.0 43862.8 44098.1 44354.1 44426.0 28641.7 29077.4 30310.8 31204.1 31246.7 28846.9 30251.5 30722.5 30959.4 31063.7 36225.5 36917.0 36928.8 37035.0 37053.8 29408.0 30504.1 30984.5 31351.1 31545.1 19774.0 24422.6 24502.4 24565.9 24600.4 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:41343.95 Median:23273.74 stddev:121222.40 (520.9%) stddev-sans-first:121523.51 07:15:48 INFO - PID 1637 | Values: 415.9 422.6 426.8 442.8 447.6 20236.6 21893.9 22650.9 22819.4 22831.5 21973.9 22663.2 23149.5 23397.9 24049.4 5935.7 6068.4 6253.0 6256.0 6257.7 6095.9 6176.3 6240.9 6247.7 6290.8 5503.3 5967.9 6160.7 6214.2 6227.0 6225.6 6264.5 6271.0 6284.9 6303.9 5491.3 5517.3 5520.1 5575.2 5584.9 25394.0 25584.6 27422.3 28118.9 28328.7 1804.0 2029.1 2038.3 2208.3 2214.4 17404.9 17649.9 18464.1 18577.8 18659.0 2067.4 2070.2 2078.6 2130.5 2135.0 123728.0 142958.0 156985.9 163769.4 166845.0 12313.8 12857.7 12933.5 12966.9 12982.4 16337.5 16610.2 16659.1 16690.9 16718.3 8667.0 8851.7 8867.6 8955.0 8996.5 8295.9 8296.6 8302.8 8438.8 8475.0 7992.1 8085.3 8128.4 8153.2 8157.3 2212.4 2216.5 2220.7 2222.4 2391.1 909.4 929.4 939.4 941.9 976.6 20510.6 20941.3 20976.6 20993.4 21151.6 945.5 978.2 986.5 989.0 992.8 10520.5 10753.4 10882.3 10903.5 10906.8 713541.0 721480.0 721578.0 727135.0 732969.0 156899.2 157072.0 164216.0 164320.0 167189.0 1117.6 1152.4 1169.9 1174.7 1176.5 14625.5 17641.7 17797.8 18110.0 18247.4 45182.0 52739.7 61899.8 65410.7 65934.4 74424.1 84923.6 85952.7 86031.1 86289.1 7897.8 8706.7 8843.9 8905.4 8918.6 13539.5 13849.7 13853.8 13880.7 14044.2 11507.9 11524.7 11891.7 11928.9 11983.2 10814.4 10859.6 10886.9 11085.7 11209.4 11080.6 11572.8 11718.8 11894.0 11907.3 7626.6 8331.3 8594.7 8611.9 8614.6 9700.1 11438.0 11456.5 11489.8 11793.4 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:7272.71 Median:2524.54 stddev:4601.06 (182.3%) stddev-sans-first:4591.19 07:15:48 INFO - PID 1637 | Values: 1180.3 1415.8 1422.1 1426.7 1462.6 11403.9 11795.8 11811.9 11832.2 12143.6 11680.9 11938.5 11962.3 11973.7 11997.1 2502.6 2561.1 2563.0 2564.2 2565.5 2081.9 2479.9 2518.7 2526.8 2530.1 2495.1 2504.1 2522.3 2537.8 2545.1 2000.8 2136.5 2461.3 2504.5 2515.2 2402.6 2406.4 2410.8 2412.2 2498.7 11449.1 11510.8 11565.1 11593.6 11614.0 6615.7 6867.9 6868.6 6872.9 6875.6 4145.9 4336.3 4412.8 4437.0 4506.2 957.2 1082.8 1212.4 1269.2 1277.3 15418.3 15632.7 15705.0 16432.7 16524.9 4671.5 4729.4 5845.5 5879.5 5885.9 10258.8 11062.3 12197.3 12426.9 12457.9 6644.9 6646.9 6651.0 6659.6 6665.5 5874.3 6064.0 6218.3 6221.4 6282.9 4070.1 4366.1 4461.7 4466.9 4475.0 1217.4 1222.4 1256.2 1313.5 1337.2 748.3 755.1 776.7 780.4 805.8 6854.3 7221.1 7250.2 7359.8 7425.6 894.4 899.2 922.3 926.6 946.1 3629.2 4307.5 4323.9 4357.2 4453.8 14897.6 15324.9 15483.1 15511.8 15533.8 14815.8 15066.7 15407.5 15418.2 15426.3 10646.3 10697.7 10734.1 10850.8 10851.7 6979.2 7006.2 7168.3 7207.6 7309.6 13287.1 13828.7 13998.4 14083.2 14203.3 13867.9 13971.2 14004.2 14163.7 14214.9 10699.7 10732.7 10775.2 10828.7 10912.2 10405.6 10612.3 10667.1 10722.4 10853.6 7579.4 8776.8 8780.5 9156.4 9241.5 7614.0 8870.1 9010.0 9089.7 9259.4 8113.7 8232.1 8344.5 8364.6 8458.7 6087.4 6108.8 6246.9 6291.4 6344.3 6044.7 6116.8 6172.9 6275.1 6291.3 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5275.79 Median:5793.53 stddev:1683.90 (29.1%) stddev-sans-first:1648.05 07:15:48 INFO - PID 1637 | Values: 380.3 384.2 395.2 403.8 407.1 5056.4 5319.5 5963.6 6329.1 6339.0 4913.5 5642.5 5835.2 6115.6 6123.8 4002.4 4624.7 4649.3 4661.9 4705.2 4682.5 4692.0 4699.6 4702.2 4708.6 3828.7 4245.9 4427.7 4478.0 4667.4 4025.3 4065.8 4448.5 4460.8 4475.8 3210.0 3797.2 3847.2 3849.3 3867.3 4812.9 5183.6 5751.9 5912.8 5987.5 4608.7 4658.8 5352.9 5394.6 5432.2 6497.9 6532.0 6543.9 6579.1 6585.8 3452.8 4256.9 4327.5 4390.9 4418.9 6624.5 6779.0 6811.1 6904.4 6993.3 4269.8 4441.3 4455.4 4486.9 4490.6 4170.4 4434.5 4555.5 4556.5 4565.2 4524.8 5240.6 5338.9 5396.2 5400.7 5368.8 5726.7 6512.5 6536.6 6554.9 1397.9 1464.6 1503.4 1524.7 1531.7 983.9 1008.3 1012.5 1014.8 1027.4 5671.0 6175.6 6182.8 6203.6 6227.4 6385.0 6508.9 6730.8 6757.7 6814.9 5905.9 6163.6 6220.0 6251.7 6281.5 3206.6 3523.2 3536.5 3556.7 3568.4 6361.3 6770.2 6869.9 7112.8 7133.5 6350.9 6383.1 7109.1 7123.9 7136.6 6916.3 7086.3 7117.9 7154.0 7203.3 5497.9 5587.6 6733.7 6938.5 6942.2 5589.1 6409.7 6570.6 6719.4 6756.3 6339.4 7173.4 7189.2 7203.9 7204.5 4423.5 4479.4 4483.2 4506.2 4515.1 6666.6 6808.0 6864.7 6905.7 6937.5 5349.6 6620.0 6625.8 6673.0 6699.4 5148.4 5909.9 6110.8 6135.9 6612.2 6483.6 6544.5 6554.3 6563.8 6569.8 5306.7 5871.8 6449.7 6638.6 6656.7 5596.6 6389.6 6400.6 6415.3 6447.7 07:15:48 INFO - PID 1637 | 07:15:48 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:20630.44 Median:3282.76 stddev:29688.99 (904.4%) stddev-sans-first:29734.71 07:15:48 INFO - PID 1637 | Values: 739.4 784.9 832.0 837.3 843.2 12764.9 15419.3 15952.5 16493.2 16547.7 14894.2 14964.6 14999.6 15074.9 15251.8 938.9 966.9 969.2 971.2 972.0 957.6 980.0 983.5 996.4 997.5 1046.0 1048.8 1054.4 1062.0 1064.5 1044.2 1051.0 1057.7 1059.5 1061.2 767.7 771.5 781.4 782.7 783.1 16429.0 16575.6 16711.3 17046.7 17193.7 14825.6 14841.7 14847.3 14906.9 14989.6 12249.4 12507.3 13509.3 13546.1 13596.3 3204.0 3361.6 3372.5 3374.9 3384.0 97490.0 99496.0 112769.9 114909.5 119479.8 10952.6 11350.0 11525.0 11554.7 11885.7 20806.8 25105.2 25497.5 25547.0 25757.5 7666.0 7734.3 7860.0 7893.0 8009.8 3981.4 4109.2 4113.2 4157.0 4174.9 4259.3 4291.6 4346.9 4367.5 4372.2 933.3 939.3 954.8 955.4 957.9 610.6 613.5 624.9 636.4 656.0 8645.6 9531.7 10159.5 10275.6 10318.8 581.8 605.5 649.5 650.5 659.3 4178.4 4524.7 4862.9 5172.7 5256.4 97373.5 105184.0 105637.5 106330.0 106468.0 95227.6 95503.5 95953.5 97271.0 97849.5 59076.0 70281.6 73519.0 74608.0 75659.2 10794.2 10822.5 11019.9 11035.4 11064.6 37390.3 38151.0 38953.0 39050.2 40095.0 68508.0 68628.7 69793.0 70015.0 71666.6 13473.0 14060.6 14103.5 14152.7 14533.9 12719.7 14587.6 14746.7 14884.9 15097.7 12067.5 13595.7 13965.6 14169.4 14558.9 13768.4 13879.9 13881.0 13940.6 13968.4 13200.5 13334.9 13366.1 13650.7 14141.7 9159.0 9332.4 9411.7 9446.0 9676.7 10671.6 10933.8 11021.6 11263.6 11324.3 07:15:48 INFO - PID 1637 | -------- Summary: end -------- 07:15:48 INFO - PID 1637 | 07:15:48 INFO - TEST-INFO | 1637: exit 0 07:15:48 INFO - TEST-OK | dromaeo_css | took 1118149ms 07:15:48 INFO - TEST-START | kraken 07:15:48 INFO - operating with platform_type : mac_ 07:15:48 INFO - Initialising browser for kraken test... 07:15:49 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp8Mmkgc/profile http://localhost:49239/getInfo.html) 07:15:52 INFO - PID 1650 | 2017-04-05 07:15:52.090 plugin-container[1651:10171] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 07:15:52 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:15:52 INFO - PID 1650 | 2017-04-05 07:15:52.093 plugin-container[1651:10171] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 07:15:52 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:15:52 INFO - PID 1650 | 2017-04-05 07:15:52.093 plugin-container[1651:10171] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:15:52 INFO - PID 1650 | __metrics Screen width/height:1600/1200 07:15:52 INFO - PID 1650 | colorDepth:24 07:15:52 INFO - PID 1650 | Browser inner width/height: 1024/689 07:15:52 INFO - PID 1650 | __metrics 07:15:52 ERROR - PID 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 07:15:53 INFO - TEST-INFO | 1650: exit 0 07:15:53 INFO - Browser initialized. 07:15:53 INFO - Running cycle 1/1 for kraken test... 07:15:53 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp8Mmkgc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:55 INFO - PID 1652 | 2017-04-05 07:15:55.746 plugin-container[1653:10293] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 07:15:55 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:15:55 INFO - PID 1652 | 2017-04-05 07:15:55.747 plugin-container[1653:10293] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 07:15:55 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:15:55 INFO - PID 1652 | 2017-04-05 07:15:55.747 plugin-container[1653:10293] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:16:05 INFO - PID 1652 | RSS: Main: 234426368 07:16:05 INFO - PID 1652 | 07:16:08 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 07:16:09 INFO - PID 1652 | RSS: Main: 249364480 07:16:09 INFO - PID 1652 | 07:16:12 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 07:16:12 INFO - PID 1652 | RSS: Main: 257961984 07:16:12 INFO - PID 1652 | 07:16:16 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 07:16:17 INFO - PID 1652 | RSS: Main: 260214784 07:16:17 INFO - PID 1652 | 07:16:19 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 07:16:20 INFO - PID 1652 | RSS: Main: 261275648 07:16:20 INFO - PID 1652 | 07:16:21 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:16:22 INFO - PID 1652 | RSS: Main: 263057408 07:16:22 INFO - PID 1652 | 07:16:25 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 07:16:26 INFO - PID 1652 | RSS: Main: 268324864 07:16:26 INFO - PID 1652 | 07:16:29 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 07:16:30 INFO - PID 1652 | RSS: Main: 266612736 07:16:30 INFO - PID 1652 | 07:16:34 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 07:16:34 INFO - PID 1652 | RSS: Main: 266457088 07:16:34 INFO - PID 1652 | 07:16:36 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:16:37 INFO - PID 1652 | RSS: Main: 267706368 07:16:37 INFO - PID 1652 | 07:16:38 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:39 INFO - PID 1652 | RSS: Main: 268140544 07:16:39 INFO - PID 1652 | 07:16:41 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:42 INFO - PID 1652 | RSS: Main: 268419072 07:16:42 INFO - PID 1652 | 07:16:45 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:46 INFO - PID 1652 | RSS: Main: 268791808 07:16:46 INFO - PID 1652 | 07:16:49 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:50 INFO - PID 1652 | RSS: Main: 266489856 07:16:50 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 07:16:52 INFO - PID 1652 | RSS: Main: 269803520 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | __start_tp_report 07:16:52 INFO - PID 1652 | _x_x_mozilla_page_load 07:16:52 INFO - PID 1652 | _x_x_mozilla_page_load_details 07:16:52 INFO - PID 1652 | |i|pagename|runs| 07:16:52 INFO - PID 1652 | |0;ai-astar;110;123;172;124;186;188;153;121;122;123 07:16:52 INFO - PID 1652 | |1;audio-beat-detection;151;145;150;153;118;118;116;130;137;116 07:16:52 INFO - PID 1652 | |2;audio-dft;223;246;241;226;214;291;215;284;281;214 07:16:52 INFO - PID 1652 | |3;audio-fft;82;64;60;88;60;61;55;77;104;88 07:16:52 INFO - PID 1652 | |4;audio-oscillator;94;72;88;74;73;73;88;72;74;90 07:16:52 INFO - PID 1652 | |5;imaging-gaussian-blur;94;98;92;88;110;93;95;108;88;82 07:16:52 INFO - PID 1652 | |6;imaging-darkroom;138;114;117;162;163;101;144;158;129;103 07:16:52 INFO - PID 1652 | |7;imaging-desaturate;104;99;89;166;110;168;166;103;169;166 07:16:52 INFO - PID 1652 | |8;json-parse-financial;53;52;51;52;60;68;81;80;79;52 07:16:52 INFO - PID 1652 | |9;json-stringify-tinderbox;59;61;68;75;66;61;60;61;61;69 07:16:52 INFO - PID 1652 | |10;stanford-crypto-aes;86;89;90;86;88;92;88;87;86;87 07:16:52 INFO - PID 1652 | |11;stanford-crypto-ccm;171;150;140;148;136;164;138;178;223;159 07:16:52 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;253;192;228;202;254;237;193;247;199;237 07:16:52 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;72;67;78;104;111;101;65;78;78;62 07:16:52 INFO - PID 1652 | __end_tp_report 07:16:52 INFO - PID 1652 | __start_cc_report 07:16:52 INFO - PID 1652 | _x_x_mozilla_cycle_collect,1013 07:16:52 INFO - PID 1652 | __end_cc_report 07:16:52 INFO - PID 1652 | __startTimestamp1491401812748__endTimestamp 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | ------- Summary: start ------- 07:16:52 INFO - PID 1652 | Number of tests: 14 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:142.20 Median:138.50 stddev:29.78 (21.5%) stddev-sans-first:29.22 07:16:52 INFO - PID 1652 | Values: 110.0 123.0 172.0 124.0 186.0 188.0 153.0 121.0 122.0 123.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:141.00 stddev:15.66 (11.1%) stddev-sans-first:15.27 07:16:52 INFO - PID 1652 | Values: 151.0 145.0 150.0 153.0 118.0 118.0 116.0 130.0 137.0 116.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:243.50 Median:243.50 stddev:30.90 (12.7%) stddev-sans-first:31.87 07:16:52 INFO - PID 1652 | Values: 223.0 246.0 241.0 226.0 214.0 291.0 215.0 284.0 281.0 214.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:73.90 Median:70.50 stddev:16.29 (23.1%) stddev-sans-first:17.01 07:16:52 INFO - PID 1652 | Values: 82.0 64.0 60.0 88.0 60.0 61.0 55.0 77.0 104.0 88.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:81.00 stddev:8.95 (11.1%) stddev-sans-first:7.89 07:16:52 INFO - PID 1652 | Values: 94.0 72.0 88.0 74.0 73.0 73.0 88.0 72.0 74.0 90.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:92.50 stddev:8.72 (9.4%) stddev-sans-first:9.24 07:16:52 INFO - PID 1652 | Values: 94.0 98.0 92.0 88.0 110.0 93.0 95.0 108.0 88.0 82.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:132.90 Median:141.00 stddev:23.73 (16.8%) stddev-sans-first:25.10 07:16:52 INFO - PID 1652 | Values: 138.0 114.0 117.0 162.0 163.0 101.0 144.0 158.0 129.0 103.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:134.00 Median:167.00 stddev:35.18 (21.1%) stddev-sans-first:35.60 07:16:52 INFO - PID 1652 | Values: 104.0 99.0 89.0 166.0 110.0 168.0 166.0 103.0 169.0 166.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:64.00 stddev:12.95 (20.2%) stddev-sans-first:13.24 07:16:52 INFO - PID 1652 | Values: 53.0 52.0 51.0 52.0 60.0 68.0 81.0 80.0 79.0 52.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:63.50 stddev:5.20 (8.2%) stddev-sans-first:5.17 07:16:52 INFO - PID 1652 | Values: 59.0 61.0 68.0 75.0 66.0 61.0 60.0 61.0 61.0 69.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:88.00 stddev:1.97 (2.2%) stddev-sans-first:1.96 07:16:52 INFO - PID 1652 | Values: 86.0 89.0 90.0 86.0 88.0 92.0 88.0 87.0 86.0 87.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:160.70 Median:161.50 stddev:26.10 (16.2%) stddev-sans-first:27.41 07:16:52 INFO - PID 1652 | Values: 171.0 150.0 140.0 148.0 136.0 164.0 138.0 178.0 223.0 159.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:224.20 Median:237.00 stddev:25.20 (10.6%) stddev-sans-first:24.48 07:16:52 INFO - PID 1652 | Values: 253.0 192.0 228.0 202.0 254.0 237.0 193.0 247.0 199.0 237.0 07:16:52 INFO - PID 1652 | 07:16:52 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.60 Median:69.50 stddev:17.47 (25.1%) stddev-sans-first:18.18 07:16:52 INFO - PID 1652 | Values: 72.0 67.0 78.0 104.0 111.0 101.0 65.0 78.0 78.0 62.0 07:16:52 INFO - PID 1652 | -------- Summary: end -------- 07:16:52 INFO - PID 1652 | 07:16:53 INFO - TEST-INFO | 1652: exit 0 07:16:53 INFO - TEST-OK | kraken | took 64846ms 07:16:53 INFO - SUITE-END | took 1182s 07:16:53 INFO - Completed test suite (00:19:43) 07:16:53 INFO - javascript benchmark 07:16:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7882.797332127058, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3575.427931530954, 3580.6419358064195, 3601.477785721072, 3619.511365965595, 3627.691646210072, 6143.235544005193, 6199.442050215474, 6238.313785483599, 6240.531960102993, 6298.905516417258, 6222.284437289713, 6232.719527621257, 6265.404786545282, 6290.905636415458, 6333.936660633392, 5463.945360546383, 5522.420145884695, 5546.278983732109, 5583.162525621169, 5634.633748806335, 5470.890582188354, 5558.305211848519, 5612.803551875685, 5618.91571626426, 5646.491815736583, 5403.891922161535, 5433.8369848904595, 5576.470235327637, 5594.720263986785, 5639.746211420496, 4575.862724118282, 5459.617826752129, 5462.344518657746, 5553.389127196006, 5572.60991730579, 5469.507744302992, 5473.28847249859, 5476.644018138808, 5491.533219676332, 5525.944740552583, 6032.095185722133, 6343.397377249154, 6343.636118234602, 6344.6827658616885, 6352.968235158841, 6559.278479367265, 6657.367550082734, 6717.966410167966, 6803.081583986148, 6809.931900680979, 6937.826554336182, 6951.7566885159285, 6964.059851919977, 6969.860602787916, 6974.895376569356, 6339.397757213057, 6346.397092276226, 6418.871622567569, 6421.518386121013, 6427.228732552124, 6810.727570897108, 6918.8962165567555, 6954.7218111276, 6996.19543752475, 7036.437085033185, 6513.837154071186, 6531.575447595891, 6609.20689517261, 6711.161104861892, 6743.898841517381, 6822.829429264209, 6830.8633827324165, 6859.451243900476, 6889.448844092461, 6921.273266307066, 6792.626405547742, 6810.659467026629, 6815.727370905108, 6825.9317406826285, 6839.350261725128, 6521.250056243498, 6558.967205164039, 6664.067030615718, 6776.3833371544615, 6818.727250910008, 5442.2108794225405, 5454.509094181542, 5501.532369748536, 5515.834524964257, 5525.696086715269, 4105.281575724236, 4857.101436234308, 4866.537678920497, 4880.487548807324, 4891.095147397743, 6395.072714456471, 6436.8390790230615, 6437.967810160919, 6467.602030619224, 6514.218293804774, 6686.030525573862, 6799.252082270947, 6887.483438742114, 6902.965485172643, 6948.513604047769, 4943.382077240345, 5811.79658711943, 6161.106639537332, 6466.191726034246, 6483.643399613066, 5385.6230063895155, 6059.182010428536, 6077.36187700294, 6131.509479241739, 6163.137160797492, 6912.239653638197, 7044.8591028178125, 7093.042439270633, 7114.288571142844, 7226.458015648953, 6918.481113916376, 6936.930630693831, 6942.271061538466, 6961.89557156633, 6967.686454109476, 7040.225575186623, 7160.248173941661, 7196.136463624399, 7206.783796486114, 7224.927750722425, 5926.822195334147, 6228.968855155877, 6456.838579035561, 6796.456283497209, 6825.931740682729, 6768.898466523105, 6837.076994605664, 6921.342472465108, 6933.791986240421, 6956.130483689539, 6386.0, 6577.440917522064, 6663.267040625624, 6665.333466653296, 6671.833204169935, 5368.731563421891, 6498.220213574401, 6518.934810652023, 6525.347465253437, 6585.1439312889015, 5594.216809646734, 6543.574667646588, 6565.441937435371, 6570.868582628416, 6586.868262634816, 5565.693886836101, 6696.933030669631, 6702.798916032527, 6704.6982885769285, 6705.2959439258175, 6212.968935155295, 6287.0, 6407.711652975534, 6515.12045873801, 6553.082568440517], "value": 6187.805290836849, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9452047271221, 790.2887401338795, 814.5804910471109, 1269.4985480735104, 1279.2132838304433, 34831.129221769435, 36873.07817304569, 38587.61412385875, 39122.0, 39351.60648393515, 38614.8069259654, 38836.80581597088, 38857.0, 38967.22065558687, 38983.0, 8007.879881801763, 8155.266026057654, 8513.702020429286, 8735.868961965576, 8747.95626021869, 8702.782430439227, 8747.431416957877, 8815.118488151198, 8830.11698830115, 8838.0, 8738.257248133916, 8745.300375969908, 8794.560271986407, 8841.867371989392, 8865.290776737878, 8794.912050879473, 8808.867866982, 8819.162179592993, 8836.337274704423, 8848.823023539557, 8683.13168683133, 8733.694320698809, 8741.431806932529, 8747.343949203836, 8751.212390884852, 31455.37089258202, 38137.42793858094, 38396.80801596002, 38397.424038639445, 38484.61515384867, 3483.756137070406, 3488.4069708149677, 3523.964760352415, 3525.347810655037, 3529.0824385659657, 30269.394612107855, 30391.696083039107, 30540.862139650235, 30609.38781224363, 30654.386912261853, 3103.3948380065895, 3109.300407408338, 3113.315070684446, 3138.137012321607, 3145.213696575856, 208208.0, 278071.0, 332046.0, 333667.0, 340405.29797351104, 52113.7394313026, 52398.0, 52445.0, 52652.736736316074, 52916.0, 54680.72659636677, 55155.44844551583, 55391.44608553863, 55603.88792224133, 55641.44358556443, 13867.514636987657, 13975.02174847751, 14003.579892603238, 14011.71976560463, 14026.0, 11106.44467776608, 11151.442427878574, 11208.66374008781, 11271.774564508827, 11274.210805243718, 12629.93685031569, 14206.147631142165, 14241.572752817225, 14278.0, 14339.784903226251, 5823.30120385548, 6229.408206220402, 6233.875322493615, 6248.812535623939, 6251.749930002749, 845.966161353539, 906.2704522859029, 946.1153821177221, 986.1469828598355, 1005.6178652112151, 21129.577408451743, 22216.777832221793, 24177.75822241755, 24252.87873560621, 24301.906414211404, 1049.1239814754765, 1055.461714525582, 1060.3584831177027, 1088.7332603512032, 1088.8693356797235, 12077.335746534025, 15851.365945362288, 16104.75842862358, 16206.432774852823, 16286.592835179215, 449158.0, 450193.0, 452377.0, 454251.0, 455599.0, 58223.41776582265, 58519.41480585225, 58541.70729146327, 58623.0, 58668.41331586715, 1398.9860101399058, 1471.6615178509003, 1471.7939488471836, 1473.8452462491284, 1492.8656420922168, 23953.880230599432, 28078.455684937526, 29753.85123074371, 29768.350933875878, 29923.401531969674, 31984.84007579947, 37556.87329380123, 37590.248195036496, 37845.62154378531, 37914.8104259477, 389498.0, 393853.0, 394082.0, 395516.0, 395659.0, 32248.516272256406, 35175.42719446456, 35635.643643563235, 35667.82166089153, 35745.82127089348, 43633.0, 43862.78068609637, 44098.11803763843, 44354.11291774211, 44426.0, 28641.713582863904, 29077.41845163127, 30310.84844575763, 31204.063878083693, 31246.68753312529, 28846.855765721037, 30251.546226806175, 30722.539161913035, 30959.380812384075, 31063.689363106983, 36225.45661815022, 36917.0, 36928.81535592305, 37035.0, 37053.81473092617, 29408.0, 30504.08487745371, 30984.535231971087, 31351.05946821599, 31545.053648390585, 19774.0, 24422.63366049475, 24502.387440314134, 24565.89453474562, 24600.43078361854], "value": 18173.673430978397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.8897892058603, 422.5812028197692, 426.8143357639427, 442.7520588470457, 447.60834270013737, 20236.59526809463, 21893.890530547345, 22650.88674556629, 22819.42951426213, 22831.543369132607, 21973.90130493473, 22663.206787762432, 23149.537009259806, 23397.94709238084, 24049.398765030885, 5935.703214839263, 6068.362821903703, 6253.030780229072, 6255.968720156393, 6257.687115644222, 6095.939040609582, 6176.258848938133, 6240.906386404207, 6247.687615619224, 6290.842728931791, 5503.257060296869, 5967.910481342783, 6160.691965401735, 6214.223222097238, 6227.003679411295, 6225.564210505244, 6264.467520260783, 6271.0, 6284.937150628503, 6303.873922521547, 5491.28613280271, 5517.310336207974, 5520.144377621435, 5575.1915972184215, 5584.944150558483, 25393.984240630536, 25584.592847393385, 27422.314442138908, 28118.859405703046, 28328.71671283302, 1804.0168108380965, 2029.0869108901054, 2038.2865996901114, 2208.3374987503844, 2214.368904862107, 17404.912975435043, 17649.911750441293, 18464.076796160272, 18577.814221857745, 18659.0, 2067.400453868376, 2070.2133189388087, 2078.5842831433774, 2130.5099827039867, 2135.0392323454507, 123728.0, 142958.0, 156985.8602827937, 163769.3623063778, 166845.0, 12313.815292770616, 12857.721281073267, 12933.54732584355, 12966.935165324114, 12982.35088245584, 16337.509874703777, 16610.169491525616, 16659.083750393846, 16690.916545417436, 16718.331266749436, 8666.956665216634, 8851.69019084342, 8867.556622168866, 8955.0, 8996.460212387277, 8295.917040829514, 8296.585170741439, 8302.8339433211, 8438.789030274293, 8475.0, 7992.080910695228, 8085.312748416332, 8128.431009829374, 8153.225443582969, 8157.306628936488, 2212.402651284144, 2216.5456081503253, 2220.7446143693683, 2222.377734234417, 2391.0674836813655, 909.4316052467208, 929.4051806843626, 939.3659279986118, 941.9387739796891, 976.6142373762466, 20510.589788204154, 20941.267055653283, 20976.580468390548, 20993.37019889406, 21151.576968460544, 945.4658118163353, 978.2076518020426, 986.5363279258737, 988.9901100988898, 992.7959928957703, 10520.473976301155, 10753.408562529135, 10882.29265097766, 10903.509342079467, 10906.836397453886, 713541.0, 721480.0, 721578.0, 727135.0, 732969.0, 156899.21550392176, 157072.0, 164216.0, 164320.0, 167189.0, 1117.6200091968608, 1152.4065106470175, 1169.9473523691454, 1174.671092094215, 1176.517627772609, 14625.513662677584, 17641.735373969143, 17797.822021779615, 18110.0, 18247.361342352953, 45182.0, 52739.73630131825, 61899.83350582708, 65410.672946634964, 65934.35164120936, 74424.13939651551, 84923.5753821227, 85952.71070933816, 86031.13968860482, 86289.13710862811, 7897.802554936173, 8706.651733930825, 8843.91156088431, 8905.421147625384, 8918.643254269757, 13539.458421663023, 13849.653758656113, 13853.792193117313, 13880.652983675489, 14044.227567483886, 11507.884921150682, 11524.711882203012, 11891.702707432383, 11928.940355298168, 11983.161178717406, 10814.405207713651, 10859.619913302997, 10886.891131088587, 11085.722856928642, 11209.383483908463, 11080.61217857371, 11572.826407604061, 11718.765624687288, 11894.048476122063, 11907.285562866256, 7626.618669066635, 8331.250187483156, 8594.699185528476, 8611.870821937551, 8614.61234244448, 9700.126988571063, 11438.0, 11456.484458199568, 11489.82765258505, 11793.351365674971], "value": 10530.217653635596, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1180.3390101543137, 1415.81594392729, 1422.054333867978, 1426.7360538300416, 1462.5758530026294, 11403.885961140386, 11795.764084718301, 11811.940940295297, 11832.171747977634, 12143.57497487588, 11680.941595292012, 11938.462769175387, 11962.282263064222, 11973.700657483545, 11997.100217483701, 2502.56205164096, 2561.1164148368784, 2562.988488525984, 2564.217913536371, 2565.525377805112, 2081.895905204741, 2479.8884050217694, 2518.6725725655638, 2526.7978561715017, 2530.127106148376, 2495.0643508684243, 2504.111040580595, 2522.2811498722867, 2537.784288335494, 2545.1346542175656, 2000.7895223389858, 2136.540643761591, 2461.2862269941697, 2504.5241404133158, 2515.2454263720992, 2402.5675378431874, 2406.38637147528, 2410.758924107593, 2412.2039726890084, 2498.675172227617, 11449.141314401453, 11510.827337589943, 11565.13261505382, 11593.594224202112, 11614.012808911253, 6615.735370585219, 6867.862642747167, 6868.553544019623, 6872.896906546406, 6875.5530890491955, 4145.937810932838, 4336.262835318003, 4412.84555040572, 4436.977815110936, 4506.188886000518, 957.1959553974694, 1082.7942690888785, 1212.4483360071147, 1269.1686945051006, 1277.2783377391745, 15418.306176222097, 15632.687346253011, 15705.0, 16432.671346573123, 16524.925879817773, 4671.5328467153695, 4729.36153619257, 5845.532357411397, 5879.52963762898, 5885.852853678693, 10258.846117308247, 11062.336259824437, 12197.32914689683, 12426.937865310616, 12457.875421245853, 6644.900326495106, 6646.86706265872, 6651.0, 6659.567128136656, 6665.500087493458, 5874.324452687995, 6064.0297552392285, 6218.31598524162, 6221.4089661482085, 6282.905756413657, 4070.063885306396, 4366.126774645084, 4461.732296062247, 4466.9106617867465, 4474.977625111854, 1217.397388292783, 1222.3582619124852, 1256.1772039314264, 1313.5271302331153, 1337.1575907178415, 748.3227678950558, 755.0863455219246, 776.6660336055551, 780.3990926986189, 805.7864665863551, 6854.314568543105, 7221.097362829646, 7250.238724933912, 7359.816004599821, 7425.62871856405, 894.3828758156851, 899.2266650680409, 922.3497434308796, 926.5645146781002, 946.1012038563255, 3629.237860049366, 4307.483102027777, 4323.935140972888, 4357.213542447581, 4453.75504347264, 14897.627559310888, 15324.923375383052, 15483.148426836633, 15511.844881551266, 15533.844661553467, 14815.777763333559, 15066.698666026618, 15407.46073887431, 15418.152001640017, 15426.305816238297, 10646.307989980782, 10697.732556686145, 10734.087602553871, 10850.80641129475, 10851.67444976652, 6979.232284448605, 7006.248437890527, 7168.2831716827895, 7207.5675459472595, 7309.634518274172, 13287.13633613812, 13828.723425531232, 13998.370073346927, 14083.225422601856, 14203.289835507976, 13867.930660346634, 13971.231582263074, 14004.229767362485, 14163.716725665636, 14214.857851421768, 10699.679009629723, 10732.73168170802, 10775.245732798629, 10828.729281767704, 10912.181586380895, 10405.635802746867, 10612.310199836986, 10667.093297069836, 10722.410267435365, 10853.620123295646, 7579.393648508217, 8776.824463510566, 8780.473171609723, 9156.359054866096, 9241.537923103953, 7613.961930190314, 8870.068642792414, 9010.013337845608, 9089.727308180765, 9259.398139120936, 8113.716019939274, 8232.053313868983, 8344.499330040217, 8364.6235919385, 8458.703945361884, 6087.421694938974, 6108.75564977396, 6246.906296405648, 6291.433770960635, 6344.30212676596, 6044.697765111815, 6116.755329786759, 6172.938270617236, 6275.090111933835, 6291.307956124731], "value": 5452.393067146256, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.3154322220005, 384.15102623202705, 395.2293028594241, 403.75844278842567, 407.1226506877676, 5056.393232812063, 5319.547838433728, 5963.55273354498, 6329.145565348676, 6339.034899181257, 4913.533214344631, 5642.520385767215, 5835.153902684108, 6115.633062016271, 6123.846903827406, 4002.359622460407, 4624.653151013687, 4649.349870573775, 4661.9067618647605, 4705.176594096037, 4682.484926658065, 4691.997121842024, 4699.624030077603, 4702.224133018048, 4708.623310135181, 3828.693704503647, 4245.893852653678, 4427.71219870709, 4478.0, 4667.416572928384, 4025.3156963316305, 4065.7763822989723, 4448.466184057917, 4460.843870464518, 4475.753833539154, 3209.9679003209903, 3797.240551889633, 3847.153626202231, 3849.30712471755, 3867.3425517662067, 4812.879678008043, 5183.637145399824, 5751.913721294184, 5912.763489460416, 5987.491063259628, 4608.700434471749, 4658.836940707059, 5352.866178345534, 5394.595405344576, 5432.239486471897, 6497.902531461985, 6531.967340163316, 6543.93456065438, 6579.111819904348, 6585.835354116138, 3452.8273586320583, 4256.87229383119, 4327.5239723630375, 4390.9022744313925, 4418.9337159942625, 6624.503162262801, 6779.0, 6811.092893989691, 6904.447644188504, 6993.335633114897, 4269.807858646368, 4441.289393696993, 4455.420795296591, 4486.887827804331, 4490.640748740093, 4170.395292682544, 4434.490033646172, 4555.453345598549, 4556.476005259371, 4565.155446242456, 4524.819007239739, 5240.633155679142, 5338.932213557304, 5396.163594642837, 5400.703831080591, 5368.785248590091, 5726.713664316768, 6512.479001679854, 6536.607803531803, 6554.934450655433, 1397.8956624266716, 1464.648484363745, 1503.3911265937313, 1524.7103050420385, 1531.7242896278776, 983.8720966274482, 1008.324422636835, 1012.4988130875116, 1014.8224060789332, 1027.3784360461814, 5670.971645141748, 6175.62946223228, 6182.814515564541, 6203.565750397519, 6227.377262273827, 6385.0, 6508.9023664645065, 6730.764423245163, 6757.662116894136, 6814.863702725917, 5905.852353691193, 6163.630182189083, 6220.03589443637, 6251.718672659741, 6281.497480201573, 3206.551082848403, 3523.224890524081, 3536.504889315498, 3556.7332450066347, 3568.3933731265747, 6361.268454127742, 6770.187577490733, 6869.931300687029, 7112.822179445452, 7133.53762478701, 6350.904736428957, 6383.138276332728, 7109.146902371645, 7123.857522849514, 7136.607486588287, 6916.308369163144, 7086.255943126001, 7117.861142217221, 7153.964230178815, 7203.279672032964, 5497.92790405867, 5587.552995760248, 6733.69698363565, 6938.548994315353, 6942.166939967236, 5589.133684278943, 6409.71156297977, 6570.605763654196, 6719.428848547928, 6756.256811750605, 6339.429451349401, 7173.390261827594, 7189.209186989531, 7203.883398073307, 7204.53170543913, 4423.535528769433, 4479.440069991251, 4483.237849565647, 4506.211413002777, 4515.074409745928, 6666.633335166613, 6808.0, 6864.725410983505, 6905.654717264217, 6937.479689023445, 5349.57203423733, 6619.966900165468, 6625.768098116543, 6672.9666351669875, 6699.39705426514, 5148.3564554430695, 5909.852253693692, 6110.816675499742, 6135.907961380493, 6612.173478315211, 6483.578567393104, 6544.509161812788, 6554.344565543408, 6563.803085907431, 6569.751747168023, 5306.681599104066, 5871.7651293949475, 6449.7420103195345, 6638.601683898982, 6656.700448479927, 5596.552275817843, 6389.648569328731, 6400.551961362846, 6415.294317624965, 6447.677616119269], "value": 4750.9481725102105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.4343327354575, 784.917583653716, 831.9642045653159, 837.2757564706528, 843.2031730015138, 12764.936175319122, 15419.306131224093, 15952.521424357274, 16493.17534123295, 16547.66904661906, 14894.180820054893, 14964.578365055302, 14999.550013499613, 15074.924625376858, 15251.847481525181, 938.8686632607709, 966.9274804389664, 969.1955676788284, 971.2327261463436, 971.9854202186973, 957.6169532187112, 979.9608015679364, 983.4787562591838, 996.392200757541, 997.5311603546357, 1045.9581616735322, 1048.7849990751915, 1054.4200689620716, 1061.9522121504513, 1064.5050051725946, 1044.185535282477, 1050.9894901051007, 1057.7091299892513, 1059.4861492176287, 1061.1881910338598, 767.6507189228944, 771.4831063187678, 781.3788038509399, 782.6634547144726, 783.115079959642, 16429.0, 16575.585610359718, 16711.331546738114, 17046.659066818716, 17193.7420938686, 14825.55523334291, 14841.699536571849, 14847.331870065873, 14906.850931490655, 14989.550313490503, 12249.387530623522, 12507.312097834616, 13509.256990865499, 13546.119502232323, 13596.320183990762, 3203.951940720891, 3361.5629968104236, 3372.460406334975, 3374.898753037413, 3383.9661603383897, 97490.0, 99496.0, 112769.87230127757, 114909.46756169977, 119479.80520194773, 10952.561897524169, 11350.035247003932, 11525.0, 11554.711132221762, 11885.702857428634, 20806.79193208079, 25105.24684259475, 25497.490050198892, 25547.0, 25757.484850303263, 7666.0, 7734.303912647776, 7859.960700196462, 7892.960535197287, 8009.839803203903, 3981.3828856526707, 4109.219248342805, 4113.197926404382, 4156.9792151039055, 4174.91650167001, 4259.2759230930815, 4291.592298731678, 4346.891327716832, 4367.497737760134, 4372.234858899744, 933.3000249812641, 939.3049143633798, 954.7994921066515, 955.3885513271512, 957.9233661307079, 610.6366711806468, 613.4938675592654, 624.9031400132986, 636.4367534731704, 655.9635775474834, 8645.610947507377, 9531.714048578553, 10159.516033623178, 10275.588976441008, 10318.845217321747, 581.8225441240462, 605.5155875299743, 649.4804156674642, 650.4536189600758, 659.3406593406594, 4178.435911152016, 4524.660650451164, 4862.8784280392565, 5172.741362931838, 5256.421793602701, 97373.53939690911, 105184.0, 105637.47181264198, 106330.0, 106468.0, 95227.57158642626, 95503.52248238854, 95953.5202323998, 97271.0, 97849.51075244579, 59076.0, 70281.64859175672, 73519.0, 74608.0, 75659.24340756632, 10794.19043571751, 10822.51298691545, 11019.944900275448, 11035.39305338182, 11064.612738554433, 37390.25219495649, 38151.046223843514, 38953.0, 39050.21899561936, 40094.99762505961, 68508.0, 68628.6568567154, 69793.0, 70015.0, 71666.64166679133, 13473.0, 14060.648483787987, 14103.506377276746, 14152.716945661236, 14533.857850512553, 12719.745605088032, 14587.635309117357, 14746.686362184846, 14884.925575372054, 15097.698046039237, 12067.517299307929, 13595.728085438433, 13965.58103256904, 14169.362378692776, 14558.908081894113, 13768.380422880795, 13879.930600347338, 13880.958928080232, 13940.58178254654, 13968.37142328618, 13200.471981120647, 13334.866651333363, 13366.064375493623, 13650.726985460036, 14141.717165656424, 9159.0, 9332.440053596805, 9411.717648470556, 9446.0, 9676.661316853877, 10671.57313707474, 10933.83599246028, 11021.560040272967, 11263.605773797877, 11324.263922844988], "value": 7821.078810254197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1715.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 123.0, 172.0, 124.0, 186.0, 188.0, 153.0, 121.0, 122.0, 123.0], "value": 142.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 145.0, 150.0, 153.0, 118.0, 118.0, 116.0, 130.0, 137.0, 116.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 246.0, 241.0, 226.0, 214.0, 291.0, 215.0, 284.0, 281.0, 214.0], "value": 243.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 64.0, 60.0, 88.0, 60.0, 61.0, 55.0, 77.0, 104.0, 88.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 72.0, 88.0, 74.0, 73.0, 73.0, 88.0, 72.0, 74.0, 90.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 92.0, 88.0, 110.0, 93.0, 95.0, 108.0, 88.0, 82.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 114.0, 117.0, 162.0, 163.0, 101.0, 144.0, 158.0, 129.0, 103.0], "value": 132.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 99.0, 89.0, 166.0, 110.0, 168.0, 166.0, 103.0, 169.0, 166.0], "value": 134.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 52.0, 60.0, 68.0, 81.0, 80.0, 79.0, 52.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 68.0, 75.0, 66.0, 61.0, 60.0, 61.0, 61.0, 69.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 90.0, 86.0, 88.0, 92.0, 88.0, 87.0, 86.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 150.0, 140.0, 148.0, 136.0, 164.0, 138.0, 178.0, 223.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [253.0, 192.0, 228.0, 202.0, 254.0, 237.0, 193.0, 247.0, 199.0, 237.0], "value": 224.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 78.0, 104.0, 111.0, 101.0, 65.0, 78.0, 78.0, 62.0], "value": 81.6, "unit": "score"}]}]} 07:16:54 INFO - Return code: 0 07:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:16:54 ERROR - # TBPL SUCCESS # 07:16:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:16:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:16:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:16:54 INFO - 2017-04-05 07:16:54.120 screenresolution[1657:10682] starting screenresolution argv=screenresolution get 07:16:54 INFO - 2017-04-05 07:16:54.123 screenresolution[1657:10682] Display 0: 1600x1200x32@60 07:16:54 INFO - 2017-04-05 07:16:54.129 screenresolution[1658:10685] starting screenresolution argv=screenresolution list 07:16:54 INFO - Available Modes on Display 0 07:16:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:16:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:16:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:16:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:16:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:16:54 INFO - Intel Iris: 07:16:54 INFO - Chipset Model: Intel Iris 07:16:54 INFO - Type: GPU 07:16:54 INFO - Bus: Built-In 07:16:54 INFO - VRAM (Dynamic, Max): 1536 MB 07:16:54 INFO - Vendor: Intel (0x8086) 07:16:54 INFO - Device ID: 0x0a2e 07:16:54 INFO - Revision ID: 0x0009 07:16:54 INFO - Displays: 07:16:54 INFO - Display: 07:16:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:16:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:16:54 INFO - Display Serial Number: 1600x1200 60 07:16:54 INFO - Main Display: Yes 07:16:54 INFO - Mirror: Off 07:16:54 INFO - Online: Yes 07:16:54 INFO - Rotation: Supported 07:16:54 INFO - Return code: 0 07:16:54 INFO - Running post-action listener: _resource_record_post_action 07:16:54 INFO - [mozharness: 2017-04-05 14:16:54.369903Z] Finished run-tests step (success) 07:16:54 INFO - Running post-run listener: _resource_record_post_run 07:16:54 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 40495616; Write bytes: 520321024; Read time: 391; Write time: 2004 07:16:54 INFO - TinderboxPrint: CPU usage
54.2% 07:16:54 INFO - TinderboxPrint: I/O read bytes / time
40,495,616 / 391 07:16:54 INFO - TinderboxPrint: I/O write bytes / time
520,321,024 / 2,004 07:16:54 INFO - TinderboxPrint: CPU idle
2,208.1 (45.8%) 07:16:54 INFO - TinderboxPrint: CPU system
968.8 (20.1%) 07:16:54 INFO - TinderboxPrint: CPU user
1,640.7 (34.1%) 07:16:54 INFO - TinderboxPrint: Swap in / out
247,095,296 / 0 07:16:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204511744; Write bytes: 203367936; Read time: 15977; Write time: 397 07:16:54 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 38365696; Write bytes: 309879296; Read time: 368; Write time: 1578 07:16:54 INFO - Running post-run listener: _upload_blobber_files 07:16:54 INFO - Blob upload gear active. 07:16:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:16:54 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 07:16:54 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'] 07:16:54 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 07:16:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:56 INFO - (blobuploader) - INFO - Done attempting. 07:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:57 INFO - (blobuploader) - INFO - Done attempting. 07:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:58 INFO - (blobuploader) - INFO - Done attempting. 07:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:17:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:17:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:17:00 INFO - (blobuploader) - INFO - Done attempting. 07:17:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:17:00 INFO - Return code: 0 07:17:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:17:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:17:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e1987d64ad2a033d25626e7f600ed7a350cdb1c843ee03c7dd415edaa5bf7c64a9cabc469f10c6ed8b62a3ce168b85d6a44d445e4f4970087787570bd1e5d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8488b43c688e6a1857c8af37255670bce801c6a4cf5d41fda8c85cd8c1603988282df3e9dd0b113ec522ebf14e7d3955b8a3e7d86d0b3200e41451a811d4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf38eb6c46a8f4168652e9d909c0d3c1a8b291bdb918d1d3ee9945a36da6f5a940ef480a290ced01e1ba0f9e47512a59ac98e1a327238a574b97a9b03d325b58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c8a11c7c52ff151d161231cd223400751c53f4066d197cf531c04ce98b22e54b5dd88e2e7dcdd4896543dbf4ec541454d3a014659734cc6a7820daae406aec"} 07:17:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:17:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:17:00 INFO - Contents: 07:17:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e1987d64ad2a033d25626e7f600ed7a350cdb1c843ee03c7dd415edaa5bf7c64a9cabc469f10c6ed8b62a3ce168b85d6a44d445e4f4970087787570bd1e5d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8488b43c688e6a1857c8af37255670bce801c6a4cf5d41fda8c85cd8c1603988282df3e9dd0b113ec522ebf14e7d3955b8a3e7d86d0b3200e41451a811d4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf38eb6c46a8f4168652e9d909c0d3c1a8b291bdb918d1d3ee9945a36da6f5a940ef480a290ced01e1ba0f9e47512a59ac98e1a327238a574b97a9b03d325b58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c8a11c7c52ff151d161231cd223400751c53f4066d197cf531c04ce98b22e54b5dd88e2e7dcdd4896543dbf4ec541454d3a014659734cc6a7820daae406aec"} 07:17:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:17:00 INFO - Copying logs to upload dir... 07:17:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:17:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.205815 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-05 07:17:00.444246) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 07:17:00.448239) ========= 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.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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/f0e1987d64ad2a033d25626e7f600ed7a350cdb1c843ee03c7dd415edaa5bf7c64a9cabc469f10c6ed8b62a3ce168b85d6a44d445e4f4970087787570bd1e5d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8488b43c688e6a1857c8af37255670bce801c6a4cf5d41fda8c85cd8c1603988282df3e9dd0b113ec522ebf14e7d3955b8a3e7d86d0b3200e41451a811d4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf38eb6c46a8f4168652e9d909c0d3c1a8b291bdb918d1d3ee9945a36da6f5a940ef480a290ced01e1ba0f9e47512a59ac98e1a327238a574b97a9b03d325b58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c8a11c7c52ff151d161231cd223400751c53f4066d197cf531c04ce98b22e54b5dd88e2e7dcdd4896543dbf4ec541454d3a014659734cc6a7820daae406aec"} build_url:https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/KKKOrFGxTWGJwZfu7oq08w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e1987d64ad2a033d25626e7f600ed7a350cdb1c843ee03c7dd415edaa5bf7c64a9cabc469f10c6ed8b62a3ce168b85d6a44d445e4f4970087787570bd1e5d4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8488b43c688e6a1857c8af37255670bce801c6a4cf5d41fda8c85cd8c1603988282df3e9dd0b113ec522ebf14e7d3955b8a3e7d86d0b3200e41451a811d4cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf38eb6c46a8f4168652e9d909c0d3c1a8b291bdb918d1d3ee9945a36da6f5a940ef480a290ced01e1ba0f9e47512a59ac98e1a327238a574b97a9b03d325b58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56c8a11c7c52ff151d161231cd223400751c53f4066d197cf531c04ce98b22e54b5dd88e2e7dcdd4896543dbf4ec541454d3a014659734cc6a7820daae406aec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 07:17:00.483071) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 07:17:00.483374) ========= 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.ZOXnval7hh/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.GDDzsOqTZW/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005110 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 07:17:00.531564) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 07:17:00.531909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 07:17:00.532218) ========= ========= Total master_lag: 0.45 =========