[ 0] capos kernel starting... [ 0] smp: BSP per-cpu active cpu=0 lapic=0 base=0xffffffff812a9000 syscall_rsp=0xffffffff812b15f0 [ 0] syscall: entry at 0xffffffff805b3984 [ 0] syscall: sqpoll-result mapping proof current_thread_blocked=true thread_owned_head=true thread_owned_head_available=true stale_sq_consumer=true proof_result=ok [ 0] x86_64: GDT + IDT + syscall initialized [ 0] Memory map (19 entries): [ 0] 0x0000000000001000 - 0x0000000000053000 5 [ 0] 0x0000000000053000 - 0x000000000009f000 0 [ 0] 0x000000000009fc00 - 0x00000000000a0000 1 [ 0] 0x00000000000f0000 - 0x0000000000100000 1 [ 0] 0x0000000000100000 - 0x0000000009f74000 0 [ 0] 0x0000000009f74000 - 0x0000000009fc5000 6 [ 0] 0x0000000009fc5000 - 0x0000000009fc6000 5 [ 0] 0x0000000009fc6000 - 0x0000000009fc7000 0 [ 0] 0x0000000009fc7000 - 0x0000000009fc8000 5 [ 0] 0x0000000009fc8000 - 0x0000000009fc9000 0 [ 0] 0x0000000009fc9000 - 0x0000000009fd2000 5 [ 0] 0x0000000009fd2000 - 0x000000000b3c0000 6 [ 0] 0x000000000b3c0000 - 0x000000000ff2d000 5 [ 0] 0x000000000ff2d000 - 0x000000000ff3d000 0 [ 0] 0x000000000ff3d000 - 0x000000000ffe0000 5 [ 0] 0x000000000ffe0000 - 0x0000000010000000 1 [ 0] 0x00000000fd000000 - 0x00000000fd3e8000 7 [ 0] 0x00000000feffc000 - 0x00000000ff000000 1 [ 0] 0x00000000fffc0000 - 0x0000000100000000 1 [ 0] HHDM offset: 0xffff800000000000 [ 0] frame: tracking 65341 frames (158 MB physical), bitmap at 0x53000 (8168 bytes) [ 0] heap: largest free physical run before reservation: 162256 KB (40564 frames) [ 0] heap: 98304 KB across 1 physical runs / 2 allocator regions (14 region slots free) [ 0] mem: frame allocator + heap initialized (16080 usable frames) [ 0] alloc test: [1, 2, 3, 4, 5] [ 0] paging: kernel sections: [ 0] .text: 0xffffffff80000000 - 0xffffffff808bab0f [ 0] .rodata: 0xffffffff808bb000 - 0xffffffff80a37460 [ 0] .data: 0xffffffff80a38000 - 0xffffffff812a8ac0 [ 0] .bss: 0xffffffff812a9000 - 0xffffffff813edf98 [ 0] paging: preseeded kernel PML4 slot 288 for MMIO/firmware mappings [ 0] paging: kernel page tables active (PML4 at 0x6100000) [ 0] smep/smap: CR4.SMEP=1 CR4.SMAP=1 [ 0] lapic: selected mode=LapicMode::X2Apic backend=x2apic-msr [ 0] lapic: BSP x2APIC enabled id=0 [ 0] smp: Limine MP response cpus=1 bsp_lapic=0 [ 0] smp: prepared 0 AP per-cpu slot(s); scheduler handoff pending [ 0] acpi: RSDP phys=0xf5290 rev=0 oem=BOCHS root=RSDT phys=0xffe1c87 [ 0] acpi: RSDT tables=4 MADT=true MCFG=false DMAR=false IVRS=false [ 0] acpi: MADT lapic=0xfee00000 flags=0x1 enabled_lapics=1 io_apics=1 isos=5 [ 0] acpi: MADT IOAPIC[0] id=0 addr=0xfec00000 gsi_base=0 [ 0] acpi: MADT ISO[0] bus=0 source=0 gsi=2 flags=0x0000 [ 0] acpi: MADT ISO[1] bus=0 source=5 gsi=5 flags=0x000d [ 0] acpi: MADT ISO[2] bus=0 source=9 gsi=9 flags=0x000d [ 0] acpi: MADT ISO[3] bus=0 source=10 gsi=10 flags=0x000d [ 0] acpi: MADT ISO 1 additional record(s) omitted [ 0] acpi: MCFG not found [ 0] acpi: DMAR not found [ 0] acpi: IVRS not found [ 0] acpi: IOMMU policy dmar=absent ivrs=absent direct_dma=blocked bounce_buffer=required remapping_domains=unsupported userspace_dmapool=not-started virtio_net=kernel-owned-prototype [ 0] ioapic: mapped id=0 phys=0xfec00000 virt=0xffff90000000b000 gsi_base=0 redirs=24 version=0x11 madt_id=0 [ 0] ioapic: masked 24 redirection entry(s) id=0 [ 0] ioapic: route irq=0 gsi=2 vector=64 masked=true registry_source_id=16 registry_source_generation=1 registry_route_generation=2 [ 0] ioapic: route irq=0 gsi=2 vector=64 masked=true flags=0x0000 [ 0] ioapic: route irq=1 gsi=1 vector=65 masked=true registry_source_id=17 registry_source_generation=3 registry_route_generation=4 [ 0] ioapic: route irq=1 gsi=1 vector=65 masked=true flags=0x0000 [ 0] ioapic: route irq=2 gsi=2 skipped=duplicate_gsi flags=0x0000 [ 0] ioapic: route irq=3 gsi=3 vector=67 masked=true registry_source_id=19 registry_source_generation=5 registry_route_generation=6 [ 0] ioapic: route irq=3 gsi=3 vector=67 masked=true flags=0x0000 [ 0] ioapic: route irq=4 gsi=4 vector=68 masked=true registry_source_id=20 registry_source_generation=7 registry_route_generation=8 [ 0] ioapic: route irq=4 gsi=4 vector=68 masked=true flags=0x0000 [ 0] ioapic: route irq=5 gsi=5 vector=69 masked=true registry_source_id=21 registry_source_generation=9 registry_route_generation=10 [ 0] ioapic: route irq=5 gsi=5 vector=69 masked=true flags=0x000d [ 0] ioapic: route irq=6 gsi=6 vector=70 masked=true registry_source_id=22 registry_source_generation=11 registry_route_generation=12 [ 0] ioapic: route irq=6 gsi=6 vector=70 masked=true flags=0x0000 [ 0] ioapic: route irq=7 gsi=7 vector=71 masked=true registry_source_id=23 registry_source_generation=13 registry_route_generation=14 [ 0] ioapic: route irq=7 gsi=7 vector=71 masked=true flags=0x0000 [ 0] ioapic: route irq=8 gsi=8 vector=72 masked=true registry_source_id=24 registry_source_generation=15 registry_route_generation=16 [ 0] ioapic: route irq=8 gsi=8 vector=72 masked=true flags=0x0000 [ 0] ioapic: route irq=9 gsi=9 vector=73 masked=true registry_source_id=25 registry_source_generation=17 registry_route_generation=18 [ 0] ioapic: route irq=9 gsi=9 vector=73 masked=true flags=0x000d [ 0] ioapic: route irq=10 gsi=10 vector=74 masked=true registry_source_id=26 registry_source_generation=19 registry_route_generation=20 [ 0] ioapic: route irq=10 gsi=10 vector=74 masked=true flags=0x000d [ 0] ioapic: route irq=11 gsi=11 vector=75 masked=true registry_source_id=27 registry_source_generation=21 registry_route_generation=22 [ 0] ioapic: route irq=11 gsi=11 vector=75 masked=true flags=0x000d [ 0] ioapic: route irq=12 gsi=12 vector=76 masked=true registry_source_id=28 registry_source_generation=23 registry_route_generation=24 [ 0] ioapic: route irq=12 gsi=12 vector=76 masked=true flags=0x0000 [ 0] ioapic: route irq=13 gsi=13 vector=77 masked=true registry_source_id=29 registry_source_generation=25 registry_route_generation=26 [ 0] ioapic: route irq=13 gsi=13 vector=77 masked=true flags=0x0000 [ 0] ioapic: route irq=14 gsi=14 vector=78 masked=true registry_source_id=30 registry_source_generation=27 registry_route_generation=28 [ 0] ioapic: route irq=14 gsi=14 vector=78 masked=true flags=0x0000 [ 0] ioapic: route irq=15 gsi=15 vector=79 masked=true registry_source_id=31 registry_source_generation=29 registry_route_generation=30 [ 0] ioapic: route irq=15 gsi=15 vector=79 masked=true flags=0x0000 [ 0] ioapic: routes configured 15 legacy IRQ(s) masked=true [ 0] ioapic: route irq=7 gsi=7 vector=71 masked=false id=0 flags=0x0000 [ 0] ioapic: route irq=7 gsi=7 vector=71 masked=true id=0 flags=0x0000 [ 0] interrupt: route dispatch proof source=legacy-ioapic owner=kernel-ioapic-proof irq=7 gsi=7 source_id=23 source_generation=13 route_generation=14 lapic_vector=71 route_state=claimed-masked masked_delivery=masked masked_dispatch_result=state-mismatch wrong_owner_unmask_result=owner-mismatch unmask_result=ok dispatch_result=delivered dispatch_count_before=0 dispatch_count_after=1 dispatch_count_changed=true mask_result=ok final_masked_delivery=masked final_route_state=claimed-masked proof_result=ok [ 0] pci: ECAM unavailable (no MCFG allocations) [ 0] pci: ECAM enumerated 0 function(s) [ 0] pci: config backend=ecam enumerated 0 function(s) [ 0] pci: dma-attachment policy total_dma_capable=0 retained_printed=0 omitted=0 iommu_attached=0 iommu_covered=0 bounce_buffer_required=0 prototype_bounce_buffer_only=0 direct_dma_trusted_domains=0 remapping_domains=unsupported userspace_dmapool=not-started [ 0] pci: dma-domain policy proof total_dma_capable=0 retained_printed=0 omitted=0 iommu_attached=0 iommu_covered=0 prototype_bounce_buffer_only=0 blocked_direct_dma_devices=0 claimed_device_domain_owner=future-device-manager domain_granularity=per-device-or-trusted-sharing-group trusted_sharing_groups=future direct_dma=blocked bounce_buffer=required exported_device_addresses=iova-only host_physical_user_visible=0 direct_dma_trusted_domains=0 claimed_device_domains_ready=0 remapping_tables=not-programmed remapping_tables_programmed=0 remapping_domains=not-started userspace_dmapool=not-started userspace_devicemmio=not-started userspace_interrupt=not-started prototype_devices=kernel-owned-bounce-buffer-only metadata_status=absent-blocked unsafe_metadata_policy=fail-closed domain_activation=not-started policy=blocked-direct-dma proof_result=ok [ 0] pci: iommu-remapping table-scaffold proof backend=intel-qemu backend_state=disabled disabled_reason=no-dma-capable-pci-function representable=true drhd=absent drhd_index=0 drhd_segment=0 drhd_include_all=false drhd_register_base_user_visible=0 source_segment=0 bdf=00:00.0 source_id=0x0000 domain_id=1 address_width=qemu-intel-aw39 address_width_bits=39 second_level_levels=3 root_entry=representable-disabled context_entry=representable-disabled second_level_root=placeholder root_table_pointer=not-written context_entry_programming=not-written invalidation_registers=not-written fault_registers=not-written protected_memory_registers=not-written invalidation_queue=not-written remapping_tables=not-programmed hardware_programming=not-attempted direct_dma=blocked iova_export=disabled-future-only host_physical_user_visible=0 proof_result=ok [ 0] pci: iommu-remapping mmio-status proof backend=intel-qemu backend_state=disabled disabled_reason=no-dma-capable-pci-function drhd=absent drhd_index=0 drhd_segment=0 drhd_include_all=false drhd_register_base_user_visible=0 chosen_drhd=absent source_segment=0 bdf=00:00.0 source_id=0x0000 address_width=qemu-intel-aw39 address_width_bits=39 mmio_window=not-mapped mmio_read=not-attempted read_result=no-drhd capability_read=unavailable status_read=unavailable fault_status_read=unavailable version_major=0 version_minor=0 cap_mgaw_bits=0 cap_sagaw_mask=0x00 selected_address_width_status=not-read root_table_readiness=not-programmed translation_status=not-read root_table_status=not-read invalidation_readiness=not-installed fault_status_readiness=not-read fault_status=unavailable remapping_tables=not-programmed direct_dma=blocked fallback_policy=kernel-owned-bounce-buffer-only hostile_hardware_isolation=not-claimed fail_closed_reason=no-dma-capable-pci-function proof_result=ok [ 0] pci: nvme metadata backend=legacy-io functions=0 printed=0 print_limit=4 class=01 subclass=08 expected_qemu_prog_if=02 proof_scope=metadata-only-pci-discovery proof_result=not-found [ 0] pci: enumerated 6 function(s) [ 0] pci: virtio-net device not found [ 0] pci: virtio-blk device not found [ 0] virtio-rng: classification=qemu-only-proof-fixture userspace_capability=none production_driver=no role=ddf-metadata-and-iommu-remapping-proof-vehicle entropy_source=rdrand-separate [ 0] pci: virtio-rng device not found [ 0] pci: virtio-9p device not found [ 0] iommu-remapping: fallback proof shape=no-intel-iommu-drhd-for-selected-function fallback_policy=kernel-owned-bounce-buffer-only remapping_tables=not-programmed host_physical_user_visible=0 iova_export=disabled-this-slice hostile_hardware_isolation=not-claimed proof_result=ok [ 0] cap: capability table initialized (3 capabilities: console=0, frame_alloc=1, endpoint=2) [ 0] hardware-audit: snapshot truncation contract proof proof_scope=local-ring-no-live-audit-mutation empty_status=available-records-exhausted empty_returned=0 no_records_status=no-records-requested no_records_returned=0 request_status=request-limited request_returned=2 request_first_sequence=3 available_status=available-records-exhausted available_returned=4 available_available=4 snapshot_status=snapshot-limit-limited snapshot_returned=16 snapshot_first_returned=5 snapshot_last_returned=20 proof_result=ok [ 0] hardware-audit: snapshot cursor contract proof proof_scope=local-ring-no-live-audit-mutation cursor_clamp_start=6 cursor_clamp_first_sequence=7 cursor_clamp_next_sequence=71 cursor_clamp_available=64 cursor_clamp_returned=16 cursor_clamp_first_returned=7 cursor_clamp_last_returned=22 cursor_clamp_status=snapshot-limit-limited past_end_start=78 past_end_first_sequence=71 past_end_next_sequence=71 past_end_available=0 past_end_returned=0 past_end_status=available-records-exhausted proof_result=ok [ 0] hardware-audit: drain reply-failure retry proof proof_scope=local-ring-no-live-audit-mutation failure_injected=reply-scratch retry_expected_sequence=1 retry_first_sequence=1 retry_last_sequence=2 retry_next_sequence=3 proof_result=ok [ 0] nvme: validator selftest model=B scan=on-notify backend=bounce-buffer owner=nvme-storage owner_generation=7 window_base=0x40000000 window_len=0x10000 proof_scope=bounded-hostile-scan-selftest [ 0] nvme: validator accept kind=queue-arm owner=nvme-storage scanned_items=2 doorbell_written=true scan_before_doorbell=ok result=accept proof_result=ok [ 0] nvme: validator accept kind=sq-tail-doorbell owner=nvme-storage scanned_items=2 doorbell_written=true scan_before_doorbell=ok result=accept proof_result=ok [ 0] nvme: validator reject case=out-of-window kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=host-physical kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=cross-owner-alias kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=region-overrun kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=unaligned kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=deep-prp-chain kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator reject case=stale-generation kind=sq-tail-doorbell owner=nvme-storage doorbell_written=false waiter_wake=none result=reject proof_result=ok [ 0] nvme: validator completion submission_validated=true generation_match=true waiter_wake=signal result=ok proof_result=ok [ 0] nvme: validator completion submission_validated=false generation_match=false waiter_wake=none result=ok proof_result=ok [ 0] nvme: validator completion submission_validated=true generation_match=false waiter_wake=none result=ok proof_result=ok [ 0] nvme: validator perf scan=on-notify cost=O(descriptors-per-doorbell) accepts=2 rejects=7 max_scanned_items=2 steady_state_writes=uninstrumented proof_result=ok [ 0] nvme: validator summary model=B accepts=2 rejects=7 doorbell_writes_on_reject=0 waiter_wakes_on_reject=0 hostile_cases=out-of-window,host-physical,cross-owner-alias,region-overrun,unaligned,deep-prp-chain,stale-generation backend=bounce-buffer proof_scope=bounded-hostile-scan-selftest live_doorbell_wiring=nvme-userspace-bind-and-controller-bringup proof_result=ok [ 0] smp: prepared idle kernel stack cpu=0 top=0xffff800006130000 frames=32 [ 0] smp: prepared idle kernel stack cpu=1 top=0xffff800006150000 frames=32 [ 0] smp: prepared idle kernel stack cpu=2 top=0xffff800006170000 frames=32 [ 0] smp: prepared idle kernel stack cpu=3 top=0xffff800006190000 frames=32 [ 0] sched: CPL0 idle context cpu=0 entry=0xffffffff803c4850 kernel_rsp=0xffff800006130000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=1 entry=0xffffffff803c4850 kernel_rsp=0xffff800006150000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=2 entry=0xffffffff803c4850 kernel_rsp=0xffff800006170000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=3 entry=0xffffffff803c4850 kernel_rsp=0xffff800006190000 cs=0x8 ss=0x10 [ 0] sched: prepared 4 CPL0 idle-thread context(s) [ 0] sched: idle process 1 cpu_slot=0 [ 0] pic: remapped to vectors 32-47, all IRQs masked [ 0] lapic: BSP periodic timer vector=48 initial_count=628657 divide=16 calibrated_hz=100 clocksource=tsc-calibrated calibration_ns=10000150 tsc_delta=28113453 [ 0] clockevent: proof backend=lapic oneshot=programmed deadline_ns=14479986 delta_ns=5000000 count=314329 restored_periodic=true tick_suppression=disabled auto_nohz=disabled full_nohz=disabled [ 0] clockevent-fire: backend=lapic fired=true requested_delta_ns=5000000 observed_delta_ns=5078552 count=314329 count_after_program=312673 periodic_initial_count=628657 within_tolerance=true restored_periodic=true periodic_live=true [ 0] clockevent-floor: clocksource=tsc real_ns=5000044 monotonic_delta_ns=5000103 tick_ns=10000000 floored=false subtick_tracked=true [ 0] smp: no AP slots prepared; AP bootstrap skipped [ 0] manifest: loaded 331584 bytes from boot module [ 0] manifest: initConfig handoff, 3 binaries [ 0] manifest: logLevel=debug [ 0] cpu-isolation: declared-pools source=kernel-default count=2 default_pool_id=0 nondefault_pool_id=1 nondefault_pool_cpu_mask=0x2 [ 0] cpu-isolation: pool-grants source=kernel-default count=1 default_bound_account_id=7 default_bound_pool_id=1 [ 0] cpu-isolation: grant-minter-allowlist source=empty count=0 [ 0] dma: backend selection dma_backend=bounce-buffer dma_backend_override=absent probe_verified_usable_iommu=false [ 0] cloudboot-evidence: dma-backend bounce_buffer [ 0] pci: enumeration source=legacy-io validated_mcfg_allocations=0 [ 0] cloudboot-evidence: enumeration-source legacy-io [ 0] cloudboot-evidence: device-class 0x01 [ 0] cloudboot-evidence: device-class 0x02 [ 0] cloudboot-evidence: device-class 0x03 [ 0] cloudboot-evidence: device-class 0x06 [ 0] pci-inventory: 0000:00:00.0 vendor=0x8086 device=0x1237 class=06 subclass=00 prog_if=00 revision=02 header=00 interrupt_pin=0 interrupt_line=0 [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.00.0-8086.1237-06.00.00-rev.02-hdr.00-irq.0.0 [ 0] cloudboot-evidence: capability-walk 0000.00.00.0-8086.1237-walk.no-capability-list-caps.0 [ 0] pci-inventory: 0000:00:01.0 vendor=0x8086 device=0x7000 class=06 subclass=01 prog_if=00 revision=00 header=80 interrupt_pin=0 interrupt_line=0 [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.01.0-8086.7000-06.01.00-rev.00-hdr.80-irq.0.0 [ 0] cloudboot-evidence: capability-walk 0000.00.01.0-8086.7000-walk.no-capability-list-caps.0 [ 0] pci-inventory: 0000:00:01.1 vendor=0x8086 device=0x7010 class=01 subclass=01 prog_if=80 revision=00 header=00 interrupt_pin=0 interrupt_line=0 [ 0] pci-inventory: BAR4 io base=0xc040 prefetchable=false [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.01.1-8086.7010-01.01.80-rev.00-hdr.00-irq.0.0-b4.io.base.c040 [ 0] cloudboot-evidence: capability-walk 0000.00.01.1-8086.7010-walk.no-capability-list-caps.0 [ 0] pci-inventory: 0000:00:01.3 vendor=0x8086 device=0x7113 class=06 subclass=80 prog_if=00 revision=03 header=00 interrupt_pin=1 interrupt_line=9 [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.01.3-8086.7113-06.80.00-rev.03-hdr.00-irq.1.9 [ 0] cloudboot-evidence: capability-walk 0000.00.01.3-8086.7113-walk.no-capability-list-caps.0 [ 0] pci-inventory: 0000:00:02.0 vendor=0x1234 device=0x1111 class=03 subclass=00 prog_if=00 revision=02 header=00 interrupt_pin=0 interrupt_line=0 [ 0] pci-inventory: BAR0 mem32 base=0xfd000000 prefetchable=true [ 0] pci-inventory: BAR2 mem32 base=0xfebb0000 prefetchable=false [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.02.0-1234.1111-03.00.00-rev.02-hdr.00-irq.0.0-b0.m32p.base.fd000000-b2.m32.base.febb0000 [ 0] cloudboot-evidence: capability-walk 0000.00.02.0-1234.1111-walk.no-capability-list-caps.0 [ 0] pci-inventory: 0000:00:03.0 vendor=0x8086 device=0x100e class=02 subclass=00 prog_if=00 revision=03 header=00 interrupt_pin=1 interrupt_line=11 [ 0] pci-inventory: BAR0 mem32 base=0xfeb80000 prefetchable=false [ 0] pci-inventory: BAR1 io base=0xc000 prefetchable=false [ 0] pci-inventory: capability-walk outcome=no-capability-list caps=0 [ 0] cloudboot-evidence: device-inventory 0000.00.03.0-8086.100e-02.00.00-rev.03-hdr.00-irq.1.11-b0.m32.base.feb80000-b1.io.base.c000 [ 0] cloudboot-evidence: capability-walk 0000.00.03.0-8086.100e-walk.no-capability-list-caps.0 [ 0] manifest: booting init from initConfig only [ 0] manifest: init 'init' is the reserved embedded identity; loading PID 1 from kernel INIT_ELF (737600 bytes) [ 0] binary 'init': 737600 bytes, entry 0x218af0, 3 segments [ 0] cap: service 'init' granted 'console' (source=kernel:console) -> cap_id=0 [ 0] cap: service 'init' granted 'boot' (source=kernel:boot_package) -> cap_id=1 [ 0] cap: service 'init' granted 'spawner' (source=kernel:process_spawner) -> cap_id=2 [ 0] heap: after boot caps: used=21457 KiB free=76846 KiB [ 0] proc: created process 2 for service 'init' (binary='init', 3 caps) [ 0] sched: added process 2 [ 0] sched: BSP cpu=0 starting thread 2:1 [init] Hello from capos-rt init skeleton. [init] BootPackage manifest graph validation ok. [ 5] proc: spawned process 3 for request 'ring-nop' (binary='ring-nop', 4 caps) [ 5] proc: process 3 session context profile='system' for request 'ring-nop' [ 5] sched: added process 3 [ 6] sched: switch 2:1 -> 3:1 [ 7] pid=3 invalid submission err=-1 opcode=5 cap_id_bucket=0 cause=structural [ 7] pid=3 invalid submission err=-1 opcode=5 cap_id_bucket=0 cause=structural [ 8] pid=3 invalid submission err=-1 opcode=5 cap_id_bucket=0 cause=structural [ 8] pid=3 invalid submission err=-2 opcode=0 cap_id_bucket=0 cause=structural [ 9] pid=3 invalid submission err=-3 opcode=0 cap_id_bucket=0 cause=structural [ 9] ring: failed to serialize CapException into result buffer: Failed: result buffer too small [ 10] pid=3 invalid submission err=-2 opcode=0 cap_id_bucket=0 cause=structural [ 11] pid=3 invalid submission err=-4 opcode=0 cap_id_bucket=4294967295 cause=cap-not-found [ 11] pid=3 invalid submission err=-4 opcode=1 cap_id_bucket=0 cause=cap-invoke-error [ring-nop] CAP_OP_NOP smoke ok. [ring-nop] measure avg cycles: nop=32436 null_empty=37741 null_small=43922 [ 13] sched: switch 3:1 -> 2:1 [ 13] proc: spawned process 4 for request 'thread-lifecycle' (binary='thread-lifecycle', 8 caps) [ 13] proc: process 4 session context profile='system' for request 'thread-lifecycle' [ 13] sched: added process 4 [ 14] sched: switch 2:1 -> 4:1 [ 15] sched: switch 4:1 -> 4:2 [ 17] sched: switch 4:2 -> 4:1 [ 18] sched: switch 4:1 -> 4:2 [ 19] sched: switch 4:2 -> 3:1 [ 20] sched: switch 3:1 -> 4:1 [ 20] sched: blocked 4:1 -> 4:2 [ 21] sched: switch 4:2 -> 4:1 [ 21] sched: blocked 4:1 -> 4:2 [ 21] sched: switch to 4:1 [ 22] sched: off-stack thread stack release pid=4 tid=2 reason=thread-exit proof_result=ok [ 22] sched: switch 4:1 -> 3:1 [ 23] sched: switch 3:1 -> 4:1 [ 24] sched: switch 4:1 -> 4:3 [ 24] sched: switch to 3:1 [ 25] sched: off-stack thread stack release pid=4 tid=3 reason=thread-exit proof_result=ok [ 25] sched: switch 3:1 -> 4:1 [ 26] sched: switch 4:1 -> 4:4 [ 28] sched: switch 4:4 -> 4:1 [ 29] sched: switch 4:1 -> 4:4 [ 30] sched: switch 4:4 -> 3:1 [ 31] sched: switch 3:1 -> 4:1 [ 31] sched: blocked 4:1 -> 4:4 [ 32] sched: switch 4:4 -> 4:1 [ 33] sched: switch 4:1 -> 3:1 [ 34] sched: switch 3:1 -> 4:4 [ 34] sched: blocked 4:4 -> 4:1 [ 35] sched: switch 4:1 -> 4:4 [ 35] sched: switch to 3:1 [ 36] sched: off-stack thread stack release pid=4 tid=4 reason=thread-exit proof_result=ok [ 36] sched: switch 3:1 -> 4:1 [thread-lifecycle] park handoff wake retry ok. [ 38] sched: switch 4:1 -> 4:6 [ 38] sched: blocked 4:6 -> 4:5 [ 38] sched: blocked 4:5 -> 3:1 [ 39] sched: switch 3:1 -> 2:1 [ 39] proc: spawned process 5 for request 'unprivileged-stranger' (binary='unprivileged-stranger', 0 caps) [ 39] proc: process 5 session context profile='system' for request 'unprivileged-stranger' [ 39] sched: added process 5 [ 40] sched: switch 2:1 -> 5:1 [ 40] syscall: unknown syscall 0 [ 40] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 41] sched: switch 5:1 -> 4:1 [ 41] sched: blocked 4:1 -> 5:1 [ 41] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 42] sched: switch 5:1 -> 3:1 [ 44] sched: switch 3:1 -> 4:1 [ 45] sched: switch 4:1 -> 4:5 [ 45] sched: switch to 4:6 [ 45] sched: off-stack thread stack release pid=4 tid=5 reason=thread-exit proof_result=ok [ 45] sched: switch to 5:1 [ 46] sched: off-stack thread stack release pid=4 tid=6 reason=thread-exit proof_result=ok [ 46] sched: switch 5:1 -> 4:1 [ 48] sched: switch 4:1 -> 4:8 [ 48] sched: blocked 4:8 -> 4:7 [ 48] sched: blocked 4:7 -> 3:1 [ring-nop] park bench avg cycles: compact_wait_miss=35916 generic_wait_miss=4893122 compact_wake_empty=1030433 generic_wake_empty=8350758 [ 49] sched: switch 3:1 -> 5:1 [ 49] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 50] sched: switch 5:1 -> 4:1 [ 50] sched: blocked 4:1 -> 5:1 [ 50] sched: process_cpu_accounting pid=5 runtime_ns=40159158 context_switches=5 [ 50] proc: process 5 exited with code 0 [ 50] sched: switch to 3:1 [ 51] sched: off-stack process stack release pid=5 stacks=1 reason=deferred-process-drop proof_result=ok [ 51] sched: switch 3:1 -> 4:1 [ 53] sched: switch 4:1 -> 4:7 [ 53] sched: switch to 4:8 [ 53] sched: off-stack thread stack release pid=4 tid=7 reason=thread-exit proof_result=ok [ 53] sched: switch to 3:1 [ 54] sched: off-stack thread stack release pid=4 tid=8 reason=thread-exit proof_result=ok [ 54] sched: switch 3:1 -> 4:1 [thread-lifecycle] park multi-waiter unmap reuse cleanup ok. [ 56] sched: switch 4:1 -> 4:9 [ 58] sched: switch 4:9 -> 3:1 [ 58] sched: process_cpu_accounting pid=3 runtime_ns=178036952 context_switches=20 [ 58] proc: process 3 exited with code 0 [ 58] sched: switch to 4:1 [ 59] sched: off-stack process stack release pid=3 stacks=1 reason=deferred-process-drop proof_result=ok [ 59] sched: switch 4:1 -> 4:9 [ 60] sched: switch 4:9 -> 2:1 [init] Generic manifest child wait ok: unprivileged-stranger [ 60] sched: blocked 2:1 -> 4:9 [ 62] sched: switch 4:9 -> 4:1 [ 63] sched: switch 4:1 -> 4:9 [ 63] sched: blocked 4:9 -> 4:1 [ 63] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 63] sched: blocked 4:1 -> 1:1 [ 64] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=1 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 65] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=2 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 66] sched: cpl0-idle cpu=0 starting thread 4:1 [ 67] sched: switch 4:1 -> 4:9 [ 67] sched: switch to 4:1 [ 68] sched: off-stack thread stack release pid=4 tid=9 reason=thread-exit proof_result=ok [ 68] sched: switch 4:1 -> 4:10 [ 68] sched: blocked 4:10 -> 4:1 [ 69] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 69] sched: blocked 4:1 -> 1:1 [ 69] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=3 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 70] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=4 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 71] sched: cpl0-idle cpu=0 starting thread 4:1 [ 73] sched: switch 4:1 -> 4:10 [ 73] sched: switch to 4:1 [thread-lifecycle] park unmap/decommit/memoryobject cleanup ok. [ 74] sched: off-stack thread stack release pid=4 tid=10 reason=thread-exit proof_result=ok [ 75] sched: switch 4:1 -> 4:11 [ 75] sched: blocked 4:11 -> 4:1 [ 75] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 75] sched: blocked 4:1 -> 1:1 [ 76] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=5 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 77] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=6 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 78] sched: cpl0-idle cpu=0 starting thread 4:1 [ 79] sched: switch 4:1 -> 4:11 [ 82] sched: switch 4:11 -> 4:1 [ 83] sched: switch 4:1 -> 4:11 [ 83] sched: blocked 4:11 -> 4:1 [ 83] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 83] sched: blocked 4:1 -> 1:1 [ 84] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=7 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 85] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=8 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 86] sched: cpl0-idle cpu=0 starting thread 4:1 [ 87] sched: switch 4:1 -> 4:11 [ 89] sched: switch 4:11 -> 4:1 [ 90] sched: switch 4:1 -> 4:11 [ 90] sched: blocked 4:11 -> 4:1 [ 90] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 90] sched: blocked 4:1 -> 1:1 [ 93] sched: cpl0-idle cpu=0 starting thread 4:1 [ 94] sched: switch 4:1 -> 4:11 [ 96] sched: switch 4:11 -> 4:1 [ 97] sched: switch 4:1 -> 4:11 [ 97] sched: blocked 4:11 -> 4:1 [ 97] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 97] sched: blocked 4:1 -> 1:1 [ 100] sched: cpl0-idle cpu=0 starting thread 4:1 [ 101] sched: switch 4:1 -> 4:11 [ 103] sched: switch 4:11 -> 4:1 [ 104] sched: switch 4:1 -> 4:11 [ 104] sched: blocked 4:11 -> 4:1 [ 104] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 104] sched: blocked 4:1 -> 1:1 [ 107] sched: cpl0-idle cpu=0 starting thread 4:1 [ 108] sched: switch 4:1 -> 4:11 [ 110] sched: switch 4:11 -> 4:1 [ 111] sched: switch 4:1 -> 4:11 [ 111] sched: blocked 4:11 -> 4:1 [ 111] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 111] sched: blocked 4:1 -> 1:1 [ 114] sched: cpl0-idle cpu=0 starting thread 4:1 [ 115] sched: switch 4:1 -> 4:11 [ 115] sched: switch to 4:1 [thread-lifecycle] park path avg cycles: failed_wait=241377 empty_wake=228654 wait_to_block=87206517 wake_to_runnable=405714 wake_to_resume=25396064 [ 116] sched: off-stack thread stack release pid=4 tid=11 reason=thread-exit proof_result=ok [ 117] sched: blocked 4:1 -> 4:12 [ 117] sched: blocked 4:12 -> 4:1 [ 117] sched: blocked 4:1 -> 4:12 [ 118] sched: blocked 4:12 -> 4:1 [ 118] sched: blocked 4:1 -> 4:12 [ 118] sched: blocked 4:12 -> 4:1 [ 119] sched: blocked 4:1 -> 4:12 [ 119] sched: blocked 4:12 -> 4:1 [ 119] sched: blocked 4:1 -> 4:12 [ 119] sched: blocked 4:12 -> 4:1 [ 120] sched: blocked 4:1 -> 4:12 [ 120] sched: blocked 4:12 -> 4:1 [ 120] sched: blocked 4:1 -> 4:12 [ 121] sched: blocked 4:12 -> 4:1 [ 121] sched: blocked 4:1 -> 4:12 [ 121] sched: blocked 4:12 -> 4:1 [ 121] sched: blocked 4:1 -> 4:12 [ 122] sched: blocked 4:12 -> 4:1 [ 122] sched: blocked 4:1 -> 4:12 [ 122] sched: blocked 4:12 -> 4:1 [ 123] sched: blocked 4:1 -> 4:12 [ 123] sched: blocked 4:12 -> 4:1 [ 123] sched: blocked 4:1 -> 4:12 [ 123] sched: blocked 4:12 -> 4:1 [ 124] sched: blocked 4:1 -> 4:12 [ 124] sched: blocked 4:12 -> 4:1 [ 124] sched: blocked 4:1 -> 4:12 [ 125] sched: blocked 4:12 -> 4:1 [ 125] sched: blocked 4:1 -> 4:12 [ 125] sched: blocked 4:12 -> 4:1 [ 125] sched: blocked 4:1 -> 4:12 [ 126] sched: blocked 4:12 -> 4:1 [ 126] sched: blocked 4:1 -> 4:12 [ 126] sched: blocked 4:12 -> 4:1 [ 126] sched: blocked 4:1 -> 4:12 [ 127] sched: blocked 4:12 -> 4:1 [ 127] sched: blocked 4:1 -> 4:12 [ 127] sched: blocked 4:12 -> 4:1 [ 128] sched: blocked 4:1 -> 4:12 [ 128] sched: blocked 4:12 -> 4:1 [ 128] sched: blocked 4:1 -> 4:12 [ 128] sched: blocked 4:12 -> 4:1 [ 129] sched: blocked 4:1 -> 4:12 [ 129] sched: blocked 4:12 -> 4:1 [ 129] sched: blocked 4:1 -> 4:12 [ 130] sched: blocked 4:12 -> 4:1 [ 130] sched: blocked 4:1 -> 4:12 [ 130] sched: blocked 4:12 -> 4:1 [ 130] sched: blocked 4:1 -> 4:12 [ 131] sched: blocked 4:12 -> 4:1 [ 131] sched: blocked 4:1 -> 4:12 [ 131] sched: blocked 4:12 -> 4:1 [ 132] sched: blocked 4:1 -> 4:12 [ 132] sched: blocked 4:12 -> 4:1 [ 132] sched: blocked 4:1 -> 4:12 [ 132] sched: blocked 4:12 -> 4:1 [ 133] sched: blocked 4:1 -> 4:12 [ 133] sched: blocked 4:12 -> 4:1 [ 133] sched: blocked 4:1 -> 4:12 [ 134] sched: blocked 4:12 -> 4:1 [ 134] sched: blocked 4:1 -> 4:12 [ 134] sched: blocked 4:12 -> 4:1 [ 134] sched: blocked 4:1 -> 4:12 [ 135] sched: blocked 4:12 -> 4:1 [ 135] sched: blocked 4:1 -> 4:12 [ 135] sched: blocked 4:12 -> 4:1 [ 135] sched: blocked 4:1 -> 4:12 [ 136] sched: blocked 4:12 -> 4:1 [ 136] sched: blocked 4:1 -> 4:12 [ 136] sched: blocked 4:12 -> 4:1 [ 137] sched: blocked 4:1 -> 4:12 [ 137] sched: blocked 4:12 -> 4:1 [ 137] sched: blocked 4:1 -> 4:12 [ 138] sched: blocked 4:12 -> 4:1 [ 138] sched: blocked 4:1 -> 4:12 [ 138] sched: blocked 4:12 -> 4:1 [ 138] sched: blocked 4:1 -> 4:12 [ 139] sched: blocked 4:12 -> 4:1 [ 139] sched: blocked 4:1 -> 4:12 [ 139] sched: blocked 4:12 -> 4:1 [ 139] sched: blocked 4:1 -> 4:12 [ 140] sched: blocked 4:12 -> 4:1 [ 140] sched: blocked 4:1 -> 4:12 [ 140] sched: blocked 4:12 -> 4:1 [ 141] sched: blocked 4:1 -> 4:12 [ 141] sched: blocked 4:12 -> 4:1 [ 141] sched: blocked 4:1 -> 4:12 [ 141] sched: blocked 4:12 -> 4:1 [ 142] sched: blocked 4:1 -> 4:12 [ 142] sched: blocked 4:12 -> 4:1 [ 142] sched: blocked 4:1 -> 4:12 [ 143] sched: blocked 4:12 -> 4:1 [ 143] sched: blocked 4:1 -> 4:12 [ 143] sched: blocked 4:12 -> 4:1 [ 143] sched: blocked 4:1 -> 4:12 [ 144] sched: blocked 4:12 -> 4:1 [ 144] sched: blocked 4:1 -> 4:12 [ 144] sched: blocked 4:12 -> 4:1 [ 145] sched: blocked 4:1 -> 4:12 [ 145] sched: blocked 4:12 -> 4:1 [ 145] sched: blocked 4:1 -> 4:12 [ 145] sched: blocked 4:12 -> 4:1 [ 146] sched: blocked 4:1 -> 4:12 [ 146] sched: blocked 4:12 -> 4:1 [ 146] sched: blocked 4:1 -> 4:12 [ 147] sched: blocked 4:12 -> 4:1 [ 147] sched: blocked 4:1 -> 4:12 [ 147] sched: blocked 4:12 -> 4:1 [ 147] sched: blocked 4:1 -> 4:12 [ 148] sched: blocked 4:12 -> 4:1 [ 148] sched: blocked 4:1 -> 4:12 [ 148] sched: blocked 4:12 -> 4:1 [ 148] sched: blocked 4:1 -> 4:12 [ 149] sched: blocked 4:12 -> 4:1 [ 149] sched: blocked 4:1 -> 4:12 [ 149] sched: blocked 4:12 -> 4:1 [ 150] sched: blocked 4:1 -> 4:12 [ 150] sched: blocked 4:12 -> 4:1 [ 150] sched: blocked 4:1 -> 4:12 [ 150] sched: blocked 4:12 -> 4:1 [ 151] sched: blocked 4:1 -> 4:12 [ 151] sched: blocked 4:12 -> 4:1 [ 151] sched: blocked 4:1 -> 4:12 [ 152] sched: blocked 4:12 -> 4:1 [ 152] sched: blocked 4:1 -> 4:12 [ 152] sched: blocked 4:12 -> 4:1 [ 152] sched: blocked 4:1 -> 4:12 [ 153] sched: blocked 4:12 -> 4:1 [ 153] sched: blocked 4:1 -> 4:12 [ 153] sched: blocked 4:12 -> 4:1 [ 154] sched: blocked 4:1 -> 4:12 [ 154] sched: blocked 4:12 -> 4:1 [ 154] sched: blocked 4:1 -> 4:12 [ 154] sched: blocked 4:12 -> 4:1 [ 155] sched: blocked 4:1 -> 4:12 [ 155] sched: blocked 4:12 -> 4:1 [ 155] sched: blocked 4:1 -> 4:12 [ 155] sched: blocked 4:12 -> 4:1 [ 156] sched: blocked 4:1 -> 4:12 [ 156] sched: blocked 4:12 -> 4:1 [ 156] sched: blocked 4:1 -> 4:12 [ 157] sched: blocked 4:12 -> 4:1 [ 157] sched: blocked 4:1 -> 4:12 [ 157] sched: switch to 4:1 [thread-lifecycle] endpoint CALL-to-receiver avg cycles: 7902385 [ 158] sched: off-stack thread stack release pid=4 tid=12 reason=thread-exit proof_result=ok [thread-lifecycle] thread lifecycle checkpoint ok. [ 159] sched: process_cpu_accounting pid=4 runtime_ns=1029836185 context_switches=286 [ 159] proc: process 4 exited with code 0 [ 159] sched: switch to 2:1 [ 160] sched: off-stack process stack release pid=4 stacks=1 reason=deferred-process-drop proof_result=ok [init] Generic manifest child wait ok: thread-lifecycle [init] Generic manifest child wait ok: ring-nop [init] Generic manifest spawn loop ok. [ 162] proc: spawned process 6 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 162] proc: process 6 session context profile='system' for request 'cap-slot-leak' [ 162] sched: added process 6 [ 163] sched: switch 2:1 -> 6:1 [ 163] syscall: unknown syscall 0 [ 163] pid=6 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 164] pid=6 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 164] pid=6 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 165] sched: process_cpu_accounting pid=6 runtime_ns=20576180 context_switches=3 [ 165] proc: process 6 exited with code 0 [ 165] sched: switch to 2:1 [ 166] sched: off-stack process stack release pid=6 stacks=1 reason=deferred-process-drop proof_result=ok [ 166] proc: spawned process 7 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 166] proc: process 7 session context profile='system' for request 'cap-slot-leak' [ 166] sched: added process 7 [ 167] sched: switch 2:1 -> 7:1 [ 167] syscall: unknown syscall 0 [ 167] pid=7 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 168] pid=7 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 168] pid=7 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 169] sched: process_cpu_accounting pid=7 runtime_ns=20416333 context_switches=3 [ 169] proc: process 7 exited with code 0 [ 169] sched: switch to 2:1 [ 170] sched: off-stack process stack release pid=7 stacks=1 reason=deferred-process-drop proof_result=ok [ 171] proc: spawned process 8 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 171] proc: process 8 session context profile='system' for request 'cap-slot-leak' [ 171] sched: added process 8 [ 172] sched: switch 2:1 -> 8:1 [ 173] syscall: unknown syscall 0 [ 173] pid=8 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 173] pid=8 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 174] pid=8 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 174] sched: process_cpu_accounting pid=8 runtime_ns=20507161 context_switches=3 [ 174] proc: process 8 exited with code 0 [ 174] sched: switch to 2:1 [ 175] sched: off-stack process stack release pid=8 stacks=1 reason=deferred-process-drop proof_result=ok [ 176] proc: spawned process 9 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 176] proc: process 9 session context profile='system' for request 'cap-slot-leak' [ 176] sched: added process 9 [ 177] sched: switch 2:1 -> 9:1 [ 177] syscall: unknown syscall 0 [ 177] pid=9 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 178] pid=9 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 178] pid=9 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 179] sched: process_cpu_accounting pid=9 runtime_ns=20485235 context_switches=3 [ 179] proc: process 9 exited with code 0 [ 179] sched: switch to 2:1 [ 180] sched: off-stack process stack release pid=9 stacks=1 reason=deferred-process-drop proof_result=ok [ 180] proc: spawned process 10 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 180] proc: process 10 session context profile='system' for request 'cap-slot-leak' [ 180] sched: added process 10 [ 181] sched: switch 2:1 -> 10:1 [ 181] syscall: unknown syscall 0 [ 181] pid=10 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 182] pid=10 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 183] pid=10 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 183] sched: process_cpu_accounting pid=10 runtime_ns=20737567 context_switches=3 [ 183] proc: process 10 exited with code 0 [ 183] sched: switch to 2:1 [ 184] sched: off-stack process stack release pid=10 stacks=1 reason=deferred-process-drop proof_result=ok [ 185] proc: spawned process 11 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 185] proc: process 11 session context profile='system' for request 'cap-slot-leak' [ 185] sched: added process 11 [ 186] sched: switch 2:1 -> 11:1 [ 187] syscall: unknown syscall 0 [ 187] pid=11 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 187] sched: process_cpu_accounting pid=11 runtime_ns=10261095 context_switches=2 [ 187] proc: process 11 exited with code 0 [ 187] pid=11 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 187] sched: switch to 2:1 [ 188] sched: off-stack process stack release pid=11 stacks=1 reason=deferred-process-drop proof_result=ok [ 189] proc: spawned process 12 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 189] proc: process 12 session context profile='system' for request 'cap-slot-leak' [ 189] sched: added process 12 [ 190] sched: switch 2:1 -> 12:1 [ 191] syscall: unknown syscall 0 [ 191] sched: process_cpu_accounting pid=12 runtime_ns=5169667 context_switches=2 [ 191] proc: process 12 exited with code 0 [ 191] pid=12 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 191] sched: switch to 2:1 [ 192] sched: off-stack process stack release pid=12 stacks=1 reason=deferred-process-drop proof_result=ok [ 192] proc: spawned process 13 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 192] proc: process 13 session context profile='system' for request 'cap-slot-leak' [ 192] sched: added process 13 [ 193] sched: switch 2:1 -> 13:1 [ 193] syscall: unknown syscall 0 [ 193] sched: process_cpu_accounting pid=13 runtime_ns=4896679 context_switches=1 [ 193] proc: process 13 exited with code 0 [ 193] pid=13 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 193] sched: switch to 2:1 [ 194] sched: off-stack process stack release pid=13 stacks=1 reason=deferred-process-drop proof_result=ok [ 195] proc: spawned process 14 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 195] proc: process 14 session context profile='system' for request 'cap-slot-leak' [ 195] sched: added process 14 [ 196] sched: switch 2:1 -> 14:1 [ 197] syscall: unknown syscall 0 [ 197] sched: process_cpu_accounting pid=14 runtime_ns=5254058 context_switches=2 [ 197] proc: process 14 exited with code 0 [ 197] pid=14 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 197] sched: switch to 2:1 [ 198] sched: off-stack process stack release pid=14 stacks=1 reason=deferred-process-drop proof_result=ok [ 198] proc: spawned process 15 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 198] proc: process 15 session context profile='system' for request 'cap-slot-leak' [ 198] sched: added process 15 [ 199] sched: switch 2:1 -> 15:1 [ 199] syscall: unknown syscall 0 [ 199] sched: process_cpu_accounting pid=15 runtime_ns=4960118 context_switches=1 [ 199] proc: process 15 exited with code 0 [ 199] pid=15 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 199] sched: switch to 2:1 [ 200] sched: off-stack process stack release pid=15 stacks=1 reason=deferred-process-drop proof_result=ok [ 201] proc: spawned process 16 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 201] proc: process 16 session context profile='system' for request 'cap-slot-leak' [ 201] sched: added process 16 [ 202] sched: switch 2:1 -> 16:1 [ 203] syscall: unknown syscall 0 [ 203] sched: process_cpu_accounting pid=16 runtime_ns=5271792 context_switches=2 [ 203] proc: process 16 exited with code 0 [ 203] pid=16 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 203] sched: switch to 2:1 [ 204] sched: off-stack process stack release pid=16 stacks=1 reason=deferred-process-drop proof_result=ok [ 204] proc: spawned process 17 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 204] proc: process 17 session context profile='system' for request 'cap-slot-leak' [ 204] sched: added process 17 [ 205] sched: switch 2:1 -> 17:1 [ 205] syscall: unknown syscall 0 [ 206] sched: process_cpu_accounting pid=17 runtime_ns=5249916 context_switches=2 [ 206] proc: process 17 exited with code 0 [ 206] pid=17 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 206] sched: switch to 2:1 [ 207] sched: off-stack process stack release pid=17 stacks=1 reason=deferred-process-drop proof_result=ok [ 208] proc: spawned process 18 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 208] proc: process 18 session context profile='system' for request 'cap-slot-leak' [ 208] sched: added process 18 [ 209] sched: switch 2:1 -> 18:1 [ 209] syscall: unknown syscall 0 [ 209] sched: process_cpu_accounting pid=18 runtime_ns=4927725 context_switches=1 [ 209] proc: process 18 exited with code 0 [ 209] pid=18 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 209] sched: switch to 2:1 [ 210] sched: off-stack process stack release pid=18 stacks=1 reason=deferred-process-drop proof_result=ok [ 211] proc: spawned process 19 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 211] proc: process 19 session context profile='system' for request 'cap-slot-leak' [ 211] sched: added process 19 [ 212] sched: switch 2:1 -> 19:1 [ 212] syscall: unknown syscall 0 [ 212] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 213] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 213] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 214] sched: process_cpu_accounting pid=19 runtime_ns=20973057 context_switches=3 [ 214] proc: process 19 exited with code 0 [ 214] sched: switch to 2:1 [ 215] sched: off-stack process stack release pid=19 stacks=1 reason=deferred-process-drop proof_result=ok [ 216] proc: spawned process 20 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 216] proc: process 20 session context profile='system' for request 'cap-slot-leak' [ 216] sched: added process 20 [ 217] sched: switch 2:1 -> 20:1 [ 218] syscall: unknown syscall 0 [ 218] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 219] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 219] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 220] sched: process_cpu_accounting pid=20 runtime_ns=21276512 context_switches=4 [ 220] proc: process 20 exited with code 0 [ 220] sched: switch to 2:1 [ 221] sched: off-stack process stack release pid=20 stacks=1 reason=deferred-process-drop proof_result=ok [ 221] proc: spawned process 21 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 221] proc: process 21 session context profile='system' for request 'cap-slot-leak' [ 221] sched: added process 21 [ 222] sched: switch 2:1 -> 21:1 [ 222] syscall: unknown syscall 0 [ 223] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 223] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 224] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 224] sched: process_cpu_accounting pid=21 runtime_ns=21274453 context_switches=3 [ 224] proc: process 21 exited with code 0 [ 224] sched: switch to 2:1 [ 225] sched: off-stack process stack release pid=21 stacks=1 reason=deferred-process-drop proof_result=ok [ 226] proc: spawned process 22 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 226] proc: process 22 session context profile='system' for request 'cap-slot-leak' [ 226] sched: added process 22 [ 227] sched: switch 2:1 -> 22:1 [ 227] syscall: unknown syscall 0 [ 227] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 228] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 229] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 229] sched: process_cpu_accounting pid=22 runtime_ns=20964916 context_switches=3 [ 229] proc: process 22 exited with code 0 [ 229] sched: switch to 2:1 [ 230] sched: off-stack process stack release pid=22 stacks=1 reason=deferred-process-drop proof_result=ok [ 231] proc: spawned process 23 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 231] proc: process 23 session context profile='system' for request 'cap-slot-leak' [ 231] sched: added process 23 [ 232] sched: switch 2:1 -> 23:1 [ 232] syscall: unknown syscall 0 [ 232] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 233] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 233] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 234] sched: process_cpu_accounting pid=23 runtime_ns=21213606 context_switches=3 [ 234] proc: process 23 exited with code 0 [ 234] sched: switch to 2:1 [ 235] sched: off-stack process stack release pid=23 stacks=1 reason=deferred-process-drop proof_result=ok [ 236] proc: spawned process 24 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 236] proc: process 24 session context profile='system' for request 'cap-slot-leak' [ 236] sched: added process 24 [ 237] sched: switch 2:1 -> 24:1 [ 237] syscall: unknown syscall 0 [ 237] pid=24 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 238] sched: process_cpu_accounting pid=24 runtime_ns=10345824 context_switches=2 [ 238] proc: process 24 exited with code 0 [ 238] pid=24 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 238] sched: switch to 2:1 [ 239] sched: off-stack process stack release pid=24 stacks=1 reason=deferred-process-drop proof_result=ok [ 240] proc: spawned process 25 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 240] proc: process 25 session context profile='system' for request 'cap-slot-leak' [ 240] sched: added process 25 [ 241] sched: switch 2:1 -> 25:1 [ 241] syscall: unknown syscall 0 [ 241] sched: process_cpu_accounting pid=25 runtime_ns=4898703 context_switches=1 [ 241] proc: process 25 exited with code 0 [ 241] pid=25 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 241] sched: switch to 2:1 [ 242] sched: off-stack process stack release pid=25 stacks=1 reason=deferred-process-drop proof_result=ok [ 243] proc: spawned process 26 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 243] proc: process 26 session context profile='system' for request 'cap-slot-leak' [ 243] sched: added process 26 [ 244] sched: switch 2:1 -> 26:1 [ 244] syscall: unknown syscall 0 [ 244] sched: process_cpu_accounting pid=26 runtime_ns=4906629 context_switches=1 [ 244] proc: process 26 exited with code 0 [ 244] pid=26 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 244] sched: switch to 2:1 [ 245] sched: off-stack process stack release pid=26 stacks=1 reason=deferred-process-drop proof_result=ok [ 246] proc: spawned process 27 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 246] proc: process 27 session context profile='system' for request 'cap-slot-leak' [ 246] sched: added process 27 [ 247] sched: switch 2:1 -> 27:1 [ 248] syscall: unknown syscall 0 [ 248] sched: process_cpu_accounting pid=27 runtime_ns=5372557 context_switches=2 [ 248] proc: process 27 exited with code 0 [ 248] pid=27 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 248] sched: switch to 2:1 [ 249] sched: off-stack process stack release pid=27 stacks=1 reason=deferred-process-drop proof_result=ok [ 249] proc: spawned process 28 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 249] proc: process 28 session context profile='system' for request 'cap-slot-leak' [ 249] sched: added process 28 [ 250] sched: switch 2:1 -> 28:1 [ 250] syscall: unknown syscall 0 [ 251] sched: process_cpu_accounting pid=28 runtime_ns=5224575 context_switches=2 [ 251] proc: process 28 exited with code 0 [ 251] pid=28 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 251] sched: switch to 2:1 [ 252] sched: off-stack process stack release pid=28 stacks=1 reason=deferred-process-drop proof_result=ok [ 253] proc: spawned process 29 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 253] proc: process 29 session context profile='system' for request 'cap-slot-leak' [ 253] sched: added process 29 [ 254] sched: switch 2:1 -> 29:1 [ 254] syscall: unknown syscall 0 [ 254] sched: process_cpu_accounting pid=29 runtime_ns=4944278 context_switches=1 [ 254] proc: process 29 exited with code 0 [ 254] pid=29 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 254] sched: switch to 2:1 [ 255] sched: off-stack process stack release pid=29 stacks=1 reason=deferred-process-drop proof_result=ok [ 256] proc: spawned process 30 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 256] proc: process 30 session context profile='system' for request 'cap-slot-leak' [ 256] sched: added process 30 [ 257] sched: switch 2:1 -> 30:1 [ 257] syscall: unknown syscall 0 [ 257] sched: process_cpu_accounting pid=30 runtime_ns=4900829 context_switches=1 [ 257] proc: process 30 exited with code 0 [ 257] pid=30 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 257] sched: switch to 2:1 [ 258] sched: off-stack process stack release pid=30 stacks=1 reason=deferred-process-drop proof_result=ok [ 259] proc: spawned process 31 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 259] proc: process 31 session context profile='system' for request 'cap-slot-leak' [ 259] sched: added process 31 [ 260] sched: switch 2:1 -> 31:1 [ 260] syscall: unknown syscall 0 [ 260] sched: process_cpu_accounting pid=31 runtime_ns=4906893 context_switches=1 [ 260] proc: process 31 exited with code 0 [ 260] pid=31 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 260] sched: switch to 2:1 [ 261] sched: off-stack process stack release pid=31 stacks=1 reason=deferred-process-drop proof_result=ok [ 261] proc: spawned process 32 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 261] proc: process 32 session context profile='system' for request 'cap-slot-leak' [ 261] sched: added process 32 [ 262] sched: switch 2:1 -> 32:1 [ 262] syscall: unknown syscall 0 [ 263] sched: process_cpu_accounting pid=32 runtime_ns=5348291 context_switches=2 [ 263] proc: process 32 exited with code 0 [ 263] pid=32 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 263] sched: switch to 2:1 [ 264] sched: off-stack process stack release pid=32 stacks=1 reason=deferred-process-drop proof_result=ok [ 265] proc: spawned process 33 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 265] proc: process 33 session context profile='system' for request 'cap-slot-leak' [ 265] sched: added process 33 [ 266] sched: switch 2:1 -> 33:1 [ 266] syscall: unknown syscall 0 [ 267] sched: process_cpu_accounting pid=33 runtime_ns=5231097 context_switches=2 [ 267] proc: process 33 exited with code 0 [ 267] pid=33 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 267] sched: switch to 2:1 [ 268] sched: off-stack process stack release pid=33 stacks=1 reason=deferred-process-drop proof_result=ok [ 269] proc: spawned process 34 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 269] proc: process 34 session context profile='system' for request 'cap-slot-leak' [ 269] sched: added process 34 [ 270] sched: switch 2:1 -> 34:1 [ 270] syscall: unknown syscall 0 [ 270] sched: process_cpu_accounting pid=34 runtime_ns=5604257 context_switches=1 [ 270] proc: process 34 exited with code 0 [ 270] pid=34 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 270] sched: switch to 2:1 [ 271] sched: off-stack process stack release pid=34 stacks=1 reason=deferred-process-drop proof_result=ok [ 272] proc: spawned process 35 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 272] proc: process 35 session context profile='system' for request 'cap-slot-leak' [ 272] sched: added process 35 [ 273] sched: switch 2:1 -> 35:1 [ 273] syscall: unknown syscall 0 [ 273] sched: process_cpu_accounting pid=35 runtime_ns=4829003 context_switches=1 [ 273] proc: process 35 exited with code 0 [ 273] pid=35 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 273] sched: switch to 2:1 [ 274] sched: off-stack process stack release pid=35 stacks=1 reason=deferred-process-drop proof_result=ok [ 275] proc: spawned process 36 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 275] proc: process 36 session context profile='system' for request 'cap-slot-leak' [ 275] sched: added process 36 [ 276] sched: switch 2:1 -> 36:1 [ 277] syscall: unknown syscall 0 [ 277] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 278] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 278] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 279] sched: process_cpu_accounting pid=36 runtime_ns=22710270 context_switches=4 [ 279] proc: process 36 exited with code 0 [ 279] sched: switch to 2:1 [ 280] sched: off-stack process stack release pid=36 stacks=1 reason=deferred-process-drop proof_result=ok [ 281] proc: spawned process 37 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 281] proc: process 37 session context profile='system' for request 'cap-slot-leak' [ 281] sched: added process 37 [ 282] sched: switch 2:1 -> 37:1 [ 283] syscall: unknown syscall 0 [ 283] pid=37 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 283] pid=37 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 284] pid=37 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 285] sched: process_cpu_accounting pid=37 runtime_ns=21124760 context_switches=4 [ 285] proc: process 37 exited with code 0 [ 285] sched: switch to 2:1 [ 286] sched: off-stack process stack release pid=37 stacks=1 reason=deferred-process-drop proof_result=ok [ 286] proc: spawned process 38 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 286] proc: process 38 session context profile='system' for request 'cap-slot-leak' [ 286] sched: added process 38 [ 287] sched: switch 2:1 -> 38:1 [ 287] syscall: unknown syscall 0 [ 288] pid=38 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 288] pid=38 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 289] pid=38 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 289] sched: process_cpu_accounting pid=38 runtime_ns=20832031 context_switches=3 [ 289] proc: process 38 exited with code 0 [ 289] sched: switch to 2:1 [ 290] sched: off-stack process stack release pid=38 stacks=1 reason=deferred-process-drop proof_result=ok [ 291] proc: spawned process 39 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 291] proc: process 39 session context profile='system' for request 'cap-slot-leak' [ 291] sched: added process 39 [ 292] sched: switch 2:1 -> 39:1 [ 292] syscall: unknown syscall 0 [ 292] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 293] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 293] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 294] sched: process_cpu_accounting pid=39 runtime_ns=20760142 context_switches=3 [ 294] proc: process 39 exited with code 0 [ 294] sched: switch to 2:1 [ 295] sched: off-stack process stack release pid=39 stacks=1 reason=deferred-process-drop proof_result=ok [ 296] proc: spawned process 40 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 296] proc: process 40 session context profile='system' for request 'cap-slot-leak' [ 296] sched: added process 40 [ 297] sched: switch 2:1 -> 40:1 [ 297] syscall: unknown syscall 0 [ 297] pid=40 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 298] pid=40 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 298] pid=40 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 299] sched: process_cpu_accounting pid=40 runtime_ns=20672821 context_switches=3 [ 299] proc: process 40 exited with code 0 [ 299] sched: switch to 2:1 [ 300] sched: off-stack process stack release pid=40 stacks=1 reason=deferred-process-drop proof_result=ok [ 300] proc: spawned process 41 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 300] proc: process 41 session context profile='system' for request 'cap-slot-leak' [ 300] sched: added process 41 [ 301] sched: switch 2:1 -> 41:1 [ 301] syscall: unknown syscall 0 [ 302] pid=41 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 302] sched: process_cpu_accounting pid=41 runtime_ns=10256755 context_switches=2 [ 302] proc: process 41 exited with code 0 [ 302] pid=41 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 302] sched: switch to 2:1 [ 303] sched: off-stack process stack release pid=41 stacks=1 reason=deferred-process-drop proof_result=ok [ 304] proc: spawned process 42 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 304] proc: process 42 session context profile='system' for request 'cap-slot-leak' [ 304] sched: added process 42 [ 305] sched: switch 2:1 -> 42:1 [ 306] syscall: unknown syscall 0 [ 306] sched: process_cpu_accounting pid=42 runtime_ns=5408519 context_switches=2 [ 306] proc: process 42 exited with code 0 [ 306] pid=42 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 306] sched: switch to 2:1 [ 307] sched: off-stack process stack release pid=42 stacks=1 reason=deferred-process-drop proof_result=ok [ 307] proc: spawned process 43 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 307] proc: process 43 session context profile='system' for request 'cap-slot-leak' [ 307] sched: added process 43 [ 308] sched: switch 2:1 -> 43:1 [ 309] syscall: unknown syscall 0 [ 309] sched: process_cpu_accounting pid=43 runtime_ns=5299172 context_switches=2 [ 309] proc: process 43 exited with code 0 [ 309] pid=43 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 309] sched: switch to 2:1 [ 310] sched: off-stack process stack release pid=43 stacks=1 reason=deferred-process-drop proof_result=ok [ 311] proc: spawned process 44 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 311] proc: process 44 session context profile='system' for request 'cap-slot-leak' [ 311] sched: added process 44 [ 312] sched: switch 2:1 -> 44:1 [ 312] syscall: unknown syscall 0 [ 313] sched: process_cpu_accounting pid=44 runtime_ns=5304001 context_switches=2 [ 313] proc: process 44 exited with code 0 [ 313] pid=44 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 313] sched: switch to 2:1 [ 314] sched: off-stack process stack release pid=44 stacks=1 reason=deferred-process-drop proof_result=ok [ 315] proc: spawned process 45 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 315] proc: process 45 session context profile='system' for request 'cap-slot-leak' [ 315] sched: added process 45 [ 316] sched: switch 2:1 -> 45:1 [ 316] syscall: unknown syscall 0 [ 316] sched: process_cpu_accounting pid=45 runtime_ns=5171786 context_switches=1 [ 316] proc: process 45 exited with code 0 [ 316] pid=45 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 316] sched: switch to 2:1 [ 317] sched: off-stack process stack release pid=45 stacks=1 reason=deferred-process-drop proof_result=ok [ 318] proc: spawned process 46 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 318] proc: process 46 session context profile='system' for request 'cap-slot-leak' [ 318] sched: added process 46 [ 319] sched: switch 2:1 -> 46:1 [ 319] syscall: unknown syscall 0 [ 319] sched: process_cpu_accounting pid=46 runtime_ns=4985093 context_switches=1 [ 319] proc: process 46 exited with code 0 [ 319] pid=46 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 319] sched: switch to 2:1 [ 320] sched: off-stack process stack release pid=46 stacks=1 reason=deferred-process-drop proof_result=ok [ 321] proc: spawned process 47 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 321] proc: process 47 session context profile='system' for request 'cap-slot-leak' [ 321] sched: added process 47 [ 322] sched: switch 2:1 -> 47:1 [ 323] syscall: unknown syscall 0 [ 323] sched: process_cpu_accounting pid=47 runtime_ns=5301673 context_switches=2 [ 323] proc: process 47 exited with code 0 [ 323] pid=47 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 323] sched: switch to 2:1 [ 324] sched: off-stack process stack release pid=47 stacks=1 reason=deferred-process-drop proof_result=ok [ 324] proc: spawned process 48 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 324] proc: process 48 session context profile='system' for request 'cap-slot-leak' [ 324] sched: added process 48 [ 325] sched: switch 2:1 -> 48:1 [ 326] syscall: unknown syscall 0 [ 326] sched: process_cpu_accounting pid=48 runtime_ns=5310988 context_switches=2 [ 326] proc: process 48 exited with code 0 [ 326] pid=48 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 326] sched: switch to 2:1 [ 327] sched: off-stack process stack release pid=48 stacks=1 reason=deferred-process-drop proof_result=ok [ 327] proc: spawned process 49 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 327] proc: process 49 session context profile='system' for request 'cap-slot-leak' [ 327] sched: added process 49 [ 328] sched: switch 2:1 -> 49:1 [ 328] syscall: unknown syscall 0 [ 329] sched: process_cpu_accounting pid=49 runtime_ns=5312734 context_switches=2 [ 329] proc: process 49 exited with code 0 [ 329] pid=49 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 329] sched: switch to 2:1 [ 330] sched: off-stack process stack release pid=49 stacks=1 reason=deferred-process-drop proof_result=ok [ 331] proc: spawned process 50 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 331] proc: process 50 session context profile='system' for request 'cap-slot-leak' [ 331] sched: added process 50 [ 332] sched: switch 2:1 -> 50:1 [ 332] syscall: unknown syscall 0 [ 333] sched: process_cpu_accounting pid=50 runtime_ns=5881856 context_switches=2 [ 333] proc: process 50 exited with code 0 [ 333] pid=50 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 333] sched: switch to 2:1 [ 334] sched: off-stack process stack release pid=50 stacks=1 reason=deferred-process-drop proof_result=ok [ 335] proc: spawned process 51 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 335] proc: process 51 session context profile='system' for request 'cap-slot-leak' [ 335] sched: added process 51 [ 336] sched: switch 2:1 -> 51:1 [ 336] syscall: unknown syscall 0 [ 336] sched: process_cpu_accounting pid=51 runtime_ns=4904053 context_switches=1 [ 336] proc: process 51 exited with code 0 [ 336] pid=51 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 336] sched: switch to 2:1 [ 337] sched: off-stack process stack release pid=51 stacks=1 reason=deferred-process-drop proof_result=ok [ 338] proc: spawned process 52 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 338] proc: process 52 session context profile='system' for request 'cap-slot-leak' [ 338] sched: added process 52 [ 339] sched: switch 2:1 -> 52:1 [ 339] syscall: unknown syscall 0 [ 339] sched: process_cpu_accounting pid=52 runtime_ns=4892461 context_switches=1 [ 339] proc: process 52 exited with code 0 [ 339] pid=52 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 339] sched: switch to 2:1 [ 340] sched: off-stack process stack release pid=52 stacks=1 reason=deferred-process-drop proof_result=ok [ 340] proc: spawned process 53 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 340] proc: process 53 session context profile='system' for request 'cap-slot-leak' [ 340] sched: added process 53 [ 341] sched: switch 2:1 -> 53:1 [ 342] syscall: unknown syscall 0 [ 342] pid=53 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 342] pid=53 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 343] pid=53 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 343] sched: process_cpu_accounting pid=53 runtime_ns=20908513 context_switches=3 [ 343] proc: process 53 exited with code 0 [ 343] sched: switch to 2:1 [ 344] sched: off-stack process stack release pid=53 stacks=1 reason=deferred-process-drop proof_result=ok [ 345] proc: spawned process 54 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 345] proc: process 54 session context profile='system' for request 'cap-slot-leak' [ 345] sched: added process 54 [ 346] sched: switch 2:1 -> 54:1 [ 346] syscall: unknown syscall 0 [ 347] pid=54 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 347] pid=54 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 348] pid=54 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 348] sched: process_cpu_accounting pid=54 runtime_ns=20973624 context_switches=3 [ 348] proc: process 54 exited with code 0 [ 348] sched: switch to 2:1 [ 349] sched: off-stack process stack release pid=54 stacks=1 reason=deferred-process-drop proof_result=ok [ 350] proc: spawned process 55 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 350] proc: process 55 session context profile='system' for request 'cap-slot-leak' [ 350] sched: added process 55 [ 351] sched: switch 2:1 -> 55:1 [ 351] syscall: unknown syscall 0 [ 351] pid=55 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 352] pid=55 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 352] pid=55 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 353] sched: process_cpu_accounting pid=55 runtime_ns=20920960 context_switches=3 [ 353] proc: process 55 exited with code 0 [ 353] sched: switch to 2:1 [ 354] sched: off-stack process stack release pid=55 stacks=1 reason=deferred-process-drop proof_result=ok [ 355] proc: spawned process 56 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 355] proc: process 56 session context profile='system' for request 'cap-slot-leak' [ 355] sched: added process 56 [ 356] sched: switch 2:1 -> 56:1 [ 356] syscall: unknown syscall 0 [ 356] pid=56 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 357] pid=56 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 357] pid=56 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 358] sched: process_cpu_accounting pid=56 runtime_ns=20905356 context_switches=3 [ 358] proc: process 56 exited with code 0 [ 358] sched: switch to 2:1 [ 359] sched: off-stack process stack release pid=56 stacks=1 reason=deferred-process-drop proof_result=ok [ 360] proc: spawned process 57 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 360] proc: process 57 session context profile='system' for request 'cap-slot-leak' [ 360] sched: added process 57 [ 361] sched: switch 2:1 -> 57:1 [ 362] syscall: unknown syscall 0 [ 362] pid=57 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 362] pid=57 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 363] pid=57 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 364] sched: process_cpu_accounting pid=57 runtime_ns=22040101 context_switches=4 [ 364] proc: process 57 exited with code 0 [ 364] sched: switch to 2:1 [ 365] sched: off-stack process stack release pid=57 stacks=1 reason=deferred-process-drop proof_result=ok [ 365] proc: spawned process 58 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 365] proc: process 58 session context profile='system' for request 'cap-slot-leak' [ 365] sched: added process 58 [ 366] sched: switch 2:1 -> 58:1 [ 367] syscall: unknown syscall 0 [ 367] pid=58 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 367] sched: process_cpu_accounting pid=58 runtime_ns=10393370 context_switches=2 [ 367] proc: process 58 exited with code 0 [ 367] pid=58 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 367] sched: switch to 2:1 [ 368] sched: off-stack process stack release pid=58 stacks=1 reason=deferred-process-drop proof_result=ok [ 369] proc: spawned process 59 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 369] proc: process 59 session context profile='system' for request 'cap-slot-leak' [ 369] sched: added process 59 [ 370] sched: switch 2:1 -> 59:1 [ 370] syscall: unknown syscall 0 [ 370] sched: process_cpu_accounting pid=59 runtime_ns=4930295 context_switches=1 [ 370] proc: process 59 exited with code 0 [ 370] pid=59 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 370] sched: switch to 2:1 [ 371] sched: off-stack process stack release pid=59 stacks=1 reason=deferred-process-drop proof_result=ok [ 372] proc: spawned process 60 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 372] proc: process 60 session context profile='system' for request 'cap-slot-leak' [ 372] sched: added process 60 [ 373] sched: switch 2:1 -> 60:1 [ 374] syscall: unknown syscall 0 [ 374] sched: process_cpu_accounting pid=60 runtime_ns=5297044 context_switches=2 [ 374] proc: process 60 exited with code 0 [ 374] pid=60 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 374] sched: switch to 2:1 [ 375] sched: off-stack process stack release pid=60 stacks=1 reason=deferred-process-drop proof_result=ok [ 375] proc: spawned process 61 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 375] proc: process 61 session context profile='system' for request 'cap-slot-leak' [ 375] sched: added process 61 [ 376] sched: switch 2:1 -> 61:1 [ 376] syscall: unknown syscall 0 [ 377] sched: process_cpu_accounting pid=61 runtime_ns=5262421 context_switches=2 [ 377] proc: process 61 exited with code 0 [ 377] pid=61 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 377] sched: switch to 2:1 [ 378] sched: off-stack process stack release pid=61 stacks=1 reason=deferred-process-drop proof_result=ok [ 379] proc: spawned process 62 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 379] proc: process 62 session context profile='system' for request 'cap-slot-leak' [ 379] sched: added process 62 [ 380] sched: switch 2:1 -> 62:1 [ 380] syscall: unknown syscall 0 [ 381] sched: process_cpu_accounting pid=62 runtime_ns=5234301 context_switches=2 [ 381] proc: process 62 exited with code 0 [ 381] pid=62 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 381] sched: switch to 2:1 [ 382] sched: off-stack process stack release pid=62 stacks=1 reason=deferred-process-drop proof_result=ok [ 383] proc: spawned process 63 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 383] proc: process 63 session context profile='system' for request 'cap-slot-leak' [ 383] sched: added process 63 [ 384] sched: switch 2:1 -> 63:1 [ 384] syscall: unknown syscall 0 [ 384] sched: process_cpu_accounting pid=63 runtime_ns=4973864 context_switches=1 [ 384] proc: process 63 exited with code 0 [ 384] pid=63 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 384] sched: switch to 2:1 [ 385] sched: off-stack process stack release pid=63 stacks=1 reason=deferred-process-drop proof_result=ok [ 386] proc: spawned process 64 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 386] proc: process 64 session context profile='system' for request 'cap-slot-leak' [ 386] sched: added process 64 [ 387] sched: switch 2:1 -> 64:1 [ 387] syscall: unknown syscall 0 [ 387] sched: process_cpu_accounting pid=64 runtime_ns=4936563 context_switches=1 [ 387] proc: process 64 exited with code 0 [ 387] pid=64 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 387] sched: switch to 2:1 [ 388] sched: off-stack process stack release pid=64 stacks=1 reason=deferred-process-drop proof_result=ok [ 389] proc: spawned process 65 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 389] proc: process 65 session context profile='system' for request 'cap-slot-leak' [ 389] sched: added process 65 [ 390] sched: switch 2:1 -> 65:1 [ 390] syscall: unknown syscall 0 [ 390] sched: process_cpu_accounting pid=65 runtime_ns=4952802 context_switches=1 [ 390] proc: process 65 exited with code 0 [ 390] pid=65 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 390] sched: switch to 2:1 [ 391] sched: off-stack process stack release pid=65 stacks=1 reason=deferred-process-drop proof_result=ok [init] Spawn cap-table exhaustion check ok. [ 392] sched: process_cpu_accounting pid=2 runtime_ns=2764952423 context_switches=177 [ 392] proc: process 2 exited with code 0 [ 392] sched: last process exited, halting measure: ring dispatches=879 sqes=1409 nop_sqes=130 measure: serial bytes=84372 measure: timer interrupts=392 user_scheduler=369 kernel_only=23 bsp_tick_advances=392 measure: tlb cr3_writes=402 pending_flush_checks=2592 pending_flush_all=0 shootdown_requests=0 shootdown_target_cpus=0 shootdown_ipis=0 deferred_completion_drains=0 measure: network_poll scheduler_polls=0 runtime_polls=0 iface_polls=0 tcp_http_polls=0 queue_poll_spins=0 queue_completions=0 waiter_scans=0 waiter_slots=0 measure: thread_placement selected_cpu0=0 selected_cpu1=0 selected_cpu2=0 selected_cpu3=0 first_selected_cpu0=0 first_selected_cpu1=0 first_selected_cpu2=0 first_selected_cpu3=0 migrations=0 migration_to_cpu0=0 migration_to_cpu1=0 migration_to_cpu2=0 migration_to_cpu3=0 measure: segment ring_processing count=1414 cycles=7545459781 avg=5336251 measure: segment sqe_validation count=2266 cycles=44206492 avg=19508 measure: segment cap_lookup count=1680 cycles=989101658 avg=588750 measure: segment capnp_decode_encode count=643 cycles=4568396 avg=7104 measure: segment method_body count=756 cycles=6367881426 avg=8423123 measure: segment null_cap_empty count=80 cycles=4932 avg=61 measure: segment null_cap_schema count=80 cycles=398168 avg=4977 measure: schema_dispatch_overhead null_empty_count=80 null_empty_avg=61 null_schema_count=80 null_schema_avg=4977 overhead_cycles=4916 measure: cap_slot_memory slot_bytes=80 max_slots=256 max_slot_storage_bytes=20480 measure: segment cqe_post count=1397 cycles=770899 avg=551 measure: segment waiter_wake_check count=1384 cycles=16255679 avg=11745 measure: segment sched_choose_next count=639 cycles=53678832 avg=84004 measure: direct_ipc_ready_to_select count=71 cycles=28436715 avg=400517 min=381165 max=512626 measure: segment schedule_save_requeue count=369 cycles=65094523 avg=176407 measure: segment timer_sleep_wake count=1032 cycles=287427 avg=278 measure: segment park_wake count=1032 cycles=7190276 avg=6967 measure: segment cap_wait_wake_scan count=1044 cycles=2676125 avg=2563 measure: segment thread_exit_join_cleanup count=87 cycles=197779701 avg=2273329 measure: segment process_exit_cleanup count=64 cycles=724177778 avg=11315277 measure: segment process_drop count=63 cycles=1168062774 avg=18540678 measure: scheduler choose_direct_candidates=71 choose_run_queue_candidates=543 choose_idle_candidates=8 choose_runnable=622 choose_retry=0 choose_drop=0 wake_scans=245 wake_eligible_idle_cpus=0 wake_target_cpus=0 wake_ipis_sent=0 wake_pending_ipis_skipped=0 wake_target_not_ready_skipped=0 wake_lapic_targets_missing=0 wake_ipis_failed=0 measure: scheduler_lock acquisitions=12052 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=4950650708 measure: scheduler_lock_site schedule_pre_ring acquisitions=1155 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=218370992 measure: scheduler_lock_site schedule_select acquisitions=369 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=985726968 measure: scheduler_lock_site block_current acquisitions=3517 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=1325613356 measure: scheduler_lock_site wake_unblock acquisitions=1419 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=17922539 measure: scheduler_lock_site metadata acquisitions=5096 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=503535934 measure: shared_kernel_lock frame_alloc acquisitions=53618 contended=0 spin_loops=0 measure: shared_kernel_lock frame_free acquisitions=52794 contended=0 spin_loops=0 measure: shared_kernel_lock ring_dispatch_cap_table acquisitions=369 contended=0 spin_loops=0 measure: shared_kernel_lock ring_dispatch_scratch acquisitions=369 contended=0 spin_loops=0 measure: shared_kernel_lock endpoint_inner acquisitions=374 contended=0 spin_loops=0 measure: shared_kernel_lock endpoint_cancel_scratch acquisitions=86 contended=0 spin_loops=0 measure: shared_kernel_lock address_space acquisitions=3854 contended=0 spin_loops=0 measure: shared_kernel_lock heap acquisitions=5453 contended=0 spin_loops=0 measure: user_pc_samples total=0 overflow=0