[ 0] capos kernel starting... [ 0] smp: BSP per-cpu active cpu=0 lapic=0 base=0xffffffff81254900 syscall_rsp=0xffffffff8138ebf0 [ 0] syscall: entry at 0xffffffff804b4d0c [ 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 - 0x000000000a255000 0 [ 0] 0x000000000a255000 - 0x000000000a297000 6 [ 0] 0x000000000a297000 - 0x000000000a298000 5 [ 0] 0x000000000a298000 - 0x000000000a299000 0 [ 0] 0x000000000a299000 - 0x000000000a29a000 5 [ 0] 0x000000000a29a000 - 0x000000000a29b000 0 [ 0] 0x000000000a29b000 - 0x000000000a2a4000 5 [ 0] 0x000000000a2a4000 - 0x000000000b63d000 6 [ 0] 0x000000000b63d000 - 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 (161 MB physical), bitmap at 0x53000 (8168 bytes) [ 0] heap: 98304 KB at virt 0xffff800000100000 [ 0] mem: frame allocator + heap initialized (16817 usable frames) [ 0] alloc test: [1, 2, 3, 4, 5] [ 0] paging: kernel sections: [ 0] .text: 0xffffffff80000000 - 0xffffffff80872f5f [ 0] .rodata: 0xffffffff80873000 - 0xffffffff809e96e8 [ 0] .data: 0xffffffff809ea000 - 0xffffffff81253ea0 [ 0] .bss: 0xffffffff81254000 - 0xffffffff81398bf0 [ 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=0xffffffff802aa2e0 kernel_rsp=0xffff800006130000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=1 entry=0xffffffff802aa2e0 kernel_rsp=0xffff800006150000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=2 entry=0xffffffff802aa2e0 kernel_rsp=0xffff800006170000 cs=0x8 ss=0x10 [ 0] sched: CPL0 idle context cpu=3 entry=0xffffffff802aa2e0 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=629506 divide=16 calibrated_hz=100 clocksource=tsc-calibrated calibration_ns=10000150 tsc_delta=28106558 [ 0] clockevent: proof backend=lapic oneshot=programmed deadline_ns=14570393 delta_ns=5000000 count=314753 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=5096467 count=314753 count_after_program=313087 periodic_initial_count=629506 within_tolerance=true restored_periodic=true periodic_live=true [ 0] clockevent-floor: clocksource=tsc real_ns=5000010 monotonic_delta_ns=5000075 tick_ns=10000000 floored=false subtick_tracked=true [ 0] smp: no AP slots prepared; AP bootstrap skipped [ 0] manifest: loaded 268112 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 (725048 bytes) [ 0] binary 'init': 725048 bytes, entry 0x217f50, 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=21310 KiB free=76993 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 [ 6] ring: capability application exception: Message ends prematurely. Header claimed 4 words, but message only has 1 words [ 7] ring: capability application exception: Failed: result buffer too small [ 7] ring: failed to serialize CapException into result buffer: Failed: result buffer too small [ 8] ring: cap lookup error: capability not found [ 8] ring: endpoint RETURN error: Unimplemented: capability is not an endpoint [ring-nop] CAP_OP_NOP smoke ok. [ring-nop] measure avg cycles: nop=34010 null_empty=37275 null_small=44428 [ 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 [ 14] ring: capability application exception: Failed: ThreadSpawner entry must be a mapped executable user address [ 15] ring: capability application exception: Failed: ThreadSpawner stackTop must be a mapped writable 16-byte-aligned user address [ 16] sched: switch 4:1 -> 3:1 [ 17] sched: switch 3:1 -> 4:1 [ 18] sched: switch 4:1 -> 4:2 [ 20] sched: switch 4:2 -> 3:1 [ 21] sched: switch 3:1 -> 4:2 [ 22] sched: switch 4:2 -> 4:1 [ 22] sched: blocked 4:1 -> 4:2 [ 23] sched: switch 4:2 -> 4:1 [ 23] sched: blocked 4:1 -> 3:1 [ 24] sched: switch 3:1 -> 4:2 [ 24] sched: switch to 4:1 [ 24] ring: capability application exception: Failed: ThreadHandle.join already consumed [ 25] sched: off-stack thread stack release pid=4 tid=2 reason=thread-exit proof_result=ok [ 25] sched: switch 4:1 -> 3:1 [ 27] sched: switch 3:1 -> 4:1 [ 28] sched: switch 4:1 -> 4:3 [ 28] sched: switch to 3:1 [ring-nop] park bench avg cycles: compact_wait_miss=36358 generic_wait_miss=5077104 compact_wake_empty=1471591 generic_wake_empty=3539166 [ 29] sched: off-stack thread stack release pid=4 tid=3 reason=thread-exit proof_result=ok [ 29] sched: switch 3:1 -> 4:1 [ 31] sched: switch 4:1 -> 4:4 [ 33] sched: switch 4:4 -> 4:1 [ 33] sched: blocked 4:1 -> 4:4 [ 34] sched: switch 4:4 -> 4:1 [ 35] sched: switch 4:1 -> 3:1 [ 35] sched: process_cpu_accounting pid=3 runtime_ns=128319929 context_switches=14 [ 35] proc: process 3 exited with code 0 [ 35] sched: switch to 4:4 [ 36] sched: off-stack process stack release pid=3 stacks=1 reason=deferred-process-drop proof_result=ok [ 36] sched: switch 4:4 -> 4:1 [ 38] sched: switch 4:1 -> 2:1 [ 38] proc: spawned process 5 for request 'unprivileged-stranger' (binary='unprivileged-stranger', 0 caps) [ 38] proc: process 5 session context profile='system' for request 'unprivileged-stranger' [ 38] sched: added process 5 [ 39] sched: switch 2:1 -> 5:1 [ 40] syscall: unknown syscall 0 [ 40] ring: cap lookup error: capability not found [ 41] ring: cap lookup error: capability not found [ 41] ring: cap lookup error: capability not found [ 42] sched: switch 5:1 -> 4:4 [ 42] sched: blocked 4:4 -> 4:1 [ 43] sched: switch 4:1 -> 4:4 [ 43] sched: switch to 5:1 [ 43] sched: off-stack thread stack release pid=4 tid=4 reason=thread-exit proof_result=ok [ 43] sched: process_cpu_accounting pid=5 runtime_ns=30547124 context_switches=4 [ 43] proc: process 5 exited with code 0 [ 43] sched: switch to 4:1 [ 44] sched: off-stack process stack release pid=5 stacks=1 reason=deferred-process-drop proof_result=ok [thread-lifecycle] park handoff wake retry ok. [ 47] sched: switch 4:1 -> 4:6 [ 47] sched: blocked 4:6 -> 4:5 [ 47] sched: blocked 4:5 -> 4:1 [ 47] sched: blocked 4:1 -> 2:1 [init] Generic manifest child wait ok: unprivileged-stranger [ 48] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 48] sched: blocked 2:1 -> 1:1 [ 49] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=1 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 50] sched: cpl0-idle cpu=0 starting thread 4:1 [ 51] sched: switch 4:1 -> 4:5 [ 51] sched: switch to 4:6 [ 51] sched: off-stack thread stack release pid=4 tid=5 reason=thread-exit proof_result=ok [ 51] sched: switch to 4:1 [ 52] sched: off-stack thread stack release pid=4 tid=6 reason=thread-exit proof_result=ok [ 54] sched: switch 4:1 -> 4:8 [ 54] sched: blocked 4:8 -> 4:7 [ 54] sched: blocked 4:7 -> 4:1 [ 54] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 54] sched: blocked 4:1 -> 1:1 [ 55] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=2 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 56] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=3 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 57] sched: cpl0-idle cpu=0 starting thread 4:1 [ 58] sched: switch 4:1 -> 4:7 [ 58] sched: switch to 4:8 [ 58] sched: off-stack thread stack release pid=4 tid=7 reason=thread-exit proof_result=ok [ 58] sched: switch to 4:1 [ 59] sched: off-stack thread stack release pid=4 tid=8 reason=thread-exit proof_result=ok [thread-lifecycle] park multi-waiter unmap reuse cleanup ok. [ 61] sched: switch 4:1 -> 4:9 [ 61] sched: blocked 4:9 -> 4:1 [ 61] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 61] sched: blocked 4:1 -> 1:1 [ 62] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=4 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 63] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=5 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 64] sched: cpl0-idle cpu=0 starting thread 4:1 [ 65] sched: switch 4:1 -> 4:9 [ 65] sched: switch to 4:1 [ 66] sched: off-stack thread stack release pid=4 tid=9 reason=thread-exit proof_result=ok [ 66] sched: switch 4:1 -> 4:10 [ 66] sched: blocked 4:10 -> 4:1 [ 67] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 67] sched: blocked 4:1 -> 1:1 [ 67] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=6 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 68] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=7 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 69] sched: cpl0-idle cpu=0 starting thread 4:1 [ 71] sched: switch 4:1 -> 4:10 [ 71] sched: switch to 4:1 [thread-lifecycle] park unmap/decommit/memoryobject cleanup ok. [ 72] sched: off-stack thread stack release pid=4 tid=10 reason=thread-exit proof_result=ok [ 73] sched: switch 4:1 -> 4:11 [ 73] sched: blocked 4:11 -> 4:1 [ 73] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 73] sched: blocked 4:1 -> 1:1 [ 74] cpu-isolation: kernel-idle hlt cpu=0 idle_path=cooperative-cpl0 entries=8 nohz_active=false timer_source=periodic-tick tickless_idle_active=false [ 76] sched: cpl0-idle cpu=0 starting thread 4:1 [ 77] sched: switch 4:1 -> 4:11 [ 80] sched: switch 4:11 -> 4:1 [ 81] sched: switch 4:1 -> 4:11 [ 81] sched: blocked 4:11 -> 4:1 [ 81] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 81] sched: blocked 4:1 -> 1:1 [ 84] sched: cpl0-idle cpu=0 starting thread 4:1 [ 85] sched: switch 4:1 -> 4:11 [ 86] sched: switch 4:11 -> 4:1 [ 87] sched: switch 4:1 -> 4:11 [ 87] sched: blocked 4:11 -> 4:1 [ 87] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 87] sched: blocked 4:1 -> 1:1 [ 90] sched: cpl0-idle cpu=0 starting thread 4:1 [ 91] sched: switch 4:1 -> 4:11 [ 93] sched: switch 4:11 -> 4:1 [ 94] sched: switch 4:1 -> 4:11 [ 94] sched: blocked 4:11 -> 4:1 [ 94] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 94] sched: blocked 4:1 -> 1:1 [ 97] sched: cpl0-idle cpu=0 starting thread 4:1 [ 98] sched: switch 4:1 -> 4:11 [ 100] sched: switch 4:11 -> 4:1 [ 101] sched: switch 4:1 -> 4:11 [ 101] sched: blocked 4:11 -> 4:1 [ 101] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 101] sched: blocked 4:1 -> 1:1 [ 104] sched: cpl0-idle cpu=0 starting thread 4:1 [ 105] sched: switch 4:1 -> 4:11 [ 107] sched: switch 4:11 -> 4:1 [ 108] sched: switch 4:1 -> 4:11 [ 108] sched: blocked 4:11 -> 4:1 [ 108] sched: dispatch idle cpu=0 idle_path=cpl0-dispatch-block [ 108] sched: blocked 4:1 -> 1:1 [ 111] sched: cpl0-idle cpu=0 starting thread 4:1 [ 112] sched: switch 4:1 -> 4:11 [ 112] sched: switch to 4:1 [thread-lifecycle] park path avg cycles: failed_wait=3178199 empty_wake=238081 wait_to_block=88037545 wake_to_runnable=488932 wake_to_resume=24763866 [ 113] sched: off-stack thread stack release pid=4 tid=11 reason=thread-exit proof_result=ok [ 114] sched: blocked 4:1 -> 4:12 [ 114] sched: blocked 4:12 -> 4:1 [ 115] sched: blocked 4:1 -> 4:12 [ 115] sched: blocked 4:12 -> 4:1 [ 115] sched: blocked 4:1 -> 4:12 [ 115] sched: blocked 4:12 -> 4:1 [ 116] sched: blocked 4:1 -> 4:12 [ 116] sched: blocked 4:12 -> 4:1 [ 116] sched: blocked 4:1 -> 4:12 [ 117] sched: blocked 4:12 -> 4:1 [ 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 [ 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 [ 125] 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 [ 127] 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 [ 129] 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 [ 135] 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 [ 136] sched: blocked 4:1 -> 4:12 [ 136] sched: blocked 4:12 -> 4:1 [ 136] 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 [ 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 [ 139] 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 [ 140] sched: blocked 4:1 -> 4:12 [ 140] sched: blocked 4:12 -> 4:1 [ 140] 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 [ 141] sched: blocked 4:1 -> 4:12 [ 142] sched: blocked 4:12 -> 4:1 [ 142] sched: blocked 4:1 -> 4:12 [ 142] 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 [ 143] 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 [ 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 [ 146] 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 [ 148] 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 [ 149] sched: blocked 4:1 -> 4:12 [ 149] sched: blocked 4:12 -> 4:1 [ 149] 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 [ 150] sched: blocked 4:1 -> 4:12 [ 151] 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 [ 153] 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 [ 155] sched: blocked 4:12 -> 4:1 [ 155] sched: blocked 4:1 -> 4:12 [ 155] sched: switch to 4:1 [thread-lifecycle] direct IPC call-to-receiver avg cycles: 8046901 [ 156] sched: off-stack thread stack release pid=4 tid=12 reason=thread-exit proof_result=ok [thread-lifecycle] thread lifecycle checkpoint ok. [ 157] sched: process_cpu_accounting pid=4 runtime_ns=1033544246 context_switches=285 [ 157] proc: process 4 exited with code 0 [ 157] sched: switch to 2:1 [ 158] 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. [ 160] proc: spawned process 6 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 160] proc: process 6 session context profile='system' for request 'cap-slot-leak' [ 160] sched: added process 6 [ 161] sched: switch 2:1 -> 6:1 [ 162] syscall: unknown syscall 0 [ 162] ring: cap lookup error: capability not found [ 162] ring: cap lookup error: capability not found [ 163] ring: cap lookup error: capability not found [ 163] sched: process_cpu_accounting pid=6 runtime_ns=15120346 context_switches=3 [ 163] proc: process 6 exited with code 0 [ 163] sched: switch to 2:1 [ 164] sched: off-stack process stack release pid=6 stacks=1 reason=deferred-process-drop proof_result=ok [ 165] proc: spawned process 7 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 165] proc: process 7 session context profile='system' for request 'cap-slot-leak' [ 165] sched: added process 7 [ 166] sched: switch 2:1 -> 7:1 [ 166] syscall: unknown syscall 0 [ 167] ring: cap lookup error: capability not found [ 167] ring: cap lookup error: capability not found [ 167] ring: cap lookup error: capability not found [ 168] sched: process_cpu_accounting pid=7 runtime_ns=14973277 context_switches=3 [ 168] proc: process 7 exited with code 0 [ 168] sched: switch to 2:1 [ 169] sched: off-stack process stack release pid=7 stacks=1 reason=deferred-process-drop proof_result=ok [ 169] proc: spawned process 8 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 169] proc: process 8 session context profile='system' for request 'cap-slot-leak' [ 169] sched: added process 8 [ 170] sched: switch 2:1 -> 8:1 [ 170] syscall: unknown syscall 0 [ 170] ring: cap lookup error: capability not found [ 171] ring: cap lookup error: capability not found [ 171] ring: cap lookup error: capability not found [ 172] sched: process_cpu_accounting pid=8 runtime_ns=15315839 context_switches=3 [ 172] proc: process 8 exited with code 0 [ 172] sched: switch to 2:1 [ 173] sched: off-stack process stack release pid=8 stacks=1 reason=deferred-process-drop proof_result=ok [ 173] proc: spawned process 9 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 173] proc: process 9 session context profile='system' for request 'cap-slot-leak' [ 173] sched: added process 9 [ 174] sched: switch 2:1 -> 9:1 [ 174] syscall: unknown syscall 0 [ 174] ring: cap lookup error: capability not found [ 175] ring: cap lookup error: capability not found [ 175] ring: cap lookup error: capability not found [ 175] sched: process_cpu_accounting pid=9 runtime_ns=15211244 context_switches=2 [ 175] proc: process 9 exited with code 0 [ 175] sched: switch to 2:1 [ 176] sched: off-stack process stack release pid=9 stacks=1 reason=deferred-process-drop proof_result=ok [ 177] proc: spawned process 10 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 177] proc: process 10 session context profile='system' for request 'cap-slot-leak' [ 177] sched: added process 10 [ 178] sched: switch 2:1 -> 10:1 [ 178] syscall: unknown syscall 0 [ 178] ring: cap lookup error: capability not found [ 179] ring: cap lookup error: capability not found [ 179] ring: cap lookup error: capability not found [ 179] sched: process_cpu_accounting pid=10 runtime_ns=15302741 context_switches=2 [ 179] proc: process 10 exited with code 0 [ 179] sched: switch to 2:1 [ 180] sched: off-stack process stack release pid=10 stacks=1 reason=deferred-process-drop proof_result=ok [ 181] proc: spawned process 11 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 181] proc: process 11 session context profile='system' for request 'cap-slot-leak' [ 181] sched: added process 11 [ 182] sched: switch 2:1 -> 11:1 [ 182] syscall: unknown syscall 0 [ 182] ring: cap lookup error: capability not found [ 183] ring: cap lookup error: capability not found [ 183] ring: cap lookup error: capability not found [ 183] sched: process_cpu_accounting pid=11 runtime_ns=15206748 context_switches=2 [ 183] proc: process 11 exited with code 0 [ 183] sched: switch to 2:1 [ 184] sched: off-stack process stack release pid=11 stacks=1 reason=deferred-process-drop proof_result=ok [ 185] proc: spawned process 12 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 185] proc: process 12 session context profile='system' for request 'cap-slot-leak' [ 185] sched: added process 12 [ 186] sched: switch 2:1 -> 12:1 [ 186] syscall: unknown syscall 0 [ 186] ring: cap lookup error: capability not found [ 186] ring: cap lookup error: capability not found [ 187] ring: cap lookup error: capability not found [ 187] sched: process_cpu_accounting pid=12 runtime_ns=14933518 context_switches=2 [ 187] proc: process 12 exited with code 0 [ 187] sched: switch to 2:1 [ 188] sched: off-stack process stack release pid=12 stacks=1 reason=deferred-process-drop proof_result=ok [ 189] proc: spawned process 13 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 189] proc: process 13 session context profile='system' for request 'cap-slot-leak' [ 189] sched: added process 13 [ 190] sched: switch 2:1 -> 13:1 [ 191] syscall: unknown syscall 0 [ 191] ring: cap lookup error: capability not found [ 191] ring: cap lookup error: capability not found [ 192] ring: cap lookup error: capability not found [ 192] sched: process_cpu_accounting pid=13 runtime_ns=15479221 context_switches=3 [ 192] proc: process 13 exited with code 0 [ 192] sched: switch to 2:1 [ 193] sched: off-stack process stack release pid=13 stacks=1 reason=deferred-process-drop proof_result=ok [ 194] proc: spawned process 14 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 194] proc: process 14 session context profile='system' for request 'cap-slot-leak' [ 194] sched: added process 14 [ 195] sched: switch 2:1 -> 14:1 [ 196] syscall: unknown syscall 0 [ 196] ring: cap lookup error: capability not found [ 196] ring: cap lookup error: capability not found [ 196] ring: cap lookup error: capability not found [ 197] sched: process_cpu_accounting pid=14 runtime_ns=15404175 context_switches=3 [ 197] proc: process 14 exited with code 0 [ 197] sched: switch to 2:1 [ 198] sched: off-stack process stack release pid=14 stacks=1 reason=deferred-process-drop proof_result=ok [ 199] proc: spawned process 15 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 199] proc: process 15 session context profile='system' for request 'cap-slot-leak' [ 199] sched: added process 15 [ 200] sched: switch 2:1 -> 15:1 [ 200] syscall: unknown syscall 0 [ 201] ring: cap lookup error: capability not found [ 201] ring: cap lookup error: capability not found [ 201] ring: cap lookup error: capability not found [ 202] sched: process_cpu_accounting pid=15 runtime_ns=15256403 context_switches=3 [ 202] proc: process 15 exited with code 0 [ 202] sched: switch to 2:1 [ 203] 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 [ 204] syscall: unknown syscall 0 [ 205] ring: cap lookup error: capability not found [ 205] ring: cap lookup error: capability not found [ 205] ring: cap lookup error: capability not found [ 206] sched: process_cpu_accounting pid=16 runtime_ns=15372619 context_switches=3 [ 206] proc: process 16 exited with code 0 [ 206] sched: switch to 2:1 [ 207] sched: off-stack process stack release pid=16 stacks=1 reason=deferred-process-drop proof_result=ok [ 207] proc: spawned process 17 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 207] proc: process 17 session context profile='system' for request 'cap-slot-leak' [ 207] sched: added process 17 [ 208] sched: switch 2:1 -> 17:1 [ 208] syscall: unknown syscall 0 [ 208] ring: cap lookup error: capability not found [ 209] ring: cap lookup error: capability not found [ 209] ring: cap lookup error: capability not found [ 209] sched: process_cpu_accounting pid=17 runtime_ns=14929520 context_switches=2 [ 209] proc: process 17 exited with code 0 [ 209] sched: switch to 2:1 [ 210] sched: off-stack process stack release pid=17 stacks=1 reason=deferred-process-drop proof_result=ok [ 211] proc: spawned process 18 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 211] proc: process 18 session context profile='system' for request 'cap-slot-leak' [ 211] sched: added process 18 [ 212] sched: switch 2:1 -> 18:1 [ 212] syscall: unknown syscall 0 [ 212] ring: cap lookup error: capability not found [ 213] ring: cap lookup error: capability not found [ 213] ring: cap lookup error: capability not found [ 213] sched: process_cpu_accounting pid=18 runtime_ns=15150499 context_switches=2 [ 213] proc: process 18 exited with code 0 [ 213] sched: switch to 2:1 [ 214] sched: off-stack process stack release pid=18 stacks=1 reason=deferred-process-drop proof_result=ok [ 215] proc: spawned process 19 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 215] proc: process 19 session context profile='system' for request 'cap-slot-leak' [ 215] sched: added process 19 [ 216] sched: switch 2:1 -> 19:1 [ 216] syscall: unknown syscall 0 [ 216] ring: cap lookup error: capability not found [ 217] ring: cap lookup error: capability not found [ 217] ring: cap lookup error: capability not found [ 218] sched: process_cpu_accounting pid=19 runtime_ns=15406154 context_switches=3 [ 218] proc: process 19 exited with code 0 [ 218] sched: switch to 2:1 [ 219] sched: off-stack process stack release pid=19 stacks=1 reason=deferred-process-drop proof_result=ok [ 219] proc: spawned process 20 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 219] proc: process 20 session context profile='system' for request 'cap-slot-leak' [ 219] sched: added process 20 [ 220] sched: switch 2:1 -> 20:1 [ 220] syscall: unknown syscall 0 [ 221] ring: cap lookup error: capability not found [ 221] ring: cap lookup error: capability not found [ 221] ring: cap lookup error: capability not found [ 222] sched: process_cpu_accounting pid=20 runtime_ns=15429190 context_switches=3 [ 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 [ 225] syscall: unknown syscall 0 [ 225] ring: cap lookup error: capability not found [ 225] ring: cap lookup error: capability not found [ 225] ring: cap lookup error: capability not found [ 226] sched: process_cpu_accounting pid=21 runtime_ns=15213132 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 [ 230] syscall: unknown syscall 0 [ 230] ring: cap lookup error: capability not found [ 230] ring: cap lookup error: capability not found [ 231] ring: cap lookup error: capability not found [ 231] sched: process_cpu_accounting pid=22 runtime_ns=15284225 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] ring: cap lookup error: capability not found [ 234] ring: cap lookup error: capability not found [ 235] ring: cap lookup error: capability not found [ 235] sched: process_cpu_accounting pid=23 runtime_ns=14896061 context_switches=2 [ 235] proc: process 23 exited with code 0 [ 235] sched: switch to 2:1 [ 236] sched: off-stack process stack release pid=23 stacks=1 reason=deferred-process-drop proof_result=ok [ 237] proc: spawned process 24 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 237] proc: process 24 session context profile='system' for request 'cap-slot-leak' [ 237] sched: added process 24 [ 238] sched: switch 2:1 -> 24:1 [ 238] syscall: unknown syscall 0 [ 238] ring: cap lookup error: capability not found [ 239] ring: cap lookup error: capability not found [ 239] ring: cap lookup error: capability not found [ 239] sched: process_cpu_accounting pid=24 runtime_ns=14932595 context_switches=2 [ 239] proc: process 24 exited with code 0 [ 239] sched: switch to 2:1 [ 240] sched: off-stack process stack release pid=24 stacks=1 reason=deferred-process-drop proof_result=ok [ 241] proc: spawned process 25 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 241] proc: process 25 session context profile='system' for request 'cap-slot-leak' [ 241] sched: added process 25 [ 242] sched: switch 2:1 -> 25:1 [ 242] syscall: unknown syscall 0 [ 242] ring: cap lookup error: capability not found [ 243] ring: cap lookup error: capability not found [ 243] ring: cap lookup error: capability not found [ 243] sched: process_cpu_accounting pid=25 runtime_ns=15017176 context_switches=2 [ 243] proc: process 25 exited with code 0 [ 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] ring: cap lookup error: capability not found [ 247] ring: cap lookup error: capability not found [ 247] ring: cap lookup error: capability not found [ 248] sched: process_cpu_accounting pid=26 runtime_ns=15204076 context_switches=3 [ 248] proc: process 26 exited with code 0 [ 248] sched: switch to 2:1 [ 249] sched: off-stack process stack release pid=26 stacks=1 reason=deferred-process-drop proof_result=ok [ 249] proc: spawned process 27 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 249] proc: process 27 session context profile='system' for request 'cap-slot-leak' [ 249] sched: added process 27 [ 250] sched: switch 2:1 -> 27:1 [ 250] syscall: unknown syscall 0 [ 251] ring: cap lookup error: capability not found [ 251] ring: cap lookup error: capability not found [ 251] ring: cap lookup error: capability not found [ 252] sched: process_cpu_accounting pid=27 runtime_ns=15486044 context_switches=3 [ 252] proc: process 27 exited with code 0 [ 252] sched: switch to 2:1 [ 253] sched: off-stack process stack release pid=27 stacks=1 reason=deferred-process-drop proof_result=ok [ 253] proc: spawned process 28 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 253] proc: process 28 session context profile='system' for request 'cap-slot-leak' [ 253] sched: added process 28 [ 254] sched: switch 2:1 -> 28:1 [ 255] syscall: unknown syscall 0 [ 255] ring: cap lookup error: capability not found [ 255] ring: cap lookup error: capability not found [ 255] ring: cap lookup error: capability not found [ 256] sched: process_cpu_accounting pid=28 runtime_ns=15191899 context_switches=3 [ 256] proc: process 28 exited with code 0 [ 256] sched: switch to 2:1 [ 257] sched: off-stack process stack release pid=28 stacks=1 reason=deferred-process-drop proof_result=ok [ 258] proc: spawned process 29 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 258] proc: process 29 session context profile='system' for request 'cap-slot-leak' [ 258] sched: added process 29 [ 259] sched: switch 2:1 -> 29:1 [ 259] syscall: unknown syscall 0 [ 259] ring: cap lookup error: capability not found [ 260] ring: cap lookup error: capability not found [ 260] ring: cap lookup error: capability not found [ 260] sched: process_cpu_accounting pid=29 runtime_ns=15576403 context_switches=2 [ 260] proc: process 29 exited with code 0 [ 260] sched: switch to 2:1 [ 261] sched: off-stack process stack release pid=29 stacks=1 reason=deferred-process-drop proof_result=ok [ 262] proc: spawned process 30 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 262] proc: process 30 session context profile='system' for request 'cap-slot-leak' [ 262] sched: added process 30 [ 263] sched: switch 2:1 -> 30:1 [ 263] syscall: unknown syscall 0 [ 264] ring: cap lookup error: capability not found [ 264] ring: cap lookup error: capability not found [ 264] ring: cap lookup error: capability not found [ 265] sched: process_cpu_accounting pid=30 runtime_ns=15665217 context_switches=3 [ 265] proc: process 30 exited with code 0 [ 265] sched: switch to 2:1 [ 266] sched: off-stack process stack release pid=30 stacks=1 reason=deferred-process-drop proof_result=ok [ 267] proc: spawned process 31 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 267] proc: process 31 session context profile='system' for request 'cap-slot-leak' [ 267] sched: added process 31 [ 268] sched: switch 2:1 -> 31:1 [ 269] syscall: unknown syscall 0 [ 269] ring: cap lookup error: capability not found [ 269] ring: cap lookup error: capability not found [ 270] ring: cap lookup error: capability not found [ 270] sched: process_cpu_accounting pid=31 runtime_ns=15247120 context_switches=3 [ 270] proc: process 31 exited with code 0 [ 270] sched: switch to 2:1 [ 271] sched: off-stack process stack release pid=31 stacks=1 reason=deferred-process-drop proof_result=ok [ 272] proc: spawned process 32 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 272] proc: process 32 session context profile='system' for request 'cap-slot-leak' [ 272] sched: added process 32 [ 273] sched: switch 2:1 -> 32:1 [ 273] syscall: unknown syscall 0 [ 273] ring: cap lookup error: capability not found [ 273] ring: cap lookup error: capability not found [ 274] ring: cap lookup error: capability not found [ 274] sched: process_cpu_accounting pid=32 runtime_ns=14952249 context_switches=2 [ 274] proc: process 32 exited with code 0 [ 274] sched: switch to 2:1 [ 275] sched: off-stack process stack release pid=32 stacks=1 reason=deferred-process-drop proof_result=ok [ 276] proc: spawned process 33 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 276] proc: process 33 session context profile='system' for request 'cap-slot-leak' [ 276] sched: added process 33 [ 277] sched: switch 2:1 -> 33:1 [ 277] syscall: unknown syscall 0 [ 277] ring: cap lookup error: capability not found [ 278] ring: cap lookup error: capability not found [ 278] ring: cap lookup error: capability not found [ 278] sched: process_cpu_accounting pid=33 runtime_ns=15232559 context_switches=2 [ 278] proc: process 33 exited with code 0 [ 278] sched: switch to 2:1 [ 279] sched: off-stack process stack release pid=33 stacks=1 reason=deferred-process-drop proof_result=ok [ 280] proc: spawned process 34 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 280] proc: process 34 session context profile='system' for request 'cap-slot-leak' [ 280] sched: added process 34 [ 281] sched: switch 2:1 -> 34:1 [ 281] syscall: unknown syscall 0 [ 282] ring: cap lookup error: capability not found [ 282] ring: cap lookup error: capability not found [ 282] ring: cap lookup error: capability not found [ 283] sched: process_cpu_accounting pid=34 runtime_ns=15442526 context_switches=3 [ 283] proc: process 34 exited with code 0 [ 283] sched: switch to 2:1 [ 284] sched: off-stack process stack release pid=34 stacks=1 reason=deferred-process-drop proof_result=ok [ 285] proc: spawned process 35 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 285] proc: process 35 session context profile='system' for request 'cap-slot-leak' [ 285] sched: added process 35 [ 286] sched: switch 2:1 -> 35:1 [ 287] syscall: unknown syscall 0 [ 287] ring: cap lookup error: capability not found [ 287] ring: cap lookup error: capability not found [ 288] ring: cap lookup error: capability not found [ 288] sched: process_cpu_accounting pid=35 runtime_ns=15219704 context_switches=3 [ 288] proc: process 35 exited with code 0 [ 288] sched: switch to 2:1 [ 289] sched: off-stack process stack release pid=35 stacks=1 reason=deferred-process-drop proof_result=ok [ 290] proc: spawned process 36 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 290] proc: process 36 session context profile='system' for request 'cap-slot-leak' [ 290] sched: added process 36 [ 291] sched: switch 2:1 -> 36:1 [ 292] syscall: unknown syscall 0 [ 292] ring: cap lookup error: capability not found [ 292] ring: cap lookup error: capability not found [ 293] ring: cap lookup error: capability not found [ 293] sched: process_cpu_accounting pid=36 runtime_ns=15304690 context_switches=3 [ 293] proc: process 36 exited with code 0 [ 293] sched: switch to 2:1 [ 294] sched: off-stack process stack release pid=36 stacks=1 reason=deferred-process-drop proof_result=ok [ 295] proc: spawned process 37 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 295] proc: process 37 session context profile='system' for request 'cap-slot-leak' [ 295] sched: added process 37 [ 296] sched: switch 2:1 -> 37:1 [ 296] syscall: unknown syscall 0 [ 296] ring: cap lookup error: capability not found [ 296] ring: cap lookup error: capability not found [ 297] ring: cap lookup error: capability not found [ 297] sched: process_cpu_accounting pid=37 runtime_ns=15122622 context_switches=2 [ 297] proc: process 37 exited with code 0 [ 297] sched: switch to 2:1 [ 298] sched: off-stack process stack release pid=37 stacks=1 reason=deferred-process-drop proof_result=ok [ 299] proc: spawned process 38 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 299] proc: process 38 session context profile='system' for request 'cap-slot-leak' [ 299] sched: added process 38 [ 300] sched: switch 2:1 -> 38:1 [ 300] syscall: unknown syscall 0 [ 300] ring: cap lookup error: capability not found [ 301] ring: cap lookup error: capability not found [ 301] ring: cap lookup error: capability not found [ 301] sched: process_cpu_accounting pid=38 runtime_ns=15007526 context_switches=2 [ 301] proc: process 38 exited with code 0 [ 301] sched: switch to 2:1 [ 302] sched: off-stack process stack release pid=38 stacks=1 reason=deferred-process-drop proof_result=ok [ 303] proc: spawned process 39 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 303] proc: process 39 session context profile='system' for request 'cap-slot-leak' [ 303] sched: added process 39 [ 304] sched: switch 2:1 -> 39:1 [ 304] syscall: unknown syscall 0 [ 305] ring: cap lookup error: capability not found [ 305] ring: cap lookup error: capability not found [ 305] ring: cap lookup error: capability not found [ 306] sched: process_cpu_accounting pid=39 runtime_ns=15336738 context_switches=3 [ 306] proc: process 39 exited with code 0 [ 306] sched: switch to 2:1 [ 307] sched: off-stack process stack release pid=39 stacks=1 reason=deferred-process-drop proof_result=ok [ 307] proc: spawned process 40 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 307] proc: process 40 session context profile='system' for request 'cap-slot-leak' [ 307] sched: added process 40 [ 308] sched: switch 2:1 -> 40:1 [ 308] syscall: unknown syscall 0 [ 309] ring: cap lookup error: capability not found [ 309] ring: cap lookup error: capability not found [ 309] ring: cap lookup error: capability not found [ 310] sched: process_cpu_accounting pid=40 runtime_ns=15370869 context_switches=3 [ 310] proc: process 40 exited with code 0 [ 310] sched: switch to 2:1 [ 311] sched: off-stack process stack release pid=40 stacks=1 reason=deferred-process-drop proof_result=ok [ 312] proc: spawned process 41 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 312] proc: process 41 session context profile='system' for request 'cap-slot-leak' [ 312] sched: added process 41 [ 313] sched: switch 2:1 -> 41:1 [ 314] syscall: unknown syscall 0 [ 314] ring: cap lookup error: capability not found [ 314] ring: cap lookup error: capability not found [ 315] ring: cap lookup error: capability not found [ 315] sched: process_cpu_accounting pid=41 runtime_ns=15480114 context_switches=3 [ 315] proc: process 41 exited with code 0 [ 315] sched: switch to 2:1 [ 316] sched: off-stack process stack release pid=41 stacks=1 reason=deferred-process-drop proof_result=ok [ 317] proc: spawned process 42 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 317] proc: process 42 session context profile='system' for request 'cap-slot-leak' [ 317] sched: added process 42 [ 318] sched: switch 2:1 -> 42:1 [ 318] syscall: unknown syscall 0 [ 318] ring: cap lookup error: capability not found [ 318] ring: cap lookup error: capability not found [ 319] ring: cap lookup error: capability not found [ 319] sched: process_cpu_accounting pid=42 runtime_ns=15083126 context_switches=2 [ 319] proc: process 42 exited with code 0 [ 319] sched: switch to 2:1 [ 320] sched: off-stack process stack release pid=42 stacks=1 reason=deferred-process-drop proof_result=ok [ 321] proc: spawned process 43 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 321] proc: process 43 session context profile='system' for request 'cap-slot-leak' [ 321] sched: added process 43 [ 322] sched: switch 2:1 -> 43:1 [ 322] syscall: unknown syscall 0 [ 322] ring: cap lookup error: capability not found [ 323] ring: cap lookup error: capability not found [ 323] ring: cap lookup error: capability not found [ 323] sched: process_cpu_accounting pid=43 runtime_ns=15165064 context_switches=2 [ 323] proc: process 43 exited with code 0 [ 323] sched: switch to 2:1 [ 324] sched: off-stack process stack release pid=43 stacks=1 reason=deferred-process-drop proof_result=ok [ 325] proc: spawned process 44 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 325] proc: process 44 session context profile='system' for request 'cap-slot-leak' [ 325] sched: added process 44 [ 326] sched: switch 2:1 -> 44:1 [ 326] syscall: unknown syscall 0 [ 327] ring: cap lookup error: capability not found [ 327] ring: cap lookup error: capability not found [ 327] ring: cap lookup error: capability not found [ 328] sched: process_cpu_accounting pid=44 runtime_ns=15521679 context_switches=3 [ 328] proc: process 44 exited with code 0 [ 328] sched: switch to 2:1 [ 329] sched: off-stack process stack release pid=44 stacks=1 reason=deferred-process-drop proof_result=ok [ 330] proc: spawned process 45 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 330] proc: process 45 session context profile='system' for request 'cap-slot-leak' [ 330] sched: added process 45 [ 331] sched: switch 2:1 -> 45:1 [ 331] syscall: unknown syscall 0 [ 331] ring: cap lookup error: capability not found [ 331] ring: cap lookup error: capability not found [ 332] ring: cap lookup error: capability not found [ 332] sched: process_cpu_accounting pid=45 runtime_ns=14974919 context_switches=2 [ 332] proc: process 45 exited with code 0 [ 332] sched: switch to 2:1 [ 333] sched: off-stack process stack release pid=45 stacks=1 reason=deferred-process-drop proof_result=ok [ 334] proc: spawned process 46 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 334] proc: process 46 session context profile='system' for request 'cap-slot-leak' [ 334] sched: added process 46 [ 335] sched: switch 2:1 -> 46:1 [ 335] syscall: unknown syscall 0 [ 335] ring: cap lookup error: capability not found [ 335] ring: cap lookup error: capability not found [ 336] ring: cap lookup error: capability not found [ 336] sched: process_cpu_accounting pid=46 runtime_ns=15077551 context_switches=2 [ 336] proc: process 46 exited with code 0 [ 336] sched: switch to 2:1 [ 337] sched: off-stack process stack release pid=46 stacks=1 reason=deferred-process-drop proof_result=ok [ 338] proc: spawned process 47 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 338] proc: process 47 session context profile='system' for request 'cap-slot-leak' [ 338] sched: added process 47 [ 339] sched: switch 2:1 -> 47:1 [ 339] syscall: unknown syscall 0 [ 340] ring: cap lookup error: capability not found [ 340] ring: cap lookup error: capability not found [ 340] ring: cap lookup error: capability not found [ 341] sched: process_cpu_accounting pid=47 runtime_ns=16248289 context_switches=3 [ 341] proc: process 47 exited with code 0 [ 341] sched: switch to 2:1 [ 342] sched: off-stack process stack release pid=47 stacks=1 reason=deferred-process-drop proof_result=ok [ 343] proc: spawned process 48 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 343] proc: process 48 session context profile='system' for request 'cap-slot-leak' [ 343] sched: added process 48 [ 344] sched: switch 2:1 -> 48:1 [ 344] syscall: unknown syscall 0 [ 344] ring: cap lookup error: capability not found [ 344] ring: cap lookup error: capability not found [ 345] ring: cap lookup error: capability not found [ 345] sched: process_cpu_accounting pid=48 runtime_ns=15499751 context_switches=2 [ 345] proc: process 48 exited with code 0 [ 345] sched: switch to 2:1 [ 346] sched: off-stack process stack release pid=48 stacks=1 reason=deferred-process-drop proof_result=ok [ 347] proc: spawned process 49 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 347] proc: process 49 session context profile='system' for request 'cap-slot-leak' [ 347] sched: added process 49 [ 348] sched: switch 2:1 -> 49:1 [ 348] syscall: unknown syscall 0 [ 349] ring: cap lookup error: capability not found [ 349] ring: cap lookup error: capability not found [ 349] ring: cap lookup error: capability not found [ 350] sched: process_cpu_accounting pid=49 runtime_ns=17386051 context_switches=3 [ 350] proc: process 49 exited with code 0 [ 350] sched: switch to 2:1 [ 351] sched: off-stack process stack release pid=49 stacks=1 reason=deferred-process-drop proof_result=ok [ 352] proc: spawned process 50 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 352] proc: process 50 session context profile='system' for request 'cap-slot-leak' [ 352] sched: added process 50 [ 353] sched: switch 2:1 -> 50:1 [ 353] syscall: unknown syscall 0 [ 353] ring: cap lookup error: capability not found [ 354] ring: cap lookup error: capability not found [ 354] ring: cap lookup error: capability not found [ 354] sched: process_cpu_accounting pid=50 runtime_ns=16229514 context_switches=2 [ 354] proc: process 50 exited with code 0 [ 354] sched: switch to 2:1 [ 355] sched: off-stack process stack release pid=50 stacks=1 reason=deferred-process-drop proof_result=ok [ 356] proc: spawned process 51 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 356] proc: process 51 session context profile='system' for request 'cap-slot-leak' [ 356] sched: added process 51 [ 357] sched: switch 2:1 -> 51:1 [ 357] syscall: unknown syscall 0 [ 358] ring: cap lookup error: capability not found [ 358] ring: cap lookup error: capability not found [ 358] ring: cap lookup error: capability not found [ 359] sched: process_cpu_accounting pid=51 runtime_ns=15814046 context_switches=3 [ 359] proc: process 51 exited with code 0 [ 359] sched: switch to 2:1 [ 360] sched: off-stack process stack release pid=51 stacks=1 reason=deferred-process-drop proof_result=ok [ 361] proc: spawned process 52 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 361] proc: process 52 session context profile='system' for request 'cap-slot-leak' [ 361] sched: added process 52 [ 362] sched: switch 2:1 -> 52:1 [ 362] syscall: unknown syscall 0 [ 362] ring: cap lookup error: capability not found [ 363] ring: cap lookup error: capability not found [ 363] ring: cap lookup error: capability not found [ 363] sched: process_cpu_accounting pid=52 runtime_ns=16349918 context_switches=2 [ 363] proc: process 52 exited with code 0 [ 363] sched: switch to 2:1 [ 364] sched: off-stack process stack release pid=52 stacks=1 reason=deferred-process-drop proof_result=ok [ 365] proc: spawned process 53 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 365] proc: process 53 session context profile='system' for request 'cap-slot-leak' [ 365] sched: added process 53 [ 366] sched: switch 2:1 -> 53:1 [ 366] syscall: unknown syscall 0 [ 367] ring: cap lookup error: capability not found [ 367] ring: cap lookup error: capability not found [ 367] ring: cap lookup error: capability not found [ 368] sched: process_cpu_accounting pid=53 runtime_ns=15636824 context_switches=3 [ 368] proc: process 53 exited with code 0 [ 368] sched: switch to 2:1 [ 369] sched: off-stack process stack release pid=53 stacks=1 reason=deferred-process-drop proof_result=ok [ 370] proc: spawned process 54 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 370] proc: process 54 session context profile='system' for request 'cap-slot-leak' [ 370] sched: added process 54 [ 371] sched: switch 2:1 -> 54:1 [ 371] syscall: unknown syscall 0 [ 372] ring: cap lookup error: capability not found [ 372] ring: cap lookup error: capability not found [ 373] ring: cap lookup error: capability not found [ 373] sched: process_cpu_accounting pid=54 runtime_ns=20526359 context_switches=3 [ 373] proc: process 54 exited with code 0 [ 373] sched: switch to 2:1 [ 374] sched: off-stack process stack release pid=54 stacks=1 reason=deferred-process-drop proof_result=ok [ 376] proc: spawned process 55 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 376] proc: process 55 session context profile='system' for request 'cap-slot-leak' [ 376] sched: added process 55 [ 377] sched: switch 2:1 -> 55:1 [ 377] syscall: unknown syscall 0 [ 378] ring: cap lookup error: capability not found [ 378] ring: cap lookup error: capability not found [ 379] ring: cap lookup error: capability not found [ 379] sched: process_cpu_accounting pid=55 runtime_ns=20627243 context_switches=3 [ 379] proc: process 55 exited with code 0 [ 379] sched: switch to 2:1 [ 380] sched: off-stack process stack release pid=55 stacks=1 reason=deferred-process-drop proof_result=ok [ 381] proc: spawned process 56 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 381] proc: process 56 session context profile='system' for request 'cap-slot-leak' [ 381] sched: added process 56 [ 382] sched: switch 2:1 -> 56:1 [ 383] syscall: unknown syscall 0 [ 383] ring: cap lookup error: capability not found [ 383] ring: cap lookup error: capability not found [ 384] ring: cap lookup error: capability not found [ 384] sched: process_cpu_accounting pid=56 runtime_ns=15333976 context_switches=3 [ 384] proc: process 56 exited with code 0 [ 384] sched: switch to 2:1 [ 385] sched: off-stack process stack release pid=56 stacks=1 reason=deferred-process-drop proof_result=ok [ 386] proc: spawned process 57 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 386] proc: process 57 session context profile='system' for request 'cap-slot-leak' [ 386] sched: added process 57 [ 387] sched: switch 2:1 -> 57:1 [ 387] syscall: unknown syscall 0 [ 387] ring: cap lookup error: capability not found [ 387] ring: cap lookup error: capability not found [ 388] ring: cap lookup error: capability not found [ 388] sched: process_cpu_accounting pid=57 runtime_ns=14937742 context_switches=2 [ 388] proc: process 57 exited with code 0 [ 388] sched: switch to 2:1 [ 389] sched: off-stack process stack release pid=57 stacks=1 reason=deferred-process-drop proof_result=ok [ 390] proc: spawned process 58 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 390] proc: process 58 session context profile='system' for request 'cap-slot-leak' [ 390] sched: added process 58 [ 391] sched: switch 2:1 -> 58:1 [ 391] syscall: unknown syscall 0 [ 391] ring: cap lookup error: capability not found [ 392] ring: cap lookup error: capability not found [ 392] ring: cap lookup error: capability not found [ 392] sched: process_cpu_accounting pid=58 runtime_ns=14947017 context_switches=2 [ 392] proc: process 58 exited with code 0 [ 392] sched: switch to 2:1 [ 393] sched: off-stack process stack release pid=58 stacks=1 reason=deferred-process-drop proof_result=ok [ 394] proc: spawned process 59 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 394] proc: process 59 session context profile='system' for request 'cap-slot-leak' [ 394] sched: added process 59 [ 395] sched: switch 2:1 -> 59:1 [ 395] syscall: unknown syscall 0 [ 395] ring: cap lookup error: capability not found [ 396] ring: cap lookup error: capability not found [ 396] ring: cap lookup error: capability not found [ 396] sched: process_cpu_accounting pid=59 runtime_ns=14854410 context_switches=2 [ 396] proc: process 59 exited with code 0 [ 396] sched: switch to 2:1 [ 397] sched: off-stack process stack release pid=59 stacks=1 reason=deferred-process-drop proof_result=ok [ 398] proc: spawned process 60 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 398] proc: process 60 session context profile='system' for request 'cap-slot-leak' [ 398] sched: added process 60 [ 399] sched: switch 2:1 -> 60:1 [ 399] syscall: unknown syscall 0 [ 400] ring: cap lookup error: capability not found [ 400] ring: cap lookup error: capability not found [ 400] ring: cap lookup error: capability not found [ 401] sched: process_cpu_accounting pid=60 runtime_ns=15238205 context_switches=3 [ 401] proc: process 60 exited with code 0 [ 401] sched: switch to 2:1 [ 402] sched: off-stack process stack release pid=60 stacks=1 reason=deferred-process-drop proof_result=ok [ 402] proc: spawned process 61 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 402] proc: process 61 session context profile='system' for request 'cap-slot-leak' [ 402] sched: added process 61 [ 403] sched: switch 2:1 -> 61:1 [ 403] syscall: unknown syscall 0 [ 404] ring: cap lookup error: capability not found [ 404] ring: cap lookup error: capability not found [ 404] ring: cap lookup error: capability not found [ 405] sched: process_cpu_accounting pid=61 runtime_ns=15326596 context_switches=3 [ 405] proc: process 61 exited with code 0 [ 405] sched: switch to 2:1 [ 406] sched: off-stack process stack release pid=61 stacks=1 reason=deferred-process-drop proof_result=ok [ 406] proc: spawned process 62 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 406] proc: process 62 session context profile='system' for request 'cap-slot-leak' [ 406] sched: added process 62 [ 407] sched: switch 2:1 -> 62:1 [ 408] syscall: unknown syscall 0 [ 408] ring: cap lookup error: capability not found [ 408] ring: cap lookup error: capability not found [ 409] ring: cap lookup error: capability not found [ 409] sched: process_cpu_accounting pid=62 runtime_ns=16031340 context_switches=3 [ 409] proc: process 62 exited with code 0 [ 409] sched: switch to 2:1 [ 410] sched: off-stack process stack release pid=62 stacks=1 reason=deferred-process-drop proof_result=ok [ 411] proc: spawned process 63 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 411] proc: process 63 session context profile='system' for request 'cap-slot-leak' [ 411] sched: added process 63 [ 412] sched: switch 2:1 -> 63:1 [ 412] syscall: unknown syscall 0 [ 412] ring: cap lookup error: capability not found [ 413] ring: cap lookup error: capability not found [ 413] ring: cap lookup error: capability not found [ 414] sched: process_cpu_accounting pid=63 runtime_ns=16295170 context_switches=3 [ 414] proc: process 63 exited with code 0 [ 414] sched: switch to 2:1 [ 415] sched: off-stack process stack release pid=63 stacks=1 reason=deferred-process-drop proof_result=ok [ 415] proc: spawned process 64 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 415] proc: process 64 session context profile='system' for request 'cap-slot-leak' [ 415] sched: added process 64 [ 416] sched: switch 2:1 -> 64:1 [ 417] syscall: unknown syscall 0 [ 417] ring: cap lookup error: capability not found [ 417] ring: cap lookup error: capability not found [ 418] ring: cap lookup error: capability not found [ 418] sched: process_cpu_accounting pid=64 runtime_ns=15966665 context_switches=3 [ 418] proc: process 64 exited with code 0 [ 418] sched: switch to 2:1 [ 419] sched: off-stack process stack release pid=64 stacks=1 reason=deferred-process-drop proof_result=ok [ 420] proc: spawned process 65 for request 'cap-slot-leak' (binary='unprivileged-stranger', 0 caps) [ 420] proc: process 65 session context profile='system' for request 'cap-slot-leak' [ 420] sched: added process 65 [ 421] sched: switch 2:1 -> 65:1 [ 421] syscall: unknown syscall 0 [ 421] ring: cap lookup error: capability not found [ 422] ring: cap lookup error: capability not found [ 422] ring: cap lookup error: capability not found [ 422] sched: process_cpu_accounting pid=65 runtime_ns=16011470 context_switches=2 [ 422] proc: process 65 exited with code 0 [ 422] sched: switch to 2:1 [ 423] sched: off-stack process stack release pid=65 stacks=1 reason=deferred-process-drop proof_result=ok [ 424] ring: capability application exception: Overloaded: failed to reserve ProcessHandle cap slot [init] Spawn cap-table exhaustion check ok. [ 425] sched: process_cpu_accounting pid=2 runtime_ns=2831490257 context_switches=184 [ 425] proc: process 2 exited with code 0 [ 425] sched: last process exited, halting measure: ring dispatches=868 sqes=1394 nop_sqes=130 measure: serial bytes=84178 measure: timer interrupts=425 user_scheduler=397 kernel_only=28 bsp_tick_advances=425 measure: tlb cr3_writes=394 pending_flush_checks=2597 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=1403 cycles=8448421504 avg=6021683 measure: segment sqe_validation count=2238 cycles=3350611 avg=1497 measure: segment cap_lookup count=1650 cycles=1722889319 avg=1044175 measure: segment capnp_decode_encode count=628 cycles=4143088 avg=6597 measure: segment method_body count=741 cycles=6502804488 avg=8775714 measure: segment cqe_post count=1382 cycles=842142 avg=609 measure: segment waiter_wake_check count=1369 cycles=17061142 avg=12462 measure: segment sched_choose_next count=672 cycles=58657713 avg=87288 measure: direct_ipc_ready_to_select count=71 cycles=28901437 avg=407062 min=381529 max=534133 measure: segment schedule_save_requeue count=397 cycles=73598049 avg=185385 measure: segment timer_sleep_wake count=1098 cycles=287846 avg=262 measure: segment park_wake count=1098 cycles=8654335 avg=7881 measure: segment cap_wait_wake_scan count=1110 cycles=3250163 avg=2928 measure: segment thread_exit_join_cleanup count=87 cycles=204626911 avg=2352033 measure: segment process_exit_cleanup count=64 cycles=18263442 avg=285366 measure: segment process_drop count=63 cycles=1192733379 avg=18932275 measure: scheduler choose_direct_candidates=71 choose_run_queue_candidates=571 choose_idle_candidates=10 choose_runnable=652 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=12194 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=5091128042 measure: scheduler_lock_site schedule_pre_ring acquisitions=1249 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=214839567 measure: scheduler_lock_site schedule_select acquisitions=397 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=966155286 measure: scheduler_lock_site block_current acquisitions=3472 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=1388498368 measure: scheduler_lock_site wake_unblock acquisitions=1404 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=19133463 measure: scheduler_lock_site metadata acquisitions=5165 contended=0 spin_loops=0 wait_cycles=0 hold_cycles=521143254 measure: shared_kernel_lock frame_alloc acquisitions=53235 contended=0 spin_loops=0 measure: shared_kernel_lock frame_free acquisitions=52419 contended=0 spin_loops=0 measure: shared_kernel_lock ring_dispatch_cap_table acquisitions=397 contended=0 spin_loops=0 measure: shared_kernel_lock ring_dispatch_scratch acquisitions=397 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=3761 contended=0 spin_loops=0 measure: shared_kernel_lock heap acquisitions=5388 contended=0 spin_loops=0 measure: user_pc_samples total=0 overflow=0