[ 0] capos kernel starting... [ 0] smp: BSP per-cpu active cpu=0 lapic=0 base=0xffffffff813f0300 syscall_rsp=0xffffffff813e2b40 [ 0] syscall: entry at 0xffffffff80197e1c [ 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 - 0x0000000009f62000 0 [ 0] 0x0000000009f62000 - 0x0000000009fb6000 6 [ 0] 0x0000000009fb6000 - 0x0000000009fb7000 5 [ 0] 0x0000000009fb7000 - 0x0000000009fb8000 0 [ 0] 0x0000000009fb8000 - 0x0000000009fb9000 5 [ 0] 0x0000000009fb9000 - 0x0000000009fba000 0 [ 0] 0x0000000009fba000 - 0x0000000009fc3000 5 [ 0] 0x0000000009fc3000 - 0x000000000b3b4000 6 [ 0] 0x000000000b3b4000 - 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: 162184 KB (40546 frames) [ 0] heap: 98304 KB across 1 physical runs / 2 allocator regions (14 region slots free) [ 0] mem: frame allocator + heap initialized (16062 usable frames) [ 0] alloc test: [1, 2, 3, 4, 5] [ 0] paging: kernel sections: [ 0] .text: 0xffffffff80000000 - 0xffffffff808bc21f [ 0] .rodata: 0xffffffff808bd000 - 0xffffffff80a3a050 [ 0] .data: 0xffffffff80a3b000 - 0xffffffff812abaf8 [ 0] .bss: 0xffffffff812ac000 - 0xffffffff813f0ff8 [ 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=0xffffffff80610550 kernel_rsp=0xffff800006130000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=1 entry=0xffffffff80610550 kernel_rsp=0xffff800006150000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=2 entry=0xffffffff80610550 kernel_rsp=0xffff800006170000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=3 entry=0xffffffff80610550 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=629377 divide=16 calibrated_hz=100 clocksource=tsc-calibrated calibration_ns=10000150 tsc_delta=28103978 [ 0] clockevent: proof backend=lapic oneshot=programmed deadline_ns=14541380 delta_ns=5000000 count=314689 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=5089420 count=314689 count_after_program=311948 periodic_initial_count=629377 within_tolerance=true restored_periodic=true periodic_live=true [ 0] clockevent-floor: clocksource=tsc real_ns=5000029 monotonic_delta_ns=5000098 tick_ns=10000000 floored=false subtick_tracked=true [ 0] smp: no AP slots prepared; AP bootstrap skipped [ 0] manifest: loaded 342160 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 (740000 bytes) [ 0] binary 'init': 740000 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=21483 KiB free=76820 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. [ 6] proc: spawned process 3 for request 'ring-nop' (binary='ring-nop', 4 caps) [ 6] proc: process 3 session context profile='system' for request 'ring-nop' [ 6] sched: added process 3 [ 7] sched: switch 2:1 -> 3:1 [ 8] 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 [ 9] pid=3 invalid submission err=-1 opcode=5 cap_id_bucket=0 cause=structural [ 9] pid=3 invalid submission err=-2 opcode=0 cap_id_bucket=0 cause=structural [ 10] pid=3 invalid submission err=-3 opcode=0 cap_id_bucket=0 cause=structural [ 10] ring: failed to serialize CapException into result buffer: Failed: result buffer too small [ 11] pid=3 invalid submission err=-2 opcode=0 cap_id_bucket=0 cause=structural [ 12] pid=3 invalid submission err=-4 opcode=0 cap_id_bucket=4294967295 cause=cap-not-found [ 12] 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] cold cap_enter cycles: first_nop_round_trip=257818 [ 14] sched: switch 3:1 -> 2:1 [ 14] proc: spawned process 4 for request 'thread-lifecycle' (binary='thread-lifecycle', 8 caps) [ 14] proc: process 4 session context profile='system' for request 'thread-lifecycle' [ 14] sched: added process 4 [ 15] sched: switch 2:1 -> 4:1 [ 16] sched: switch 4:1 -> 4:2 [ 18] sched: switch 4:2 -> 4:1 [ 18] sched: blocked 4:1 -> 4:2 [ 19] sched: switch 4:2 -> 4:1 [ 19] sched: blocked 4:1 -> 3:1 [ring-nop] measure avg cycles: nop=5106773 null_empty=37588 null_small=44968 [ 20] sched: switch 3:1 -> 4:2 [ 20] sched: switch to 4:1 [ 21] sched: off-stack thread stack release pid=4 tid=2 reason=thread-exit proof_result=ok [ 22] sched: switch 4:1 -> 4:3 [ 24] sched: switch 4:3 -> 3:1 [ 25] sched: switch 3:1 -> 4:1 [ 26] sched: switch 4:1 -> 4:3 [ 26] sched: switch to 3:1 [ 27] sched: off-stack thread stack release pid=4 tid=3 reason=thread-exit proof_result=ok [ 27] sched: switch 3:1 -> 4:1 [ 29] sched: switch 4:1 -> 4:4 [ 31] sched: switch 4:4 -> 4:1 [ 31] sched: blocked 4:1 -> 4:4 [ 32] sched: switch 4:4 -> 3:1 [ 33] sched: switch 3:1 -> 4:1 [ 34] sched: switch 4: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 -> 4:1 [ 39] sched: blocked 4:1 -> 3:1 [ 40] sched: switch 3:1 -> 2:1 [ 40] proc: spawned process 5 for request 'unprivileged-stranger' (binary='unprivileged-stranger', 0 caps) [ 40] proc: process 5 session context profile='system' for request 'unprivileged-stranger' [ 40] sched: added process 5 [ 41] sched: switch 2:1 -> 5:1 [ 41] syscall: unknown syscall 0 [ 41] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 42] sched: switch 5:1 -> 4:1 [ 43] sched: switch 4:1 -> 4:5 [ 43] sched: switch to 4:6 [ 43] sched: off-stack thread stack release pid=4 tid=5 reason=thread-exit proof_result=ok [ 43] sched: switch to 5:1 [ 44] sched: off-stack thread stack release pid=4 tid=6 reason=thread-exit proof_result=ok [ 44] sched: switch 5:1 -> 4:1 [ 45] sched: switch 4:1 -> 3:1 [ 46] sched: switch 3:1 -> 5:1 [ 46] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 46] pid=5 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 47] sched: switch 5:1 -> 4:1 [ 48] sched: switch 4:1 -> 4:7 [ 50] sched: switch 4:7 -> 4:1 [ 51] sched: switch 4:1 -> 4:8 [ 51] sched: blocked 4:8 -> 3:1 [ring-nop] park bench avg cycles: compact_wait_miss=35572 generic_wait_miss=4692782 compact_wake_empty=34081 generic_wake_empty=7484582 [ 52] sched: switch 3:1 -> 4:7 [ 52] sched: blocked 4:7 -> 5:1 [ 53] sched: process_cpu_accounting pid=5 runtime_ns=33242514 context_switches=5 [ 53] proc: process 5 exited with code 0 [ 53] sched: switch to 4:1 [ 54] sched: off-stack process stack release pid=5 stacks=1 reason=deferred-process-drop proof_result=ok [ 54] sched: switch 4:1 -> 3:1 [ 56] sched: switch 3:1 -> 4:1 [ 56] sched: blocked 4:1 -> 3:1 [ 58] sched: switch 3:1 -> 2:1 [init] Generic manifest child wait ok: unprivileged-stranger [ 58] sched: blocked 2:1 -> 4:1 [ 59] sched: switch 4:1 -> 4:7 [ 59] sched: switch to 4:8 [ 59] sched: off-stack thread stack release pid=4 tid=7 reason=thread-exit proof_result=ok [ 59] sched: switch to 4:1 [ 60] sched: off-stack thread stack release pid=4 tid=8 reason=thread-exit proof_result=ok [ 61] sched: switch 4:1 -> 3:1 [ring-nop] sqe throughput workload: sqes=4096 [ 61] sched: process_cpu_accounting pid=3 runtime_ns=196423374 context_switches=21 [ 61] proc: process 3 exited with code 0 [ 61] sched: switch to 4:1 [ 62] sched: off-stack process stack release pid=3 stacks=1 reason=deferred-process-drop proof_result=ok [thread-lifecycle] park multi-waiter unmap reuse cleanup ok. [ 65] sched: switch 4:1 -> 4:9 [ 65] sched: blocked 4:9 -> 4:1 [ 65] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 65] sched: blocked 4:1 -> 1:1 [ 66] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=1 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 67] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=2 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 68] sched: cpl0-idle cpu=0 starting thread 4:1 [ 69] sched: switch 4:1 -> 4:9 [ 69] sched: switch to 4:1 [ 70] sched: off-stack thread stack release pid=4 tid=9 reason=thread-exit proof_result=ok [ 70] sched: switch 4:1 -> 4:10 [ 70] sched: blocked 4:10 -> 4:1 [ 71] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 71] sched: blocked 4:1 -> 1:1 [ 71] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=3 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 72] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=4 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 73] sched: cpl0-idle cpu=0 starting thread 4:1 [ 74] sched: switch 4:1 -> 4:10 [ 74] sched: switch to 4:1 [thread-lifecycle] park unmap/decommit/memoryobject cleanup ok. [ 75] sched: off-stack thread stack release pid=4 tid=10 reason=thread-exit proof_result=ok [ 76] sched: switch 4:1 -> 4:11 [ 76] sched: blocked 4:11 -> 4:1 [ 76] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 76] sched: blocked 4:1 -> 1:1 [ 77] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=5 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 78] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=6 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 79] sched: cpl0-idle cpu=0 starting thread 4:1 [ 80] sched: switch 4:1 -> 4:11 [ 83] sched: switch 4:11 -> 4:1 [ 84] sched: switch 4:1 -> 4:11 [ 84] sched: blocked 4:11 -> 4:1 [ 84] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 84] sched: blocked 4:1 -> 1:1 [ 85] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=7 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 86] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=8 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 87] sched: cpl0-idle cpu=0 starting thread 4:1 [ 88] 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=3079507 empty_wake=234604 wait_to_block=87582663 wake_to_runnable=410218 wake_to_resume=25207828 [ 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 [ 122] 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 [ 124] 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 [ 137] 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 [ 144] 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 [ 146] 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: switch 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 [ 153] 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: 7935837 [ 158] sched: off-stack thread stack release pid=4 tid=12 reason=thread-exit proof_result=ok [thread-lifecycle] endpoint matched avg cycles: direct=7906140 ordinary=7965534 [thread-lifecycle] thread lifecycle checkpoint ok. [ 159] sched: process_cpu_accounting pid=4 runtime_ns=1005676905 context_switches=283 [ 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. [ 161] proc: spawned process 6 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 161] proc: process 6 session context profile='system' for request 'cap-slot-leak' [ 161] sched: added process 6 [ 162] sched: switch 2:1 -> 6:1 [ 162] syscall: unknown syscall 0 [ 162] pid=6 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 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] sched: process_cpu_accounting pid=6 runtime_ns=20728223 context_switches=3 [ 164] proc: process 6 exited with code 0 [ 164] sched: switch to 2:1 [ 165] 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 [ 168] syscall: unknown syscall 0 [ 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] pid=7 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 170] sched: process_cpu_accounting pid=7 runtime_ns=21147844 context_switches=4 [ 170] proc: process 7 exited with code 0 [ 170] sched: switch to 2:1 [ 171] 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 [ 172] syscall: unknown syscall 0 [ 172] 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 [ 173] 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=20722487 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 [ 178] syscall: unknown syscall 0 [ 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] 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=20899119 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 [ 181] proc: spawned process 10 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 181] proc: process 10 session context profile='system' for request 'cap-slot-leak' [ 181] sched: added process 10 [ 182] sched: switch 2:1 -> 10:1 [ 182] syscall: unknown syscall 0 [ 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] pid=10 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 184] sched: process_cpu_accounting pid=10 runtime_ns=20965399 context_switches=3 [ 184] proc: process 10 exited with code 0 [ 184] sched: switch to 2:1 [ 185] sched: off-stack process stack release pid=10 stacks=1 reason=deferred-process-drop proof_result=ok [ 186] proc: spawned process 11 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 186] proc: process 11 session context profile='system' for request 'cap-slot-leak' [ 186] sched: added process 11 [ 187] sched: switch 2:1 -> 11:1 [ 187] syscall: unknown syscall 0 [ 188] pid=11 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 188] sched: process_cpu_accounting pid=11 runtime_ns=10372067 context_switches=2 [ 188] proc: process 11 exited with code 0 [ 188] pid=11 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 188] sched: switch to 2:1 [ 189] sched: off-stack process stack release pid=11 stacks=1 reason=deferred-process-drop proof_result=ok [ 190] proc: spawned process 12 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 190] proc: process 12 session context profile='system' for request 'cap-slot-leak' [ 190] sched: added process 12 [ 191] sched: switch 2:1 -> 12:1 [ 192] syscall: unknown syscall 0 [ 192] sched: process_cpu_accounting pid=12 runtime_ns=5288134 context_switches=2 [ 192] proc: process 12 exited with code 0 [ 192] pid=12 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 192] sched: switch to 2:1 [ 193] sched: off-stack process stack release pid=12 stacks=1 reason=deferred-process-drop proof_result=ok [ 194] proc: spawned process 13 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 194] proc: process 13 session context profile='system' for request 'cap-slot-leak' [ 194] sched: added process 13 [ 195] sched: switch 2:1 -> 13:1 [ 195] syscall: unknown syscall 0 [ 195] sched: process_cpu_accounting pid=13 runtime_ns=4865821 context_switches=1 [ 195] proc: process 13 exited with code 0 [ 195] pid=13 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 195] sched: switch to 2:1 [ 196] sched: off-stack process stack release pid=13 stacks=1 reason=deferred-process-drop proof_result=ok [ 197] proc: spawned process 14 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 197] proc: process 14 session context profile='system' for request 'cap-slot-leak' [ 197] sched: added process 14 [ 198] sched: switch 2:1 -> 14:1 [ 199] syscall: unknown syscall 0 [ 199] sched: process_cpu_accounting pid=14 runtime_ns=5420978 context_switches=2 [ 199] proc: process 14 exited with code 0 [ 199] pid=14 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=14 stacks=1 reason=deferred-process-drop proof_result=ok [ 200] proc: spawned process 15 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 200] proc: process 15 session context profile='system' for request 'cap-slot-leak' [ 200] sched: added process 15 [ 201] sched: switch 2:1 -> 15:1 [ 201] syscall: unknown syscall 0 [ 201] sched: process_cpu_accounting pid=15 runtime_ns=4934619 context_switches=1 [ 201] proc: process 15 exited with code 0 [ 201] pid=15 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 201] sched: switch to 2:1 [ 202] sched: off-stack process stack release pid=15 stacks=1 reason=deferred-process-drop proof_result=ok [ 203] proc: spawned process 16 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 203] proc: process 16 session context profile='system' for request 'cap-slot-leak' [ 203] sched: added process 16 [ 204] sched: switch 2:1 -> 16:1 [ 205] syscall: unknown syscall 0 [ 205] sched: process_cpu_accounting pid=16 runtime_ns=5267160 context_switches=2 [ 205] proc: process 16 exited with code 0 [ 205] pid=16 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 205] sched: switch to 2:1 [ 206] sched: off-stack process stack release pid=16 stacks=1 reason=deferred-process-drop proof_result=ok [ 206] proc: spawned process 17 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 206] proc: process 17 session context profile='system' for request 'cap-slot-leak' [ 206] sched: added process 17 [ 207] sched: switch 2:1 -> 17:1 [ 207] syscall: unknown syscall 0 [ 208] sched: process_cpu_accounting pid=17 runtime_ns=5279223 context_switches=2 [ 208] proc: process 17 exited with code 0 [ 208] pid=17 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 208] sched: switch to 2:1 [ 209] sched: off-stack process stack release pid=17 stacks=1 reason=deferred-process-drop proof_result=ok [ 210] proc: spawned process 18 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 210] proc: process 18 session context profile='system' for request 'cap-slot-leak' [ 210] sched: added process 18 [ 211] sched: switch 2:1 -> 18:1 [ 211] syscall: unknown syscall 0 [ 211] sched: process_cpu_accounting pid=18 runtime_ns=4925534 context_switches=1 [ 211] proc: process 18 exited with code 0 [ 211] pid=18 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 211] sched: switch to 2:1 [ 212] sched: off-stack process stack release pid=18 stacks=1 reason=deferred-process-drop proof_result=ok [ 213] proc: spawned process 19 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 213] proc: process 19 session context profile='system' for request 'cap-slot-leak' [ 213] sched: added process 19 [ 214] sched: switch 2:1 -> 19:1 [ 214] syscall: unknown syscall 0 [ 214] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 215] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 215] pid=19 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 216] sched: process_cpu_accounting pid=19 runtime_ns=21108714 context_switches=3 [ 216] proc: process 19 exited with code 0 [ 216] sched: switch to 2:1 [ 217] sched: off-stack process stack release pid=19 stacks=1 reason=deferred-process-drop proof_result=ok [ 218] proc: spawned process 20 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 218] proc: process 20 session context profile='system' for request 'cap-slot-leak' [ 218] sched: added process 20 [ 219] sched: switch 2:1 -> 20:1 [ 220] syscall: unknown syscall 0 [ 220] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 220] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 221] pid=20 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 222] sched: process_cpu_accounting pid=20 runtime_ns=21433758 context_switches=4 [ 222] proc: process 20 exited with code 0 [ 222] sched: switch to 2:1 [ 223] sched: off-stack process stack release pid=20 stacks=1 reason=deferred-process-drop proof_result=ok [ 223] proc: spawned process 21 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 223] proc: process 21 session context profile='system' for request 'cap-slot-leak' [ 223] sched: added process 21 [ 224] sched: switch 2:1 -> 21:1 [ 224] syscall: unknown syscall 0 [ 225] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 225] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 226] pid=21 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 226] sched: process_cpu_accounting pid=21 runtime_ns=21224688 context_switches=3 [ 226] proc: process 21 exited with code 0 [ 226] sched: switch to 2:1 [ 227] sched: off-stack process stack release pid=21 stacks=1 reason=deferred-process-drop proof_result=ok [ 228] proc: spawned process 22 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 228] proc: process 22 session context profile='system' for request 'cap-slot-leak' [ 228] sched: added process 22 [ 229] sched: switch 2:1 -> 22:1 [ 229] syscall: unknown syscall 0 [ 229] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 230] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 231] pid=22 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 231] sched: process_cpu_accounting pid=22 runtime_ns=21081698 context_switches=3 [ 231] proc: process 22 exited with code 0 [ 231] sched: switch to 2:1 [ 232] sched: off-stack process stack release pid=22 stacks=1 reason=deferred-process-drop proof_result=ok [ 233] proc: spawned process 23 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 233] proc: process 23 session context profile='system' for request 'cap-slot-leak' [ 233] sched: added process 23 [ 234] sched: switch 2:1 -> 23:1 [ 234] syscall: unknown syscall 0 [ 234] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 235] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 235] pid=23 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 236] sched: process_cpu_accounting pid=23 runtime_ns=21146864 context_switches=3 [ 236] proc: process 23 exited with code 0 [ 236] sched: switch to 2:1 [ 237] sched: off-stack process stack release pid=23 stacks=1 reason=deferred-process-drop proof_result=ok [ 238] proc: spawned process 24 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 238] proc: process 24 session context profile='system' for request 'cap-slot-leak' [ 238] sched: added process 24 [ 239] sched: switch 2:1 -> 24:1 [ 239] syscall: unknown syscall 0 [ 239] pid=24 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 240] sched: process_cpu_accounting pid=24 runtime_ns=10700157 context_switches=2 [ 240] proc: process 24 exited with code 0 [ 240] pid=24 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 240] sched: switch to 2:1 [ 241] sched: off-stack process stack release pid=24 stacks=1 reason=deferred-process-drop proof_result=ok [ 242] proc: spawned process 25 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 242] proc: process 25 session context profile='system' for request 'cap-slot-leak' [ 242] sched: added process 25 [ 243] sched: switch 2:1 -> 25:1 [ 243] syscall: unknown syscall 0 [ 243] sched: process_cpu_accounting pid=25 runtime_ns=4944970 context_switches=1 [ 243] proc: process 25 exited with code 0 [ 243] pid=25 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 243] sched: switch to 2:1 [ 244] sched: off-stack process stack release pid=25 stacks=1 reason=deferred-process-drop proof_result=ok [ 245] proc: spawned process 26 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 245] proc: process 26 session context profile='system' for request 'cap-slot-leak' [ 245] sched: added process 26 [ 246] sched: switch 2:1 -> 26:1 [ 246] syscall: unknown syscall 0 [ 246] sched: process_cpu_accounting pid=26 runtime_ns=5044465 context_switches=1 [ 246] proc: process 26 exited with code 0 [ 246] pid=26 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 246] sched: switch to 2:1 [ 247] sched: off-stack process stack release pid=26 stacks=1 reason=deferred-process-drop proof_result=ok [ 248] proc: spawned process 27 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 248] proc: process 27 session context profile='system' for request 'cap-slot-leak' [ 248] sched: added process 27 [ 249] sched: switch 2:1 -> 27:1 [ 250] syscall: unknown syscall 0 [ 250] sched: process_cpu_accounting pid=27 runtime_ns=5223557 context_switches=2 [ 250] proc: process 27 exited with code 0 [ 250] pid=27 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 250] sched: switch to 2:1 [ 251] sched: off-stack process stack release pid=27 stacks=1 reason=deferred-process-drop proof_result=ok [ 251] proc: spawned process 28 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 251] proc: process 28 session context profile='system' for request 'cap-slot-leak' [ 251] sched: added process 28 [ 252] sched: switch 2:1 -> 28:1 [ 252] syscall: unknown syscall 0 [ 253] sched: process_cpu_accounting pid=28 runtime_ns=5216050 context_switches=2 [ 253] proc: process 28 exited with code 0 [ 253] pid=28 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 253] sched: switch to 2:1 [ 254] sched: off-stack process stack release pid=28 stacks=1 reason=deferred-process-drop proof_result=ok [ 255] proc: spawned process 29 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 255] proc: process 29 session context profile='system' for request 'cap-slot-leak' [ 255] sched: added process 29 [ 256] sched: switch 2:1 -> 29:1 [ 256] syscall: unknown syscall 0 [ 257] sched: process_cpu_accounting pid=29 runtime_ns=5402729 context_switches=2 [ 257] proc: process 29 exited with code 0 [ 257] pid=29 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=29 stacks=1 reason=deferred-process-drop proof_result=ok [ 259] proc: spawned process 30 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 259] proc: process 30 session context profile='system' for request 'cap-slot-leak' [ 259] sched: added process 30 [ 260] sched: switch 2:1 -> 30:1 [ 260] syscall: unknown syscall 0 [ 260] sched: process_cpu_accounting pid=30 runtime_ns=4906155 context_switches=1 [ 260] proc: process 30 exited with code 0 [ 260] pid=30 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=30 stacks=1 reason=deferred-process-drop proof_result=ok [ 262] proc: spawned process 31 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 262] proc: process 31 session context profile='system' for request 'cap-slot-leak' [ 262] sched: added process 31 [ 263] sched: switch 2:1 -> 31:1 [ 263] syscall: unknown syscall 0 [ 263] sched: process_cpu_accounting pid=31 runtime_ns=4861610 context_switches=1 [ 263] proc: process 31 exited with code 0 [ 263] pid=31 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=31 stacks=1 reason=deferred-process-drop proof_result=ok [ 264] proc: spawned process 32 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 264] proc: process 32 session context profile='system' for request 'cap-slot-leak' [ 264] sched: added process 32 [ 265] sched: switch 2:1 -> 32:1 [ 265] syscall: unknown syscall 0 [ 266] sched: process_cpu_accounting pid=32 runtime_ns=5275409 context_switches=2 [ 266] proc: process 32 exited with code 0 [ 266] pid=32 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 266] sched: switch to 2:1 [ 267] sched: off-stack process stack release pid=32 stacks=1 reason=deferred-process-drop proof_result=ok [ 268] proc: spawned process 33 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 268] proc: process 33 session context profile='system' for request 'cap-slot-leak' [ 268] sched: added process 33 [ 269] sched: switch 2:1 -> 33:1 [ 269] syscall: unknown syscall 0 [ 270] sched: process_cpu_accounting pid=33 runtime_ns=5263893 context_switches=2 [ 270] proc: process 33 exited with code 0 [ 270] pid=33 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=33 stacks=1 reason=deferred-process-drop proof_result=ok [ 272] proc: spawned process 34 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 272] proc: process 34 session context profile='system' for request 'cap-slot-leak' [ 272] sched: added process 34 [ 273] sched: switch 2:1 -> 34:1 [ 273] syscall: unknown syscall 0 [ 273] sched: process_cpu_accounting pid=34 runtime_ns=4900059 context_switches=1 [ 273] proc: process 34 exited with code 0 [ 273] pid=34 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=34 stacks=1 reason=deferred-process-drop proof_result=ok [ 275] proc: spawned process 35 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 275] proc: process 35 session context profile='system' for request 'cap-slot-leak' [ 275] sched: added process 35 [ 276] sched: switch 2:1 -> 35:1 [ 276] syscall: unknown syscall 0 [ 276] sched: process_cpu_accounting pid=35 runtime_ns=4917908 context_switches=1 [ 276] proc: process 35 exited with code 0 [ 276] pid=35 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 276] sched: switch to 2:1 [ 277] sched: off-stack process stack release pid=35 stacks=1 reason=deferred-process-drop proof_result=ok [ 277] proc: spawned process 36 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 277] proc: process 36 session context profile='system' for request 'cap-slot-leak' [ 277] sched: added process 36 [ 278] sched: switch 2:1 -> 36:1 [ 278] syscall: unknown syscall 0 [ 279] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 279] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 280] pid=36 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 280] sched: process_cpu_accounting pid=36 runtime_ns=21232395 context_switches=3 [ 280] proc: process 36 exited with code 0 [ 280] sched: switch to 2:1 [ 281] sched: off-stack process stack release pid=36 stacks=1 reason=deferred-process-drop proof_result=ok [ 282] proc: spawned process 37 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 282] proc: process 37 session context profile='system' for request 'cap-slot-leak' [ 282] sched: added process 37 [ 283] sched: switch 2:1 -> 37:1 [ 283] syscall: unknown syscall 0 [ 284] 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] 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=21221950 context_switches=3 [ 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 [ 287] proc: spawned process 38 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 287] proc: process 38 session context profile='system' for request 'cap-slot-leak' [ 287] sched: added process 38 [ 288] sched: switch 2:1 -> 38:1 [ 288] syscall: unknown syscall 0 [ 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] pid=38 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 290] sched: process_cpu_accounting pid=38 runtime_ns=21116208 context_switches=3 [ 290] proc: process 38 exited with code 0 [ 290] sched: switch to 2:1 [ 291] sched: off-stack process stack release pid=38 stacks=1 reason=deferred-process-drop proof_result=ok [ 292] proc: spawned process 39 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 292] proc: process 39 session context profile='system' for request 'cap-slot-leak' [ 292] sched: added process 39 [ 293] sched: switch 2:1 -> 39:1 [ 293] syscall: unknown syscall 0 [ 293] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 294] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 294] pid=39 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 295] sched: process_cpu_accounting pid=39 runtime_ns=20679117 context_switches=3 [ 295] proc: process 39 exited with code 0 [ 295] sched: switch to 2:1 [ 296] 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 [ 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] 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=20833094 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 [ 301] proc: spawned process 41 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 301] proc: process 41 session context profile='system' for request 'cap-slot-leak' [ 301] sched: added process 41 [ 302] sched: switch 2:1 -> 41:1 [ 302] syscall: unknown syscall 0 [ 303] pid=41 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 303] sched: process_cpu_accounting pid=41 runtime_ns=10371759 context_switches=2 [ 303] proc: process 41 exited with code 0 [ 303] pid=41 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 303] sched: switch to 2:1 [ 304] sched: off-stack process stack release pid=41 stacks=1 reason=deferred-process-drop proof_result=ok [ 305] proc: spawned process 42 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 305] proc: process 42 session context profile='system' for request 'cap-slot-leak' [ 305] sched: added process 42 [ 306] sched: switch 2:1 -> 42:1 [ 307] syscall: unknown syscall 0 [ 307] sched: process_cpu_accounting pid=42 runtime_ns=5713634 context_switches=2 [ 307] proc: process 42 exited with code 0 [ 307] pid=42 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 307] sched: switch to 2:1 [ 308] sched: off-stack process stack release pid=42 stacks=1 reason=deferred-process-drop proof_result=ok [ 308] proc: spawned process 43 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 308] proc: process 43 session context profile='system' for request 'cap-slot-leak' [ 308] sched: added process 43 [ 309] sched: switch 2:1 -> 43:1 [ 309] syscall: unknown syscall 0 [ 310] sched: process_cpu_accounting pid=43 runtime_ns=5188886 context_switches=2 [ 310] proc: process 43 exited with code 0 [ 310] pid=43 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 310] sched: switch to 2:1 [ 311] sched: off-stack process stack release pid=43 stacks=1 reason=deferred-process-drop proof_result=ok [ 312] proc: spawned process 44 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 312] proc: process 44 session context profile='system' for request 'cap-slot-leak' [ 312] sched: added process 44 [ 313] sched: switch 2:1 -> 44:1 [ 313] syscall: unknown syscall 0 [ 313] sched: process_cpu_accounting pid=44 runtime_ns=4893621 context_switches=1 [ 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=5077750 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 [ 320] syscall: unknown syscall 0 [ 320] sched: process_cpu_accounting pid=46 runtime_ns=5269893 context_switches=2 [ 320] proc: process 46 exited with code 0 [ 320] pid=46 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 320] sched: switch to 2:1 [ 321] 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 [ 322] syscall: unknown syscall 0 [ 323] sched: process_cpu_accounting pid=47 runtime_ns=5261727 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 [ 325] proc: spawned process 48 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 325] proc: process 48 session context profile='system' for request 'cap-slot-leak' [ 325] sched: added process 48 [ 326] sched: switch 2:1 -> 48:1 [ 326] syscall: unknown syscall 0 [ 326] sched: process_cpu_accounting pid=48 runtime_ns=4884163 context_switches=1 [ 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 [ 328] proc: spawned process 49 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 328] proc: process 49 session context profile='system' for request 'cap-slot-leak' [ 328] sched: added process 49 [ 329] sched: switch 2:1 -> 49:1 [ 329] syscall: unknown syscall 0 [ 329] sched: process_cpu_accounting pid=49 runtime_ns=4897831 context_switches=1 [ 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 [ 333] syscall: unknown syscall 0 [ 333] sched: process_cpu_accounting pid=50 runtime_ns=5266573 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 [ 334] proc: spawned process 51 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 334] proc: process 51 session context profile='system' for request 'cap-slot-leak' [ 334] sched: added process 51 [ 335] sched: switch 2:1 -> 51:1 [ 335] syscall: unknown syscall 0 [ 336] sched: process_cpu_accounting pid=51 runtime_ns=5267539 context_switches=2 [ 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=4893855 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 [ 341] proc: spawned process 53 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 341] proc: process 53 session context profile='system' for request 'cap-slot-leak' [ 341] sched: added process 53 [ 342] 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 [ 343] 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 [ 344] sched: process_cpu_accounting pid=53 runtime_ns=20906725 context_switches=3 [ 344] proc: process 53 exited with code 0 [ 344] sched: switch to 2:1 [ 345] 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 [ 347] 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=20931827 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 [ 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] 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=20900915 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=20952147 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 [ 361] syscall: unknown syscall 0 [ 361] 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 [ 362] pid=57 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 363] sched: process_cpu_accounting pid=57 runtime_ns=20923855 context_switches=3 [ 363] proc: process 57 exited with code 0 [ 363] sched: switch to 2:1 [ 364] sched: off-stack process stack release pid=57 stacks=1 reason=deferred-process-drop proof_result=ok [ 364] proc: spawned process 58 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 364] proc: process 58 session context profile='system' for request 'cap-slot-leak' [ 364] sched: added process 58 [ 365] sched: switch 2:1 -> 58:1 [ 366] syscall: unknown syscall 0 [ 366] pid=58 invalid submission err=-4 opcode=0 cap_id_bucket=0 cause=cap-not-found [ 366] sched: process_cpu_accounting pid=58 runtime_ns=10369663 context_switches=2 [ 366] proc: process 58 exited with code 0 [ 366] pid=58 invalid submissions suppressed=2 last_err=-4 last_cause=cap-not-found reason=process-exit [ 366] sched: switch to 2:1 [ 367] sched: off-stack process stack release pid=58 stacks=1 reason=deferred-process-drop proof_result=ok [ 368] proc: spawned process 59 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 368] proc: process 59 session context profile='system' for request 'cap-slot-leak' [ 368] sched: added process 59 [ 369] sched: switch 2:1 -> 59:1 [ 369] syscall: unknown syscall 0 [ 369] sched: process_cpu_accounting pid=59 runtime_ns=4901512 context_switches=1 [ 369] proc: process 59 exited with code 0 [ 369] pid=59 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 369] sched: switch to 2:1 [ 370] sched: off-stack process stack release pid=59 stacks=1 reason=deferred-process-drop proof_result=ok [ 371] proc: spawned process 60 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 371] proc: process 60 session context profile='system' for request 'cap-slot-leak' [ 371] sched: added process 60 [ 372] sched: switch 2:1 -> 60:1 [ 373] syscall: unknown syscall 0 [ 373] sched: process_cpu_accounting pid=60 runtime_ns=5380222 context_switches=2 [ 373] proc: process 60 exited with code 0 [ 373] pid=60 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 373] sched: switch to 2:1 [ 374] sched: off-stack process stack release pid=60 stacks=1 reason=deferred-process-drop proof_result=ok [ 374] proc: spawned process 61 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 374] proc: process 61 session context profile='system' for request 'cap-slot-leak' [ 374] sched: added process 61 [ 375] sched: switch 2:1 -> 61:1 [ 375] syscall: unknown syscall 0 [ 376] sched: process_cpu_accounting pid=61 runtime_ns=5261492 context_switches=2 [ 376] proc: process 61 exited with code 0 [ 376] pid=61 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 376] sched: switch to 2:1 [ 377] sched: off-stack process stack release pid=61 stacks=1 reason=deferred-process-drop proof_result=ok [ 378] proc: spawned process 62 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 378] proc: process 62 session context profile='system' for request 'cap-slot-leak' [ 378] sched: added process 62 [ 379] sched: switch 2:1 -> 62:1 [ 379] syscall: unknown syscall 0 [ 380] sched: process_cpu_accounting pid=62 runtime_ns=5281417 context_switches=2 [ 380] proc: process 62 exited with code 0 [ 380] pid=62 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 380] sched: switch to 2:1 [ 381] sched: off-stack process stack release pid=62 stacks=1 reason=deferred-process-drop proof_result=ok [ 382] proc: spawned process 63 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 382] proc: process 63 session context profile='system' for request 'cap-slot-leak' [ 382] sched: added process 63 [ 383] sched: switch 2:1 -> 63:1 [ 383] syscall: unknown syscall 0 [ 383] sched: process_cpu_accounting pid=63 runtime_ns=4882074 context_switches=1 [ 383] proc: process 63 exited with code 0 [ 383] pid=63 invalid submissions suppressed=3 last_err=-4 last_cause=cap-not-found reason=process-exit [ 383] sched: switch to 2:1 [ 384] sched: off-stack process stack release pid=63 stacks=1 reason=deferred-process-drop proof_result=ok [ 385] proc: spawned process 64 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 385] proc: process 64 session context profile='system' for request 'cap-slot-leak' [ 385] sched: added process 64 [ 386] sched: switch 2:1 -> 64:1 [ 387] syscall: unknown syscall 0 [ 387] sched: process_cpu_accounting pid=64 runtime_ns=5217360 context_switches=2 [ 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 [ 388] proc: spawned process 65 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 388] proc: process 65 session context profile='system' for request 'cap-slot-leak' [ 388] sched: added process 65 [ 389] sched: switch 2:1 -> 65:1 [ 389] syscall: unknown syscall 0 [ 390] sched: process_cpu_accounting pid=65 runtime_ns=5222050 context_switches=2 [ 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=2755277979 context_switches=178 [ 392] proc: process 2 exited with code 0 [ 392] sched: last process exited, halting measure: ring dispatches=1146 sqes=5514 nop_sqes=4227 measure: sqe_throughput sqes=4096 elapsed_ns=66057872 ops_per_second=62006 measure: serial bytes=84415 measure: timer interrupts=392 user_scheduler=369 kernel_only=23 bsp_tick_advances=392 measure: tlb cr3_writes=399 pending_flush_checks=3121 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=5521 cycles=7560018388 avg=1369320 measure: segment sqe_validation count=6380 cycles=44980397 avg=7050 measure: segment cap_lookup count=1696 cycles=981518542 avg=578725 measure: segment capnp_decode_encode count=650 cycles=4064806 avg=6253 measure: segment method_body count=764 cycles=6367563309 avg=8334506 measure: segment null_cap_empty count=80 cycles=4936 avg=61 measure: segment null_cap_schema count=80 cycles=342635 avg=4282 measure: schema_dispatch_overhead null_empty_count=80 null_empty_avg=61 null_schema_count=80 null_schema_avg=4282 overhead_cycles=4221 measure: cap_slot_memory slot_bytes=80 max_slots=256 max_slot_storage_bytes=20480 measure: segment cqe_post count=5502 cycles=1589647 avg=288 measure: segment waiter_wake_check count=5489 cycles=23672603 avg=4312 measure: segment sched_choose_next count=638 cycles=53287981 avg=83523 measure: direct_ipc_ready_to_select count=39 cycles=15490712 avg=397197 min=382143 max=456802 measure: endpoint_scheduler_matched direct_count=32 direct_cycles=12756213 direct_avg=398631 ordinary_count=31 ordinary_cycles=12251021 ordinary_avg=395194 measure: segment schedule_save_requeue count=369 cycles=64638319 avg=175171 measure: segment timer_sleep_wake count=1031 cycles=177475 avg=172 measure: segment park_wake count=1031 cycles=7410658 avg=7187 measure: segment cap_wait_wake_scan count=1043 cycles=2634630 avg=2526 measure: segment thread_exit_join_cleanup count=87 cycles=193982077 avg=2229679 measure: segment process_exit_cleanup count=64 cycles=720282549 avg=11254414 measure: segment process_drop count=63 cycles=1157740175 avg=18376828 measure: scheduler choose_direct_candidates=39 choose_run_queue_candidates=574 choose_idle_candidates=8 choose_runnable=621 choose_retry=0 choose_drop=0 wake_scans=244 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=25160 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=4941552647 measure: scheduler_lock_site schedule_pre_ring acquisitions=1155 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=215135901 measure: scheduler_lock_site schedule_select acquisitions=369 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=959370905 measure: scheduler_lock_site block_current acquisitions=8150 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=1338954160 measure: scheduler_lock_site wake_unblock acquisitions=5524 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=23576311 measure: scheduler_lock_site metadata acquisitions=9466 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=514410695 measure: shared_kernel_lock frame_alloc acquisitions=53620 contended=0 spin_loops=0 measure: shared_kernel_lock frame_free acquisitions=52796 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=373 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=3882 contended=0 spin_loops=0 measure: shared_kernel_lock heap acquisitions=5463 contended=0 spin_loops=0 measure: user_pc_samples total=0 overflow=0