Back to build
Raw log | Switch to full mode | Login

python -u /b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/swarming/w/ir/tmp/t/tmp61alHm.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpE5BTY_ --merge-script /b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --merge-script-stdout-file /b/swarming/w/ir/tmp/t/tmpIVKr0Tmerge_script_log --merge-additional-args '[]' --build-properties '{"bot_id": "swarm1860-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1552895072084564, "id": "8918665212852496864", "project": "chromium", "tags": ["build_address:luci.chromium.ci/fuchsia-fyi-x64-dbg/5877", "builder:fuchsia-fyi-x64-dbg", "buildset:commit/git/f7b6b9f521aae8817a449b28b59e3f14649291c0", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7b6b9f521aae8817a449b28b59e3f14649291c0", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9084095275400233088", "scheduler_job_id:chromium/fuchsia-fyi-x64-dbg", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "fuchsia-fyi-x64-dbg", "buildnumber": 5877, "got_angle_revision": "38e282570676f3e434482f8a02ea539b286fd1fa", "got_dawn_revision": "991ab98f113f5f51ec87d767b45523b19cd15b9e", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0", "got_revision_cp": "refs/heads/master@{#641529}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "f413181b62ee4ad78b9ef3d58c4f395794e16bf1", "got_v8_revision_cp": "refs/heads/7.5.59@{#1}", "got_webrtc_revision": "69008a87185992aa348ece3f893f6a84f8786ae8", "got_webrtc_revision_cp": "refs/heads/master@{#27145}", "mastername": "chromium.fyi", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0"}' --summary-json-file /b/swarming/w/ir/tmp/t/tmp5X9XkY.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpL4h6kC.json in dir /b/swarming/w/ir/k: allow_subannotations: True cmd: ['python', '-u', '/b/swarming/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/swarming/w/ir/tmp/t/tmp61alHm.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpE5BTY_', '--merge-script', '/b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--merge-script-stdout-file', '/b/swarming/w/ir/tmp/t/tmpIVKr0Tmerge_script_log', '--merge-additional-args', '[]', '--build-properties', '{"bot_id": "swarm1860-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1552895072084564, "id": "8918665212852496864", "project": "chromium", "tags": ["build_address:luci.chromium.ci/fuchsia-fyi-x64-dbg/5877", "builder:fuchsia-fyi-x64-dbg", "buildset:commit/git/f7b6b9f521aae8817a449b28b59e3f14649291c0", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7b6b9f521aae8817a449b28b59e3f14649291c0", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9084095275400233088", "scheduler_job_id:chromium/fuchsia-fyi-x64-dbg", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "fuchsia-fyi-x64-dbg", "buildnumber": 5877, "got_angle_revision": "38e282570676f3e434482f8a02ea539b286fd1fa", "got_dawn_revision": "991ab98f113f5f51ec87d767b45523b19cd15b9e", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0", "got_revision_cp": "refs/heads/master@{#641529}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "f413181b62ee4ad78b9ef3d58c4f395794e16bf1", "got_v8_revision_cp": "refs/heads/7.5.59@{#1}", "got_webrtc_revision": "69008a87185992aa348ece3f893f6a84f8786ae8", "got_webrtc_revision_cp": "refs/heads/master@{#27145}", "mastername": "chromium.fyi", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0"}', '--summary-json-file', '/b/swarming/w/ir/tmp/t/tmp5X9XkY.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/swarming/w/ir/tmp/t/tmpL4h6kC.json'] env: {'CHROME_HEADLESS': '1'} env_prefixes: {'PATH': '/b/swarming/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('blink_heap_unittests',) ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: ADDRFAM: inet BOTO_CONFIG: /b/swarming/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CHROME_HEADLESS: 1 CIPD_CACHE_DIR: /b/swarming/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 42653 DOCKER_CONFIG: /b/swarming/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/swarming/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot IFACE: eth0 INFRA_GIT_WRAPPER_HOME: /b/swarming/w/ir/tmp/git_home_task LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918665212852496864 LOGDOG_STREAM_PROJECT: chromium LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGICAL: eth0 LUCI_CONTEXT: /b/swarming/w/itN_IuDI/luci_context.603119684 MAC_CHROMIUM_TMPDIR: /b/swarming/w/ir/tmp/t METHOD: dhcp NO_GCE_CHECK: False PATH: /b/swarming/w/ir/cache/swarming_client:/b/swarming/w/ir/cipd_bin_packages:/b/swarming/w/ir/cipd_bin_packages/bin:/b/swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/swarming/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 ROOT_SETUP_LOG: /var/log/messages/chromebuild/root-setup.log SHLVL: 1 STARTUP_LOG: /var/log/messages/chromebuild/startup.log SWARMING_BOT_ID: swarm1860-c4 SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43a893e23993e611 TEMP: /b/swarming/w/ir/tmp/t TEMPDIR: /b/swarming/w/ir/tmp/t TERM: linux TMP: /b/swarming/w/ir/tmp/t TMPDIR: /b/swarming/w/ir/tmp/t UPSTART_EVENTS: net-device-up UPSTART_INSTANCE: UPSTART_JOB: chromebuild-startup USER: chrome-bot USERNAME: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/swarming/w/ir/cache/vpython _: /b/swarming/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/swarming/w/ir/kitchen-checkout/build/scripts:/b/swarming/w/ir/kitchen-checkout/build/site_config:/b/swarming/w/ir/kitchen-checkout/build/third_party:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/swarming/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/swarming/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/swarming/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/swarming/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/swarming/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/swarming/w/ir/kitchen-checkout/build/third_party/jinja2:/b/swarming/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/swarming/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/swarming/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/swarming/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/swarming/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/swarming/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/swarming/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/swarming/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/swarming/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/swarming/w/ir/kitchen-checkout/build/third_party/site-packages 2019-03-18 01:08:14,749 - root: [DEBUG] Using task_output_dir: '/b/swarming/w/ir/tmp/t/tmpE5BTY_' 2019-03-18 01:08:14,749 - root: [WARNING] task_output_dir '/b/swarming/w/ir/tmp/t/tmpE5BTY_' already exists! 2019-03-18 01:08:14,749 - root: [WARNING] task_output_dir existing content: [] 2019-03-18 01:08:14,749 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/swarming/w/ir/tmp/t/tmpL4h6kC.json -output-dir /b/swarming/w/ir/tmp/t/tmpE5BTY_ -task-summary-json /b/swarming/w/ir/tmp/t/tmp5X9XkY.json [D2019-03-18T01:08:14.757555-07:00 21111 0 auth.go:1265] Minting a new token {"key":"luci_ctx/ebec93f28e00fb4638f8a323b68dcc8f5a6b27659c9f629eaa53464b426c33e0", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T01:08:14.757633-07:00 21111 0 luci_ctx.go:138] POST http://127.0.0.1:45881/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/ebec93f28e00fb4638f8a323b68dcc8f5a6b27659c9f629eaa53464b426c33e0", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T01:08:14.760087-07:00 21111 0 auth.go:1222] Token expires in 40m39.240000861s {"key":"luci_ctx/ebec93f28e00fb4638f8a323b68dcc8f5a6b27659c9f629eaa53464b426c33e0", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-18T01:08:16.044381-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:17.191927-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:18.383284-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:19.609968-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:20.921760-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:22.302379-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:23.647505-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:25.521418-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:26.988865-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:28.489508-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:30.051340-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:31.665921-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:33.307435-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:35.113464-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:36.922461-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:38.891347-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:40.780221-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:42.848203-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:44.878548-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:46.971072-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:49.279978-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:51.637026-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:53.946918-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:56.344789-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:08:58.885967-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:01.662757-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:04.323278-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:07.152839-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:10.025449-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:13.225174-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:16.399537-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:19.554003-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:22.805337-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:26.365949-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:29.898478-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:33.571423-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:37.344507-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:41.212928-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:45.242590-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:49.439922-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:53.719806-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:09:58.126795-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:02.683431-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:07.462201-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:12.389967-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:17.511715-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:22.788444-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:28.238671-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:33.817314-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:39.641096-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:45.574056-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:51.747713-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:10:58.243985-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:04.957125-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:11.764417-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:18.866674-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:26.231567-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:33.752809-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:41.538604-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:49.650562-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:11:57.989811-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:06.572519-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:15.408022-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:24.581028-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:34.082100-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:43.897369-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 [D2019-03-18T01:12:53.983033-07:00 21111 0 collect.go:344] Waiting task_id: 43a8a99169377910 43a8a99169377910: exit 0 Additional test environment: CHROME_DEVEL_SANDBOX=/opt/chromium/chrome_sandbox CHROME_HEADLESS=1 LANG=en_US.UTF-8 Command: bin/run_blink_heap_unittests --test-launcher-bot-mode --test-launcher-summary-output=/b/s/w/iosN98TP/output.json 2019-03-18 01:08:47,859:INFO:root:Connecting to Fuchsia using SSH. 2019-03-18 01:09:18,132:INFO:root:Connected! 2019-03-18 01:09:18,132:INFO:root:Attaching kernel logger. [00000.000] zbi: @ 0xffffff8000a6a000 (9856728 bytes) [00000.000] UART: FIFO depth 16 [00000.000] PMM: boot reserve add [0x100000, 0x2e4fff] [00000.000] PMM: boot reserve add [0xa6a000, 0x13d0fff] [00000.000] PMM: boot reserve marking WIRED [0x100000, 0x2e4fff] [00000.000] PMM: boot reserve marking WIRED [0xa6a000, 0x13d0fff] [00000.000] [00000.000] welcome to Zircon [00000.000] [00000.000] KASLR: .text section at 0xffffffff00100000 [00000.000] INIT: cpu 0, calling hook 0xffffffff0010f234 (global_prng_seed) at level 0x30000, flags 0x1 [00000.000] initializing vm pre-heap [00000.000] VM: marking boot alloc used range [0x13d1000, 0x13d1040) [00000.000] INIT: cpu 0, calling hook 0xffffffff0011c4d8 (elf_build_id) at level 0x4fffe, flags 0x1 [00000.000] INIT: cpu 0, calling hook 0xffffffff0011c664 (version) at level 0x4ffff, flags 0x1 [00000.000] version: [00000.000] arch: x86 [00000.000] platform: XXX [00000.000] target: XXX [00000.000] project: x64 [00000.000] buildid: git-5f2dd2258e6159b2f5ca75e2ccbe358e1fa782d2-dirty [00000.000] ELF build ID: fa087b26b89e407aec091d2abcc2c221a9bf149e [00000.000] initializing heap [00000.000] INIT: cpu 0, calling hook 0xffffffff00101f78 (console) at level 0x50000, flags 0x1 [00000.000] INIT: cpu 0, calling hook 0xffffffff00171648 (x86_resource_init) at level 0x50000, flags 0x1 [00000.000] initializing vm [00000.000] VM: reserving kernel region [0xffffffff00100000, 0xffffffff00201000) flags 0x28 name 'kernel_code' [00000.000] VM: reserving kernel region [0xffffffff00201000, 0xffffffff0024f000) flags 0x8 name 'kernel_rodata' [00000.000] VM: reserving kernel region [0xffffffff0024f000, 0xffffffff0025f000) flags 0x18 name 'kernel_data' [00000.000] VM: reserving kernel region [0xffffffff0025f000, 0xffffffff002e5000) flags 0x18 name 'kernel_bss' [00000.000] INIT: cpu 0, calling hook 0xffffffff0017230c (display_memtype) at level 0x60001, flags 0x1 [00000.000] INIT: cpu 0, calling hook 0xffffffff0017534c (acpi_tables) at level 0x60001, flags 0x1 [00000.000] INIT: cpu 0, calling hook 0xffffffff0017046c (hpet) at level 0x60002, flags 0x1 [00000.000] INIT: cpu 0, calling hook 0xffffffff0017082c (apic) at level 0x60002, flags 0x1 [00000.000] x2APIC enabled [00000.000] INIT: cpu 0, calling hook 0xffffffff0017493c (timer) at level 0x60003, flags 0x1 [00000.000] pvclock: Clocksource is stable [00000.000] HPET frequency: 100000 ticks/ms [00000.000] pvclock: Fetching TSC frequency [00000.000] TSC frequency: 2199814 ticks/ms [00000.390] timer features: constant_tsc 1 invariant_tsc 1 tsc_deadline 1 [00000.390] Using TSC as wallclock [00000.390] initializing kernel [00000.390] initializing mp [00000.390] initializing timers [00000.390] INIT: cpu 0, calling hook 0xffffffff0010f488 (global_prng_thread_safe) at level 0x7ffff, flags 0x1 [00000.390] INIT: cpu 0, calling hook 0xffffffff0011b790 (debuglog) at level 0x7ffff, flags 0x1 [00000.390] INIT: cpu 0, calling hook 0xffffffff001e5d10 (thread_set_priority_experiment) at level 0x7ffff, flags 0x1 [00000.390] thread set priority experiment is : ENABLED [00000.390] creating bootstrap completion thread [00000.530] top of bootstrap2() [00000.530] INIT: cpu 0, calling hook 0xffffffff00127f70 (libobject) at level 0x80000, flags 0x1 [00000.530] OOM: started thread [00000.537] INIT: cpu 0, calling hook 0xffffffff0019d880 (dpc) at level 0x80000, flags 0x1 [00000.541] Processor Model Info: type 0 family 0x6 model 0xf stepping 0 [00000.541] display_family 0x6 display_model 0x4f [00000.541] Vendor: Intel [00000.541] Microarch: Broadwell [00000.541] F/M/S: 6/4f/0 [00000.541] Brand: Intel(R) Xeon(R) CPU @ 2.20GHz [00000.541] Features: fpu sse sse2 sse3 ssse3 sse4.1 sse4.2 mmx avx avx2 fxsr pcid xsave aesni clflush [00000.541] fsgsbase tsc_adj smep smap erms rdrand rdseed syscall nx rdtscp invar_tsc tsc_deadline [00000.541] x2apic hypervisor [00000.541] initializing platform [00000.541] INIT: cpu 0, calling hook 0xffffffff0018deb4 (x86_perfmon) at level 0x90000, flags 0x1 [00000.541] x86_perfmon_init_once:497: perfmon: unexpected programmable counter width 0 in cpuid.0AH [00000.542] UART: started IRQ driven RX [00000.542] UART: started IRQ driven TX [00000.542] cpu topology: [00000.542] 0: apic id 0x0 package 0 node 0 core 0 smt 0 BSP [00000.542] 1: apic id 0x1 package 1 node 0 core 0 smt 0 [00000.542] 2: apic id 0x2 package 2 node 0 core 0 smt 0 [00000.542] 3: apic id 0x3 package 3 node 0 core 0 smt 0 [00000.542] Found 4 cpus [00000.542] booting apic ids: 0x1 0x2 0x3 [00000.604] entering scheduler on cpu 2 [00000.604] entering scheduler on cpu 1 [00000.604] entering scheduler on cpu 3 [00000.612] smbios: manufacturer="QEMU" product="Standard PC (Q35 + ICH9, 2009)" [00000.613] initializing target [00000.613] INIT: cpu 0, calling hook 0xffffffff00173bec (x86_pcie_init) at level 0xa0000, flags 0x1 [00000.613] moving to last init level [00000.613] INIT: cpu 0, calling hook 0xffffffff00102a48 (kernel_shell) at level 0xc0000, flags 0x1 [00000.613] INIT: cpu 0, calling hook 0xffffffff001fc0a8 (ktrace) at level 0xc0000, flags 0x1 [00000.651] ktrace: buffer at 0xffffff9651beb000 (33554432 bytes) [00000.651] INIT: cpu 0, calling hook 0xffffffff001fdfe8 (userboot) at level 0xc0000, flags 0x1 [00000.651] userboot: ramdisk 0x967000 @ 0xffffff8000a6a000 [00000.664] userboot: userboot rodata 0 @ [0x23a55fd6b000,0x23a55fd6e000) [00000.664] userboot: userboot code 0x3000 @ [0x23a55fd6e000,0x23a55fd79000) [00000.664] userboot: vdso/full rodata 0 @ [0x23a55fd79000,0x23a55fd80000) [00000.664] userboot: vdso/full code 0x7000 @ [0x23a55fd80000,0x23a55fd81000) [00000.664] userboot: entry point @ 0x23a55fd6ec90 [00000.684] userboot: option "/b/s/w/ir/third_party/fuchsia-sdk/sdk/target/x64/qemu-kernel.bin=" [00000.684] userboot: option "devmgr.epoch=1552896526" [00000.684] userboot: option "zircon.nodename=67b3feea-f003-4b87-8ba3-442dcc98cb45" [00000.684] userboot: option "TERM=dumb" [00000.684] userboot: option "kernel.serial=legacy" [00000.684] userboot: option "multiboot.boot_loader_name=qemu" [00000.714] userboot: searching bootfs for 'bin/bootsvc' [00000.714] userboot: 'bin/bootsvc' has PT_INTERP "lib/ld.so.1" [00000.714] userboot: searching bootfs for 'lib/ld.so.1' [00000.714] userboot: userboot: loaded lib/ld.so.1 at 0x425d586a3000, entry point 0x425d586e02f1 [00000.714] userboot: userboot: loaded vDSO at 0x7ebf37518000, entry point 0x0 [00000.714] userboot: process bin/bootsvc started. [00000.714] userboot: waiting for loader-service requests... [00000.715] userboot: searching bootfs for 'lib/libasync-default.so' [00000.715] userboot: searching bootfs for 'lib/libfdio.so' [00000.715] userboot: searching bootfs for 'lib/libtrace-engine.so' [00000.750] userboot: searching bootfs for 'lib/liblaunchpad.so' [00000.754] {{{reset}}} [00000.754] {{{module:0:<application>:elf:be910e109aaa900057274be2c91b44fd9251d077}}} [00000.754] {{{mmap:0x7f83854ba000:0x39000:load:0:rx:0}}} [00000.754] {{{mmap:0x7f83854f3000:0x4000:load:0:rw:0x39000}}} [00000.754] dso: id=be910e109aaa900057274be2c91b44fd9251d077 base=0x00007f83854ba000 name=<application> [00000.754] {{{module:0x2:<vDSO>:elf:5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380}}} [00000.754] {{{mmap:0x7ebf37518000:0x7000:load:0x2:r:0}}} [00000.754] {{{mmap:0x7ebf3751f000:0x1000:load:0x2:rx:0x7000}}} [00000.754] dso: id=5db6a550b7c22b4e5d9c55acc5bbc1d2583f0380 base=0x00007ebf37518000 name=<vDSO> [00000.754] {{{module:0x3:libasync-default.so:elf:179378e0029e9d73bcaaf61330269def68f524f0}}} [00000.754] {{{mmap:0x544485243000:0x1000:load:0x3:rx:0}}} [00000.754] {{{mmap:0x544485244000:0x1000:load:0x3:rw:0x1000}}} [00000.754] dso: id=179378e0029e9d73bcaaf61330269def68f524f0 base=0x0000544485243000 name=libasync-default.so [00000.754] {{{module:0x1:libc.so:elf:608526d5035c0cab2fdd1718baca2d9ed1f3441b}}} [00000.754] {{{mmap:0x425d586a3000:0xcb000:load:0x1:rx:0}}} [00000.754] {{{mmap:0x425d5876f000:0x6000:load:0x1:rw:0xcc000}}} [00000.754] dso: id=608526d5035c0cab2fdd1718baca2d9ed1f3441b base=0x0000425d586a3000 name=libc.so [00000.754] {{{module:0x4:libfdio.so:elf:b9e13f817983faaf4b0927a0a26c6ae9fc2df591}}} [00000.754] {{{mmap:0x39480bea5000:0x32000:load:0x4:rx:0}}} [00000.754] {{{mmap:0x39480bed8000:0x4000:load:0x4:rw:0x33000}}} [00000.754] dso: id=b9e13f817983faaf4b0927a0a26c6ae9fc2df591 base=0x000039480bea5000 name=libfdio.so [00000.754] {{{module:0x5:libtrace-engine.so:elf:e693b8371adfd5db148ebbe7e9af42cfd4b2408f}}} [00000.754] {{{mmap:0xc23c9644000:0x9000:load:0x5:rx:0}}} [00000.754] {{{mmap:0xc23c964d000:0x2000:load:0x5:rw:0x9000}}} [00000.754] dso: id=e693b8371adfd5db148ebbe7e9af42cfd4b2408f base=0x00000c23c9644000 name=libtrace-engine.so [00000.754] {{{module:0x6:liblaunchpad.so:elf:7bbb5d72e7b50ffd31348f1fff0031cd559eaa75}}} [00000.754] {{{mmap:0x4e756da70000:0x7000:load:0x6:rx:0}}} [00000.754] {{{mmap:0x4e756da77000:0x2000:load:0x6:rw:0x7000}}} [00000.754] dso: id=7bbb5d72e7b50ffd31348f1fff0031cd559eaa75 base=0x00004e756da70000 name=liblaunchpad.so [00000.755] bootsvc: Starting... [00000.755] bootsvc: Creating bootfs service... [00000.755] userboot: loader-service channel peer closed [00000.755] userboot: finished! [00000.880] bootsvc: Processing bootdata... [00000.880] bootsvc: Loading boot cmdline overrides... [00000.880] bootsvc: Loading kernel VMOs... [00000.880] bootsvc: Creating loader service... [00000.880] bootsvc: Launching next process... [00000.881] bootsvc: launched bin/devcoordinator [00000.898] devcoordinator: main() [00000.899] devcoordinator: coordinator_init() [00000.899] devcoordinator: init [00000.899] devcoordinator: svc init [00000.900] devcoordinator: launch /boot/bin/svchost (svchost) OK [00000.900] devcoordinator: vfs init [00000.918] devcoordinator: launch /boot/bin/fshost (fshost) OK [00000.921] devcoordinator: shell startup [00000.930] fshost: started. [00000.938] devcoordinator: launch /boot/bin/pwrbtn-monitor (pwrbtn-monitor) OK [00000.944] devcoordinator: launch /boot/bin/netsvc (netsvc) OK [00000.956] devcoordinator: launch /boot/bin/virtual-console (virtual-console) OK [00000.979] devcoordinator: no driver info in '/boot/driver/mtk-power.so' [00000.995] devcoordinator: full system required, ignoring fallback drivers until /system is loaded [00001.001] devcoordinator: launch devhost 'devhost:sys': pid=2083 [00001.010] devcoordinator: launch devhost 'devhost:test': pid=2138 [00001.013] devhost: trace provider registry begun [00001.018] devhost: trace provider registry begun [00001.022] devcoordinator: launch devhost 'devhost:root': pid=2241 [00001.029] devcoordinator: launch devhost 'devhost:misc': pid=2294 [00001.046] devhost: trace provider registry begun [00001.071] GetZbiMetadata metadata not found for type 524f426d, extra 0 [00001.076] devhost: trace provider registry begun [00001.094] devcoordinator: launch /boot/bin/sh (sh:console) OK [00001.111] acpi-bus: not using IOMMU [00001.114] GetHwProperties: No PM support [00001.114] IntelPT: No PT support [00001.114] devhost[sys/cpu-trace] bind driver '/boot/driver/cpu-trace.so' failed: -2 [00001.125] devcoordinator: rpc: bind-driver 'cpu-trace' status -2 [00001.130] [sysmem_init 28] async_get_default_dispatcher(): 0x7329357bf0a0 [00001.130] [sysmem_bind 40] sysmem_bind() [00001.137] acpi-pwrbtn: initialized [00001.141] vc: new input device /dev/class/input/000 [00001.210] acpi: published device pci(0x72ebbffe6180), parent=sys(0x7329357cd0c0), handle=0x7329357ca300 [00001.210] acpi: failed to get PCI base bus number for device 'PCI0' (status 4294967295) [00001.223] acpi: published device rtc(0x72ebbffe6200), parent=acpi(0x7329357cd300), handle=0x7329357ca7b0 [00001.230] acpi: published device i8042(0x72ebbffe6280), parent=acpi(0x7329357cd300), handle=0x7329357ca840 [00001.241] devcoordinator: launch devhost 'devhost:pci#1:1234:1111': pid=2781 [00001.249] devcoordinator: launch devhost 'devhost:pci#2:1af4:1001': pid=2838 [00001.251] devhost: trace provider registry begun [00001.262] devcoordinator: launch devhost 'devhost:pci#3:8086:100e': pid=2931 [00001.273] devhost: trace provider registry begun [00001.279] devcoordinator: launch devhost 'devhost:pci#5:8086:2922': pid=3005 [00001.290] devhost: trace provider registry begun [00001.290] devhost: WARNING: driver '/boot/driver/pc-ps2.so' did not add device in bind() [00001.302] i8042 device 0xab 0x41 [00001.304] bochs_vbe: initialized display, 1024 x 768 (stride=1024 format=00020001) [00001.316] devhost: trace provider registry begun [00001.317] vc: new input device /dev/class/input/001 [00001.330] vc: new display device /dev/class/display-controller/000/virtcon [00001.336] ahci: using MSI interrupt [00001.340] vc: Successfully attached to display 1 [00001.373] fshost: /dev/class/block/000: FVM? [00001.397] devcoordinator: launch /boot/bin/blobfs (blobfs:/blob) OK [00001.466] i8042 device 0x00 [00001.474] hid: boot mouse hack for "hid-device-002": report count (0->1), inp sz (24->24), out sz (0->0), feat sz (0->0) [00001.483] vc: new input device /dev/class/input/002 [00001.856] fshost: starting 'bin/pkgsvr' 'ac8bdc046e71a5b2101645292fd640ca71d4bfbacaacb13b59d98cc1538a8966'... [00002.407] netifc: ? /dev/class/ethernet/000 [00002.411] netifc: create 512 eth buffers [00002.415] macaddr: 52:54:00:63:5e:7b [00002.415] ip6addr: fe80::5054:4d:fe63:5e7b [00002.415] snmaddr: ff02::1:ff63:5e7b [00002.416] netsvc: using /dev/class/ethernet/000 [00002.416] netsvc: nodename='67b3feea-f003-4b87-8ba3-442dcc98cb45' [00002.416] netsvc: start [00002.724] devcoordinator: launch bin/pkgsvr (pkgfs) OK [00004.623] pkgsvr: system: will be served from ac8bdc046e71a5b2101645292fd640ca71d4bfbacaacb13b59d98cc1538a8966 [00004.623] pkgsvr: pkgfs serving index /data/pkgfs_index from blobfs /blob [00004.954] fshost: mounting minfs [00004.962] devcoordinator: launch /boot/bin/minfs (minfs:/data) OK [00007.632] devcoordinator: adding system driver 'bt_host' '/system/driver/bt-host.so' [00007.642] devcoordinator: launch /system/bin/appmgr (appmgr) OK [00008.618] devcoordinator: adding system driver 'bt_hog' '/system/driver/bt-hog.so' [00009.892] devcoordinator: adding system driver 'bt_hci_fake' '/system/driver/bt-hci-fake.so' [00012.119] devcoordinator: adding system driver 'gpu' '/system/driver/libmsd_intel.so' [00013.085] devcoordinator: adding system driver 'bt_hci_passthrough' '/system/driver/bt-hci-passthrough.so' [00013.092] devcoordinator: driver 'gpu' added [00013.093] devcoordinator: driver 'bt_hci_fake' added [00013.093] devcoordinator: driver 'bt_hog' added [00013.093] devcoordinator: driver 'bt_host' added [00013.093] devcoordinator: driver 'bt_hci_passthrough' added [00013.093] devcoordinator: fallback driver 'usb_composite' is available [00013.093] devcoordinator: driver 'usb_composite' added [00013.093] devcoordinator: fallback driver 'intel_disp' is available [00013.093] devcoordinator: driver 'intel_disp' added [00014.290] [INFO:namespace_builder.cc(93)] config-data for sysmgr [00026.235] [INFO:cobalt_main.cc(145)] Cobalt client schedule params: schedule_interval=3600 seconds, min_interval=10 seconds, initial_interval=60 seconds. [00026.562] [ERROR:garnet/lib/loader/package_loader.cc(55)] Could not open directory /pkgfs/packages/modem-mgr/0 No such file or directory [00026.786] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/modem-mgr#meta/modem_mgr.cmx died [00027.498] [INFO:namespace_builder.cc(93)] config-data for crashpad_agent [00027.731] [INFO:main.cc(35)] Trace Manager starting with config: /pkg/data/tracing.config [00027.889] wlanstack2 [I]: Starting [00028.179] [INFO:a11y_input_system.cc(9)] Scenic accessibility input system started. [00028.184] [INFO:display_watcher.cc(40)] Scenic: Acquired display controller /dev/class/display-controller/000.(000) [00028.673] [INFO:input_interpreter.cc(1006)] hid-parser succesful for 000 with usage page 1 and usage 128 [00028.794] Starting mDNS on interface ethp0003 192.168.3.9 [00028.805] Starting mDNS on interface ethp0003 [80fe::5450:ff00:63fe:7b5e] [00028.811] [ERROR:garnet/bin/mdns/service/mdns_interface_transceiver_v6.cc(49)] Failed to set socket option IPV6_JOIN_GROUP, No such device [00028.820] mDNS: Verifying uniqueness of host name step-dime-yard-juicy.local. [00029.055] ERROR: setupLoaderTermPhysDevs: Failed to detect any valid GPUs in the current coinitialized repo /b/s/w/itkFTMm7/tmptI7sHb adding package blink_heap_unittests/0 2019/03/18 08:09:19 error removing source: Source not found 2019-03-18 01:09:20,524:INFO:root:Installing blink_heap_unittests version 0. 2019/03/18 08:09:22 Awaiting response... 2019/03/18 08:09:26 Awaiting response... 2019/03/18 08:09:29 Awaiting response... 2019/03/18 08:09:32 Awaiting response... 2019/03/18 08:09:35 Awaiting response... 2019/03/18 08:09:38 Awaiting response... 2019/03/18 08:09:41 Awaiting response... 2019/03/18 08:09:44 Awaiting response... 2019/03/18 08:09:47 Awaiting response... 2019/03/18 08:09:50 Awaiting response... 2019/03/18 08:09:53 Awaiting response... 2019/03/18 08:09:56 Awaiting response... 2019/03/18 08:09:59 Awaiting response... 2019/03/18 08:10:02 Awaiting response... 2019/03/18 08:10:05 Awaiting response... 2019/03/18 08:10:09 Awaiting response... 2019/03/18 08:10:12 Awaiting response... 2019/03/18 08:10:15 Awaiting response... 2019/03/18 08:10:18 Awaiting response... 2019/03/18 08:10:21 Awaiting response... 2019/03/18 08:10:24 Awaiting response... 2019/03/18 08:10:27 Awaiting response... 2019/03/18 08:10:30 Awaiting response... 2019/03/18 08:10:33 Awaiting response... 2019/03/18 08:10:36 Awaiting response... 2019/03/18 08:10:40 Awaiting response... 2019/03/18 08:10:43 Awaiting response... 2019/03/18 08:10:46 Awaiting response... 2019/03/18 08:10:49 Awaiting response... 2019/03/18 08:10:52 Awaiting response... 2019/03/18 08:10:55 Awaiting response... 2019/03/18 08:10:59 Awaiting response... 2019/03/18 08:11:02 Awaiting response... 2019/03/18 08:11:05 Awaiting response... 2019/03/18 08:11:08 Awaiting response... 2019/03/18 08:11:11 Awaiting response... 2019/03/18 08:11:14 Awaiting response... 2019/03/18 08:11:17 Awaiting response... 2019/03/18 08:11:21 Awaiting response... 2019/03/18 08:11:24 Awaiting response... 2019/03/18 08:11:27 Awaiting response... 2019/03/18 08:11:30 Awaiting response... 2019/03/18 08:11:33 Awaiting response... 2019/03/18 08:11:36 Awaiting response... 2019/03/18 08:11:39 Awaiting response... 2019/03/18 08:11:42 Awaiting response... 2019/03/18 08:11:45 Awaiting response... 2019/03/18 08:11:48 Awaiting response... 2019/03/18 08:11:52 Awaiting response... 2019/03/18 08:11:55 Awaiting response... 2019/03/18 08:11:58 Awaiting response... 2019/03/18 08:12:01 Awaiting response... 2019/03/18 08:12:04 Awaiting response... 2019/03/18 08:12:07 Awaiting response... 2019/03/18 08:12:10 Awaiting response... 2019/03/18 08:12:13 Awaiting response... 2019/03/18 08:12:16 Awaiting response... 2019/03/18 08:12:19 Success blink_heap_unittests/0: db5eb6cae127a998c18e1ce6535f1324a026a844420e80e755a1d4a4d10ec909 2019-03-18 01:12:21,335:INFO:root:Running application. 2019-03-18 01:12:21,338:INFO:root:Running "/b/s/w/ir/third_party/fuchsia-sdk/sdk/tools/symbolize -ids /b/s/w/ir/out/Debug/gen/third_party/blink/renderer/platform/heap/blink_heap_unittests/ids.txt -ids-rel -llvm-symbolizer /b/s/w/ir/third_party/fuchsia-sdk/sdk/../../llvm-build/Release+Asserts/bin/llvm-symbolizer -build-id-dir /b/s/w/ir/third_party/fuchsia-sdk/sdk/.build-id". nfig [00029.056] ERROR: setupLoaderTrampPhysDevs: Failed during dispatch call of 'vkEnumeratePhysicalDevices' to lower layers or loader to get count. [00029.056] [ERROR:garnet/lib/ui/gfx/gfx_system.cc(188)] No Vulkan on device, Graphics system exiting. [00029.056] [INFO:input_system.cc(245)] Scenic input system initialized. [00029.080] [ERROR:garnet/bin/ui/root_presenter/app.cc(214)] Scenic died, destroying all presentations. [00029.080] [ERROR:garnet/bin/ui/view_manager/view_registry.cc(80)] Exiting due to scene manager connection error. [00029.093] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/scenic#meta/scenic.cmx died [00029.105] [ERROR:garnet/bin/sysmgr/app.cc(166)] Singleton fuchsia-pkg://fuchsia.com/view_manager#meta/view_manager.cmx died [00029.648] mDNS: Using unique host name step-dime-yard-juicy.local. [00032.922] pkgsvr: asking amber to fetch 2548 needed blobs [00212.347] pkgsvr: package activated blink_heap_unittests/0 (db5eb6cae127a998c18e1ce6535f1324a026a844420e80e755a1d4a4d10ec909) IMPORTANT DEBUGGING NOTE: batches of tests are run inside their own process. For debugging a test inside a debugger, use the --gtest_filter=<your_test_name> flag along with --single-process-tests. Using sharding settings from environment. This is shard 0/1 Using 4 parallel jobs. [1/313] HeapCompactTest.CompactInlinedBackingStore (6 ms) [2/313] ThreadHeapStatsCollectorTest.InitialEmpty (0 ms) [3/313] ThreadHeapStatsCollectorTest.IncreaseScopeTime (0 ms) [4/313] ThreadHeapStatsCollectorTest.StopMovesCurrentToPrevious (0 ms) [5/313] ThreadHeapStatsCollectorTest.StopResetsCurrent (0 ms) [6/313] ThreadHeapStatsCollectorTest.StartStop (0 ms) [7/313] ThreadHeapStatsCollectorTest.ScopeToString (0 ms) [8/313] ThreadHeapStatsCollectorTest.UpdateReason (0 ms) [9/313] ThreadHeapStatsCollectorTest.InitialEstimatedObjectSizeInBytes (0 ms) [10/313] ThreadHeapStatsCollectorTest.EstimatedObjectSizeInBytesNoMarkedBytes (0 ms) [11/313] AddressCacheTest.AddEntryAddsWholePage (4 ms) [12/313] AddressCacheTest.AddEntryOnlyAddsPageForGivenAddress (1 ms) [13/313] AddressCacheTest.FlushIfDirtyIgnoresNonDirty (1 ms) [14/313] AddressCacheTest.FlushIfDirtyHandlesDirty (1 ms) [15/313] BlinkGCDumpProviderTest.MemoryDump (7 ms) [16/313] GCInfoTest.InitialEmpty (1 ms) [17/313] GCInfoTest.ResizeToMaxIndex (3 ms) [18/313] HeapCompactTest.SparseBitmapBasic (0 ms) [19/313] HeapCompactTest.SparseBitmapBuild (0 ms) [20/313] HeapCompactTest.SparseBitmapLeftExtension (0 ms) [21/313] HeapCompactTest.CompactVector (6 ms) [22/313] HeapCompactTest.CompactHashMap (6 ms) [23/313] HeapCompactTest.CompactVectorPartHashMap (9 ms) [24/313] HeapCompactTest.CompactHashPartVector (30 ms) [25/313] HeapCompactTest.CompactDeques (6 ms) [26/313] HeapCompactTest.CompactDequeVectors (10 ms) [27/313] HeapCompactTest.CompactLinkedHashSet (12 ms) [28/313] HeapCompactTest.CompactLinkedHashSetVector (6 ms) [29/313] HeapCompactTest.CompactLinkedHashSetMap (4 ms) [30/313] HeapCompactTest.CompactLinkedHashSetNested (23 ms) [31/313] ThreadHeapStatsCollectorTest.EstimatedObjectSizeInBytesWithMarkedBytes (1 ms) [32/313] ThreadHeapStatsCollectorTest.EstimatedObjectSizeInBytesDoNotCountCurrentlyMarkedBytes (0 ms) [33/313] ThreadHeapStatsCollectorTest.PreInitializedEstimatedMarkingTime (0 ms) [34/313] ThreadHeapStatsCollectorTest.EstimatedMarkingTime1 (0 ms) [35/313] ThreadHeapStatsCollectorTest.EstimatedMarkingTime2 (0 ms) [36/313] ThreadHeapStatsCollectorTest.AllocatedSpaceInBytesInitialZero (1 ms) [37/313] ThreadHeapStatsCollectorTest.AllocatedSpaceInBytesIncrease (1 ms) [38/313] ThreadHeapStatsCollectorTest.AllocatedSpaceInBytesDecrease (1 ms) [39/313] ThreadHeapStatsCollectorTest.EventPrevGCMarkedObjectSize (0 ms) [40/313] ThreadHeapStatsCollectorTest.EventMarkingTimeInMsFromIncrementalGC (0 ms) [41/313] ThreadHeapStatsCollectorTest.EventMarkingTimeInMsFromFullGC (1 ms) [42/313] ThreadHeapStatsCollectorTest.EventMarkingTimePerByteInS (1 ms) [43/313] ThreadHeapStatsCollectorTest.EventSweepingTimeInMs (0 ms) [44/313] ThreadHeapStatsCollectorTest.EventCompactionFreedBytes (0 ms) [45/313] ThreadHeapStatsCollectorTest.EventCompactionFreedPages (1 ms) [46/313] ThreadHeapStatsCollectorTest.EventInitialEstimatedLiveObjectRate (0 ms) [47/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateSameMarkedBytes (0 ms) [48/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateHalfMarkedBytes (0 ms) [49/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateNoMarkedBytes (0 ms) [50/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateWithAllocatedBytes1 (0 ms) [51/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateWithAllocatedBytes2 (1 ms) [52/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateWithAllocatedBytes3 (0 ms) [53/313] ThreadHeapStatsCollectorTest.EventEstimatedLiveObjectRateWithAllocatedBytes4 (0 ms) [54/313] ThreadHeapStatsCollectorTest.EventAllocatedSpaceBeforeSweeping1 (1 ms) [55/313] ThreadHeapStatsCollectorTest.EventAllocatedSpaceBeforeSweeping2 (0 ms) [56/313] HeapTest.IsHeapObjectAliveForConstPointer (1 ms) [57/313] HeapTest.PreFinalizerBackingShrinkForbidden (11 ms) [58/313] HeapTest.Transition (9 ms) [59/313] HeapTest.Threading (257 ms) [60/313] HeapTest.ThreadedWeakness (442 ms) [61/313] HeapTest.TypedArenaSanity (4 ms) [62/313] HeapTest.NoAllocation (1 ms) [63/313] HeapTest.Members (5 ms) [64/313] HeapTest.MarkTest (8 ms) [65/313] HeapTest.DeepTest (322 ms) [66/313] HeapTest.WideTest (10 ms) [67/313] HeapTest.HashMapOfMembers (15 ms) [68/313] HeapTest.NestedAllocation (1 ms) [69/313] HeapTest.LargeHeapObjects (19 ms) [70/313] HeapTest.LargeHashMap (523 ms) [71/313] HeapTest.LargeVector (370 ms) [72/313] HeapTest.HeapVectorFilledWithValue (2 ms) [73/313] HeapTest.HeapVectorWithInlineCapacity (16 ms) [74/313] HeapTest.HeapVectorShrinkCapacity (9 ms) [75/313] HeapTest.HeapVectorShrinkInlineCapacity (3 ms) [76/313] HeapTest.HeapVectorOnStackLargeObjectPageSized (5 ms) [77/313] HeapTest.HeapCollectionTypes (44 ms) [78/313] HeapTest.PersistentVector (4 ms) [79/313] HeapTest.CrossThreadPersistentVector (3 ms) [80/313] HeapTest.PersistentSet (2 ms) [81/313] HeapTest.ThreadPersistent (370 ms) [82/313] HeapTest.BasicFunctionality (1044 ms) [83/313] HeapTest.SimpleAllocation (7 ms) [84/313] HeapTest.SimplePersistent (3 ms) [85/313] HeapTest.SimpleFinalization (2 ms) [86/313] HeapTest.FreelistReuse (4 ms) [87/313] HeapTest.LazySweepingPages (9 ms) [88/313] HeapTest.LazySweepingLargeObjectPages (36 ms) [89/313] HeapTest.EagerlySweepingPages (4 ms) [90/313] HeapTest.Finalization (3 ms) [91/313] HeapTest.WeakMembers (11 ms) [92/313] HeapTest.FinalizationObserver (7 ms) [93/313] HeapTest.PreFinalizer (2 ms) [94/313] HeapTest.PreFinalizerUnregistersItself (1 ms) [95/313] HeapTest.NestedPreFinalizer (2 ms) [96/313] HeapTest.Comparisons (2 ms) [97/313] HeapTest.CheckAndMarkPointer (5 ms) [98/313] HeapTest.CollectionNesting (12 ms) [99/313] HeapTest.GarbageCollectedMixin (6 ms) [100/313] HeapTest.CollectionNesting2 (5 ms) [101/313] HeapTest.CrossThreadPersistentSet (5 ms) [102/313] HeapTest.HeapHashMapWithInlinedObject (32 ms) [103/313] HeapTest.HeapWeakCollectionSimple (13 ms) [104/313] HeapTest.HeapWeakLinkedHashSet (25 ms) [105/313] HeapTest.HeapMapDestructor (20 ms) [106/313] HeapTest.HeapWeakPairs (11 ms) [107/313] HeapTest.HeapWeakCollectionTypes (251 ms) [108/313] HeapTest.HeapHashCountedSetToVector (3 ms) [109/313] HeapTest.WeakHeapHashCountedSetToVector (1 ms) [110/313] HeapTest.RefCountedGarbageCollected (4 ms) [111/313] HeapTest.CollectionNesting3 (5 ms) [112/313] HeapTest.EmbeddedInVector (6 ms) [113/313] HeapTest.EmbeddedInDeque (12 ms) [114/313] HeapTest.VectorDestructors (8 ms) [115/313] HeapTest.VectorDestructorsWithVtable (10 ms) [116/313] HeapTest.HeapLinkedStack (6 ms) [117/313] HeapTest.AllocationDuringFinalization (69 ms) [118/313] HeapTest.AllocationDuringPrefinalizer (54 ms) [119/313] HeapTest.DestructorsCalled (2 ms) [120/313] HeapTest.MultipleMixins (5 ms) [121/313] HeapTest.EphemeronsPointToEphemerons (16 ms) [122/313] HeapTest.Ephemeron (4 ms) [123/313] HeapTest.IndirectStrongToWeak (3 ms) [124/313] HeapTest.GCInHashMapOperations (26 ms) [125/313] HeapTest.PartObjectWithVirtualMethod (1 ms) [126/313] HeapTest.AllocationInSuperConstructorArgument (2 ms) [127/313] HeapTest.NonNodeAllocatingNodeInDestructor (4 ms) [128/313] HeapTest.TraceDeepEagerly (1 ms) [129/313] HeapTest.DequeExpand (3 ms) [130/313] HeapTest.DequePartObjectsExpand (3 ms) [131/313] HeapTest.HeapVectorPartObjects (3 ms) [132/313] HeapTest.StackGrowthDirection (0 ms) [133/313] HeapTest.StackFrameDepthDisabledByDefault (1 ms) [134/313] HeapTest.StackFrameDepthEnable (0 ms) [135/313] HeapTest.NestedMixinConstruction (1 ms) [136/313] HeapTest.WeakPersistent (3 ms) [137/313] HeapTest.TestClearOnShutdown (259 ms) [138/313] HeapTest.TestWeakConstObject (3 ms) [139/313] HeapTest.IsGarbageCollected (1 ms) [140/313] HeapTest.HeapHashMapCallsDestructor (4 ms) [141/313] HeapTest.DerivedMultipleMixins (5 ms) [142/313] HeapTest.MixinInstanceWithoutTrace (3 ms) [143/313] HeapTest.NeedsAdjustPointer (0 ms) [144/313] HeapTest.SetWithCustomWeaknessHandling (15 ms) [145/313] HeapTest.MapWithCustomWeaknessHandling (8 ms) [146/313] HeapTest.MapWithCustomWeaknessHandling2 (8 ms) [147/313] HeapTest.RegressNullIsStrongified (2 ms) [148/313] HeapTest.Bind (3 ms) [149/313] HeapTest.RemoveEmptySets (4 ms) [150/313] HeapTest.EphemeronsInEphemerons (1026 ms) [00227.885] PageFault: 229685 free pages [00227.889] PageFault: MemoryUsed: proc 3390 629M 'blobfs:/blob' [00227.890] PageFault: MemoryUsed: proc 3591 14M 'pkgfs' [00227.890] PageFault: MemoryUsed: proc 3943 17M 'minfs:/data' [00227.890] PageFault: MemoryUsed: proc 5402 105M 'amber.cmx' [00227.891] PageFault: MemoryUsed: proc 5713 31M 'netstack.cmx' [00227.892] PageFault: MemoryUsed: proc 131128 15M 'blink_heap_unittests.cmx' [00227.893] PageFault: MemoryUsed: proc 133573 18M '/pkg/blink_heap_unittests__exec' [00227.894] PageFault: MemoryUsed: proc 161464 18M '/pkg/blink_heap_unittests__exec' [00227.894] PageFault: MemoryUsed: proc 162394 12M '/pkg/blink_heap_unittests__exec' [00227.895] PageFault: MemoryUsed: proc 163277 8M '/pkg/blink_heap_unittests__exec' [151/313] HeapDeathTest.PreFinalizerVectorBackingExpandForbidden (1391 ms) [152/313] HeapDeathTest.PreFinalizerHashTableBackingExpandForbidden (1402 ms) [153/313] HeapDeathTest.LargeGarbageCollectedMixin (1476 ms) [154/313] HeapDeathTest.MemberSameThreadCheck (1137 ms) [155/313] HeapDeathTest.PersistentSameThreadCheck (1268 ms) [156/313] HeapDeathTest.MarkingSameThreadCheck (1298 ms) [157/313] AddressCacheTest.Scope (0 ms) [158/313] AddressCacheTest.InitialIsEmpty (1 ms) [159/313] AddressCacheTest.LookupOnEmpty (1 ms) [160/313] AddressCacheTest.LookupAfterAddEntry (0 ms) [161/313] HeapTest.HeapDoublyLinkedList (5 ms) [162/313] HeapTest.PromptlyFreeStackAllocatedHeapVector (3 ms) [163/313] HeapTest.PromptlyFreeStackAllocatedHeapDeque (1 ms) [164/313] HeapTest.PromptlyFreeStackAllocatedHeapHashSet (5 ms) [165/313] HeapTest.PromptlyFreeStackAllocatedHeapListHashSet (5 ms) [166/313] HeapTest.PromptlyFreeStackAllocatedHeapLinkedHashSet (0 ms) [167/313] HeapTest.ShrinkVector (3 ms) [168/313] HeapTest.GarbageCollectedInConstruction (3 ms) [169/313] HeapTest.GarbageCollectedMixinInConstruction (1 ms) [170/313] HeapTest.GarbageCollectedMixinIsAliveDuringConstruction (0 ms) [171/313] HeapThreadTest.CrossThreadWeakPersistent (9 ms) [172/313] IncrementalMarkingTest.EnableDisableBarrier (1 ms) [173/313] IncrementalMarkingTest.StackFrameDepthDisabled (1 ms) [174/313] IncrementalMarkingTest.ManualWriteBarrierTriggersWhenMarkingIsOn (7 ms) [175/313] IncrementalMarkingTest.ManualWriteBarrierBailoutWhenMarkingIsOff (0 ms) [176/313] IncrementalMarkingTest.MemberSetUnmarkedObject (1 ms) [177/313] IncrementalMarkingTest.MemberSetMarkedObjectNoBarrier (1 ms) [178/313] IncrementalMarkingTest.MemberInitializingStoreNoBarrier (1 ms) [179/313] IncrementalMarkingTest.MemberReferenceAssignMember (1 ms) [180/313] IncrementalMarkingTest.MemberSetDeletedValueNoBarrier (1 ms) [181/313] IncrementalMarkingTest.MemberCopyDeletedValueNoBarrier (1 ms) [182/313] IncrementalMarkingTest.MemberHashTraitConstructDeletedValueNoBarrier (1 ms) [183/313] IncrementalMarkingTest.MemberHashTraitIsDeletedValueNoBarrier (1 ms) [184/313] IncrementalMarkingTest.WriteBarrierOnUnmarkedMixinApplication (1 ms) [185/313] IncrementalMarkingTest.NoWriteBarrierOnMarkedMixinApplication (0 ms) [186/313] IncrementalMarkingTest.HeapVectorPushBackMember (1 ms) [187/313] IncrementalMarkingTest.HeapVectorPushBackNonGCedContainer (1 ms) [188/313] IncrementalMarkingTest.HeapVectorPushBackStdPair (1 ms) [189/313] IncrementalMarkingTest.HeapVectorEmplaceBackMember (1 ms) [190/313] IncrementalMarkingTest.HeapVectorEmplaceBackNonGCedContainer (1 ms) [191/313] IncrementalMarkingTest.HeapVectorEmplaceBackStdPair (3 ms) [192/313] IncrementalMarkingTest.HeapVectorCopyMember (0 ms) [193/313] IncrementalMarkingTest.HeapVectorCopyNonGCedContainer (1 ms) [194/313] IncrementalMarkingTest.HeapVectorCopyStdPair (3 ms) [195/313] IncrementalMarkingTest.HeapVectorMoveMember (1 ms) [196/313] IncrementalMarkingTest.HeapVectorMoveNonGCedContainer (0 ms) [197/313] IncrementalMarkingTest.HeapVectorMoveStdPair (0 ms) [198/313] IncrementalMarkingTest.HeapVectorSwapMember (1 ms) [199/313] IncrementalMarkingTest.HeapVectorSwapNonGCedContainer (0 ms) [200/313] IncrementalMarkingTest.HeapVectorSwapStdPair (2 ms) [201/313] IncrementalMarkingTest.HeapVectorSubscriptOperator (10 ms) [202/313] IncrementalMarkingTest.HeapVectorEagerTracingStopsAtMember (0 ms) [203/313] IncrementalMarkingTest.HeapDoublyLinkedListPush (1 ms) [204/313] IncrementalMarkingTest.HeapDoublyLinkedListAppend (0 ms) [205/313] IncrementalMarkingTest.HeapDequePushBackMember (1 ms) [206/313] IncrementalMarkingTest.HeapDequePushFrontMember (10 ms) [207/313] IncrementalMarkingTest.HeapDequeEmplaceBackMember (9 ms) [208/313] IncrementalMarkingTest.HeapDequeEmplaceFrontMember (23 ms) [209/313] IncrementalMarkingTest.HeapDequeCopyMember (0 ms) [210/313] IncrementalMarkingTest.HeapDequeMoveMember (0 ms) [211/313] IncrementalMarkingTest.HeapLinkedHashSetSwap (8 ms) [212/313] IncrementalMarkingTest.HeapHashCountedSetInsert (0 ms) [213/313] IncrementalMarkingTest.HeapHashCountedSetSwap (0 ms) [214/313] IncrementalMarkingTest.HeapHashMapInsertMember (0 ms) [215/313] IncrementalMarkingTest.HeapHashMapInsertWeakMember (0 ms) [216/313] IncrementalMarkingTest.HeapHashMapInsertMemberWeakMember (0 ms) [217/313] IncrementalMarkingTest.HeapHashMapInsertWeakMemberMember (0 ms) [218/313] IncrementalMarkingTest.HeapHashMapSetMember (1 ms) [219/313] IncrementalMarkingTest.HeapHashMapSetMemberUpdateValue (0 ms) [220/313] IncrementalMarkingTest.HeapHashMapIteratorChangeKey (0 ms) [221/313] IncrementalMarkingTest.HeapDequeSwapMember (2 ms) [222/313] IncrementalMarkingTest.HeapHashSetInsert (2 ms) [223/313] IncrementalMarkingTest.HeapHashSetCopy (1 ms) [224/313] IncrementalMarkingTest.HeapHashSetMove (1 ms) [225/313] IncrementalMarkingTest.HeapHashSetSwap (0 ms) [226/313] IncrementalMarkingTest.HeapHashSetStrongWeakPair (0 ms) [227/313] IncrementalMarkingTest.HeapLinkedHashSetStrongWeakPair (1 ms) [228/313] IncrementalMarkingTest.HeapLinkedHashSetInsert (0 ms) [229/313] IncrementalMarkingTest.HeapLinkedHashSetCopy (0 ms) [230/313] IncrementalMarkingTest.HeapLinkedHashSetMove (0 ms) [231/313] IncrementalMarkingTest.HeapHashMapSwapWeakMemberWeakMember (3 ms) [232/313] IncrementalMarkingTest.HeapHashMapSwapMemberWeakMember (1 ms) [233/313] IncrementalMarkingTest.HeapHashMapSwapWeakMemberMember (1 ms) [234/313] IncrementalMarkingTest.HeapHashMapInsertStrongWeakPairMember (0 ms) [235/313] IncrementalMarkingTest.HeapHashMapInsertMemberStrongWeakPair (0 ms) [236/313] IncrementalMarkingTest.HeapHashMapCopyKeysToVectorMember (2 ms) [237/313] IncrementalMarkingTest.HeapHashMapCopyValuesToVectorMember (0 ms) [238/313] IncrementalMarkingTest.WriteBarrierDuringMixinConstruction (0 ms) [239/313] IncrementalMarkingTest.OverrideAfterMixinConstruction (1 ms) [240/313] IncrementalMarkingTest.TestDriver (9 ms) [241/313] IncrementalMarkingTest.HeapHashMapIteratorChangeValue (3 ms) [242/313] IncrementalMarkingTest.HeapHashMapCopyMemberMember (1 ms) [243/313] IncrementalMarkingTest.HeapHashMapCopyWeakMemberWeakMember (0 ms) [244/313] IncrementalMarkingTest.HeapHashMapCopyMemberWeakMember (0 ms) [245/313] IncrementalMarkingTest.HeapHashMapCopyWeakMemberMember (1 ms) [246/313] IncrementalMarkingTest.HeapHashMapMoveMember (0 ms) [247/313] IncrementalMarkingTest.HeapHashMapMoveWeakMember (1 ms) [248/313] IncrementalMarkingTest.HeapHashMapMoveMemberWeakMember (1 ms) [249/313] IncrementalMarkingTest.HeapHashMapMoveWeakMemberMember (1 ms) [250/313] IncrementalMarkingTest.HeapHashMapSwapMemberMember (1 ms) [251/313] IncrementalMarkingTest.StepDuringMixinObjectConstruction (21 ms) [252/313] NameTraitTest.InternalNamesHiddenInOfficialBuild (1 ms) [253/313] NameTraitTest.InternalNamesHiddenWhenFlagIsTurnedOff (0 ms) [254/313] NameTraitTest.DefaultName (1 ms) [255/313] NameTraitTest.CustomName (0 ms) [256/313] ObjectStartBitmapTest.MoreThanZeroEntriesPossible (1 ms) [257/313] ObjectStartBitmapTest.InitialEmpty (0 ms) [258/313] ObjectStartBitmapTest.SetBitImpliesNonEmpty (1 ms) [259/313] ObjectStartBitmapTest.SetBitCheckBit (1 ms) [260/313] ObjectStartBitmapTest.SetBitClearbitCheckBit (0 ms) [261/313] IncrementalMarkingTest.DropBackingStore (14 ms) [262/313] IncrementalMarkingTest.WeakCallbackDoesNotReviveDeletedValue (4 ms) [263/313] IncrementalMarkingTest.NoBackingFreeDuringIncrementalMarking (3 ms) [264/313] IncrementalMarkingTest.DropReferenceWithHeapCompaction (3 ms) [265/313] IncrementalMarkingTest.HasInlineCapacityCollectionWithHeapCompaction (10 ms) [266/313] IncrementalMarkingTest.WeakHashMapHeapCompaction (3 ms) [267/313] IncrementalMarkingTest.ConservativeGCWhileCompactionScheduled (7 ms) [268/313] IncrementalMarkingTest.WeakMember (3 ms) [269/313] IncrementalMarkingTest.MemberSwap (1 ms) [270/313] IncrementalMarkingTest.StepDuringObjectConstruction (5 ms) [271/313] ThreadStateSchedulingTest.ScheduleIdleGCAgain (2 ms) [272/313] ThreadStateSchedulingTest.ScheduleIncrementalV8FollowupGCAgain (1 ms) [273/313] ThreadStateSchedulingTest.ScheduleIdleGCWhileIncrementalMarking (1 ms) [274/313] ThreadStateSchedulingTest.ScheduleIdleGCWhileLazySweeping (0 ms) [275/313] ThreadStateSchedulingTest.SchedulePreciseGCWhileLazySweeping (0 ms) [276/313] ThreadStateSchedulingTest.ScheduleIncrementalV8FollowupGCWhileLazySweeping (0 ms) [277/313] ThreadStateSchedulingTest.SchedulePreciseGCWhileIncrementalMarking (1 ms) [278/313] ThreadStateSchedulingTest.ScheduleIncrementalV8FollowupGCWhileIncrementalMarking (1 ms) [279/313] ThreadStateSchedulingTest.ScheduleIdleGCWhileGCForbidden (1 ms) [280/313] ThreadStateSchedulingTest.ScheduleIncrementalV8FollowupGCWhileGCForbidden (1 ms) [281/313] ThreadStateSchedulingTest.RunIncrementalV8FollowupGC (3 ms) [282/313] WorklistTest.SegmentCreate (0 ms) [283/313] WorklistTest.SegmentPush (1 ms) [284/313] WorklistTest.SegmentPushPop (0 ms) [285/313] WorklistTest.SegmentIsEmpty (1 ms) [286/313] WorklistTest.SegmentIsFull (1 ms) [287/313] WorklistTest.SegmentClear (0 ms) [288/313] WorklistTest.SegmentFullPushFails (1 ms) [289/313] WorklistTest.SegmentEmptyPopFails (0 ms) [290/313] WorklistTest.SegmentUpdateFalse (1 ms) [291/313] ObjectStartBitmapTest.SetBitClearBitImpliesEmpty (1 ms) [292/313] ObjectStartBitmapTest.AdjacentObjectsAtBegin (1 ms) [293/313] ObjectStartBitmapTest.AdjacentObjectsAtEnd (1 ms) [294/313] ObjectStartBitmapTest.FindHeaderExact (0 ms) [295/313] ObjectStartBitmapTest.FindHeaderApproximate (0 ms) [296/313] ObjectStartBitmapTest.FindHeaderIteratingWholeBitmap (1 ms) [297/313] ObjectStartBitmapTest.FindHeaderNextCell (0 ms) [298/313] ObjectStartBitmapTest.FindHeaderSameCell (1 ms) [299/313] PersistentTest.BindCancellation (4 ms) [300/313] PersistentTest.CrossThreadBindCancellation (2 ms) [301/313] WorklistTest.SegmentUpdate (0 ms) [302/313] WorklistTest.CreateEmpty (0 ms) [303/313] WorklistTest.LocalPushPop (1 ms) [304/313] WorklistTest.LocalIsBasedOnId (1 ms) [305/313] WorklistTest.LocalPushStaysPrivate (0 ms) [306/313] WorklistTest.GlobalUpdateNull (0 ms) [307/313] WorklistTest.GlobalUpdate (1 ms) [308/313] WorklistTest.FlushToGlobalPushSegme2019-03-18 01:12:42,906:INFO:root:Process exited normally with status code 0. 2019-03-18 01:12:42,907:INFO:root:Terminating kernel log reader. 2019-03-18 01:12:45,499:INFO:root:Shutting down QEMU. nt (0 ms) [309/313] WorklistTest.FlushToGlobalPopSegment (0 ms) [310/313] WorklistTest.Clear (1 ms) [311/313] WorklistTest.SingleSegmentSteal (0 ms) [312/313] WorklistTest.MultipleSegmentsStolen (1 ms) [313/313] WorklistTest.MergeGlobalPool (0 ms) SUCCESS: all tests passed. Tests took 16 seconds. 2019-03-18 01:12:54,254 - root: [DEBUG] Contents of task_output_dir: ['/b/swarming/w/ir/tmp/t/tmpE5BTY_/43a8a99169377910'] 2019-03-18 01:12:54,255 - root: [DEBUG] Found shard_json_files: ['/b/swarming/w/ir/tmp/t/tmpE5BTY_/43a8a99169377910/output.json'] 2019-03-18 01:12:54,255 - root: [INFO] merge_cmd: /b/swarming/w/ir/cache/vpython/ba947a/bin/python /b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py --build-properties {"bot_id": "swarm1860-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1552895072084564, "id": "8918665212852496864", "project": "chromium", "tags": ["build_address:luci.chromium.ci/fuchsia-fyi-x64-dbg/5877", "builder:fuchsia-fyi-x64-dbg", "buildset:commit/git/f7b6b9f521aae8817a449b28b59e3f14649291c0", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7b6b9f521aae8817a449b28b59e3f14649291c0", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9084095275400233088", "scheduler_job_id:chromium/fuchsia-fyi-x64-dbg", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "fuchsia-fyi-x64-dbg", "buildnumber": 5877, "got_angle_revision": "38e282570676f3e434482f8a02ea539b286fd1fa", "got_dawn_revision": "991ab98f113f5f51ec87d767b45523b19cd15b9e", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0", "got_revision_cp": "refs/heads/master@{#641529}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "f413181b62ee4ad78b9ef3d58c4f395794e16bf1", "got_v8_revision_cp": "refs/heads/7.5.59@{#1}", "got_webrtc_revision": "69008a87185992aa348ece3f893f6a84f8786ae8", "got_webrtc_revision_cp": "refs/heads/master@{#27145}", "mastername": "chromium.fyi", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0"} --summary-json /b/swarming/w/ir/tmp/t/tmp5X9XkY.json --task-output-dir /b/swarming/w/ir/tmp/t/tmpE5BTY_ -o /b/swarming/w/ir/tmp/t/tmp61alHm.json /b/swarming/w/ir/tmp/t/tmpE5BTY_/43a8a99169377910/output.json Running ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"bot_id": "swarm1860-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1552895072084564, "id": "8918665212852496864", "project": "chromium", "tags": ["build_address:luci.chromium.ci/fuchsia-fyi-x64-dbg/5877", "builder:fuchsia-fyi-x64-dbg", "buildset:commit/git/f7b6b9f521aae8817a449b28b59e3f14649291c0", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7b6b9f521aae8817a449b28b59e3f14649291c0", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9084095275400233088", "scheduler_job_id:chromium/fuchsia-fyi-x64-dbg", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "fuchsia-fyi-x64-dbg", "buildnumber": 5877, "got_angle_revision": "38e282570676f3e434482f8a02ea539b286fd1fa", "got_dawn_revision": "991ab98f113f5f51ec87d767b45523b19cd15b9e", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0", "got_revision_cp": "refs/heads/master@{#641529}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "f413181b62ee4ad78b9ef3d58c4f395794e16bf1", "got_v8_revision_cp": "refs/heads/7.5.59@{#1}", "got_webrtc_revision": "69008a87185992aa348ece3f893f6a84f8786ae8", "got_webrtc_revision_cp": "refs/heads/master@{#27145}", "mastername": "chromium.fyi", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmp5X9XkY.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpE5BTY_', '-o', '/b/swarming/w/ir/tmp/t/tmp61alHm.json', '/b/swarming/w/ir/tmp/t/tmpE5BTY_/43a8a99169377910/output.json'] in None (env: None) Command ['/b/swarming/w/ir/cache/vpython/ba947a/bin/python', '/b/swarming/w/ir/cache/builder/src/testing/merge_scripts/standard_gtest_merge.py', '--build-properties', '{"bot_id": "swarm1860-c4", "branch": "refs/heads/master", "buildbucket": {"build": {"bucket": "luci.chromium.ci", "created_by": "project:chromium", "created_ts": 1552895072084564, "id": "8918665212852496864", "project": "chromium", "tags": ["build_address:luci.chromium.ci/fuchsia-fyi-x64-dbg/5877", "builder:fuchsia-fyi-x64-dbg", "buildset:commit/git/f7b6b9f521aae8817a449b28b59e3f14649291c0", "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f7b6b9f521aae8817a449b28b59e3f14649291c0", "gitiles_ref:refs/heads/master", "scheduler_invocation_id:9084095275400233088", "scheduler_job_id:chromium/fuchsia-fyi-x64-dbg", "user_agent:luci-scheduler"]}, "hostname": "cr-buildbucket.appspot.com"}, "buildername": "fuchsia-fyi-x64-dbg", "buildnumber": 5877, "got_angle_revision": "38e282570676f3e434482f8a02ea539b286fd1fa", "got_dawn_revision": "991ab98f113f5f51ec87d767b45523b19cd15b9e", "got_nacl_revision": "1ed9878b8eb68c1e0d0268754dafcf83e747fa8f", "got_revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0", "got_revision_cp": "refs/heads/master@{#641529}", "got_swarming_client_revision": "7a61cf37d6a0163f0ec02d495289a1d038e62457", "got_v8_revision": "f413181b62ee4ad78b9ef3d58c4f395794e16bf1", "got_v8_revision_cp": "refs/heads/7.5.59@{#1}", "got_webrtc_revision": "69008a87185992aa348ece3f893f6a84f8786ae8", "got_webrtc_revision_cp": "refs/heads/master@{#27145}", "mastername": "chromium.fyi", "path_config": "generic", "recipe": "chromium", "repository": "https://chromium.googlesource.com/chromium/src.git", "revision": "f7b6b9f521aae8817a449b28b59e3f14649291c0"}', '--summary-json', '/b/swarming/w/ir/tmp/t/tmp5X9XkY.json', '--task-output-dir', '/b/swarming/w/ir/tmp/t/tmpE5BTY_', '-o', '/b/swarming/w/ir/tmp/t/tmp61alHm.json', '/b/swarming/w/ir/tmp/t/tmpE5BTY_/43a8a99169377910/output.json'] returned exit code 0