# vng -v -r arch/x86/boot/bzImage --user root --name vmksft-nf-dbg,debug-threads=on --cpus 4
early console in setup code
No EFI environment detected.
early console in extract_kernel
input_data: 0x00000000060602c4
input_len: 0x0000000001903e6c
output: 0x0000000001000000
output_len: 0x0000000005205218
kernel_total_size: 0x00000000069b7000
needed_size: 0x0000000006a00000
trampoline_32bit: 0x000000000009d000
Physical KASLR using RDRAND RDTSC...
Virtual KASLR using RDRAND RDTSC...
Decompressing Linux... Parsing ELF... Performing relocations... done.
Booting the kernel (entry_offset: 0x0000000004a6da30).
[ 0.000000][ T0] Linux version 7.1.0-virtme (vmksft@netdev-virt.bots.linux.dev) (gcc (GCC) 16.1.1 20260515 (Red Hat 16.1.1-2), GNU ld version 2.46-3.fc44) #1 SMP PREEMPT_DYNAMIC Thu Jun 18 05:02:03 EDT 2026
[ 0.000000][ T0] Command line: virtme_hostname=vmksft-nf-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-16/.virtme_mods/lib/modules/0.0.0 virtme_rw_overlay0=/etc virtme_rw_overlay1=/lib virtme_rw_overlay2=/home virtme_rw_overlay3=/opt virtme_rw_overlay4=/srv virtme_rw_overlay5=/usr virtme_rw_overlay6=/var virtme_rw_overlay7=/tmp virtme_console=ttyS0 console=hvc0 earlyprintk=serial,ttyS0,115200 psmouse.proto=exps TERM=dumb virtme_chdir=srv/vmksft/testing/wt-16 rootfstype=virtiofs root=ROOTFS raid=noautodetect ro debug init=/usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init
[ 0.000000][ T0] BIOS-provided physical RAM map:
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] System RAM
[ 0.000000][ T0] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] device reserved
[ 0.000000][ T0] BIOS-e820: [gap 0x00000000000a0000-0x00000000000effff]
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] device reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000100000-0x000000003fffefff] System RAM
[ 0.000000][ T0] BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] device reserved
[ 0.000000][ T0] BIOS-e820: [gap 0x0000000040000000-0x00000000feffbfff]
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] device reserved
[ 0.000000][ T0] BIOS-e820: [gap 0x00000000ff000000-0x00000000fffbffff]
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] device reserved
[ 0.000000][ T0] printk: legacy bootconsole [earlyser0] enabled
[ 0.000000][ T0] NX (Execute Disable) protection: active
[ 0.000000][ T0] APIC: Static calls initialized
[ 0.000000][ T0] DMI: SMBIOS 2.4 present.
[ 0.000000][ T0] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
[ 0.000000][ T0] DMI: Memory slots populated: 1/1
[ 0.000000][ T0] Hypervisor detected: KVM
[ 0.000000][ T0] last_pfn = 0x3ffff max_arch_pfn = 0x10000000000
[ 0.000000][ T0] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000002][ T0] kvm-clock: using sched offset of 339316460 cycles
[ 0.001215][ T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.004768][ T0] tsc: Detected 2599.998 MHz processor
[ 0.005886][ T0] e820: update [mem 0x00000000-0x00000fff] System RAM ==> device reserved
[ 0.007575][ T0] e820: remove [mem 0x000a0000-0x000fffff] System RAM
[ 0.008911][ T0] last_pfn = 0x3ffff max_arch_pfn = 0x10000000000
[ 0.010208][ T0] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
[ 0.012028][ T0] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
[ 0.015400][ T0] found SMP MP-table at [mem 0x000f5690-0x000f569f]
[ 0.016710][ T0] Using GB pages for direct mapping
[ 0.017840][ T0] ACPI: Early table checksum verification disabled
[ 0.019123][ T0] ACPI: RSDP 0x00000000000F54B0 000024 (v02 BOCHS )
[ 0.020431][ T0] ACPI: XSDT 0x000000003FFFFFCA 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.022299][ T0] ACPI: FACP 0x000000003FFFFE54 00010C (v05 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.024161][ T0] ACPI: DSDT 0x000000003FFFF240 000C14 (v02 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.026025][ T0] ACPI: APIC 0x000000003FFFFF60 00006A (v03 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.027888][ T0] ACPI: Reserving FACP table memory at [mem 0x3ffffe54-0x3fffff5f]
[ 0.029452][ T0] ACPI: Reserving DSDT table memory at [mem 0x3ffff240-0x3ffffe53]
[ 0.031008][ T0] ACPI: Reserving APIC table memory at [mem 0x3fffff60-0x3fffffc9]
[ 0.033092][ T0] No NUMA configuration found
[ 0.034009][ T0] Faking a node at [mem 0x0000000000000000-0x000000003fffefff]
[ 0.035506][ T0] NODE_DATA(0) allocated [mem 0x3fff9e00-0x3fffefff]
[ 0.110265][ T0] KernelAddressSanitizer initialized (generic)
[ 0.111984][ T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.113405][ T0] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23
[ 0.115023][ T0] IOAPIC[1]: apic_id 1, version 32, address 0xfec10000, GSI 24-47
[ 0.116573][ T0] ACPI: Using ACPI (MADT) for SMP configuration information
[ 0.118007][ T0] TSC deadline timer available
[ 0.118941][ T0] CPU topo: Max. logical packages: 1
[ 0.120012][ T0] CPU topo: Max. logical nodes: 1
[ 0.121083][ T0] CPU topo: Num. nodes per package: 1
[ 0.122155][ T0] CPU topo: Max. logical dies: 1
[ 0.123234][ T0] CPU topo: Max. dies per package: 1
[ 0.124305][ T0] CPU topo: Max. threads per core: 1
[ 0.125376][ T0] CPU topo: Num. cores per package: 4
[ 0.126497][ T0] CPU topo: Num. threads per package: 4
[ 0.127620][ T0] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs
[ 0.129019][ T0] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
[ 0.130586][ T0] kvm-guest: KVM setup pv remote TLB flush
[ 0.131729][ T0] kvm-guest: setup PV sched yield
[ 0.132729][ T0] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.134396][ T0] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
[ 0.136057][ T0] [gap 0x40000000-0xfeffbfff] available for PCI devices
[ 0.137428][ T0] Booting paravirtualized kernel on KVM
[ 0.138544][ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.157866][ T0] Zone ranges:
[ 0.158532][ T0] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.159916][ T0] DMA32 [mem 0x0000000001000000-0x000000003fffefff]
[ 0.161306][ T0] Normal empty
[ 0.162024][ T0] Device empty
[ 0.162751][ T0] Movable zone start for each node
[ 0.163752][ T0] Early memory node ranges
[ 0.164614][ T0] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.166018][ T0] node 0: [mem 0x0000000000100000-0x000000003fffefff]
[ 0.167425][ T0] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffefff]
[ 0.169001][ T0] On node 0, zone DMA: 1 pages in unavailable ranges
[ 0.170348][ T0] On node 0, zone DMA: 97 pages in unavailable ranges
[ 0.173347][ T0] On node 0, zone DMA32: 1 pages in unavailable ranges
[ 0.174723][ T0] setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[ 0.177370][ T0] percpu: Embedded 67 pages/cpu s233936 r8192 d32304 u524288
[ 0.178829][ T0] pcpu-alloc: s233936 r8192 d32304 u524288 alloc=1*2097152
[ 0.180253][ T0] pcpu-alloc: [0] 0 1 2 3
[ 0.181165][ T0] Kernel command line: virtme_hostname=vmksft-nf-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-16/.virtme_mods/lib/modules/0.0.0 virtme_rw_overlay0=/etc virtme_rw_overlay1=/lib virtme_rw_overlay2=/home virtme_rw_overlay3=/opt virtme_rw_overlay4=/srv virtme_rw_overlay5=/usr virtme_rw_overlay6=/var virtme_rw_overlay7=/tmp virtme_console=ttyS0 console=hvc0 earlyprintk=serial,ttyS0,115200 psmouse.proto=exps TERM=dumb virtme_chdir=srv/vmksft/testing/wt-16 rootfstype=virtiofs root=ROOTFS raid=noautodetect ro debug init=/usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init
[ 0.192507][ T0] Unknown kernel command line parameters "virtme_hostname=vmksft-nf-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-16/.virtme_mods/lib/modules/0.0.0 virtme_rw_overlay0=/etc virtme_rw_overlay1=/lib virtme_rw_overlay2=/home virtme_rw_overlay3=/opt virtme_rw_overlay4=/srv virtme_rw_overlay5=/usr virtme_rw_overlay6=/var virtme_rw_overlay7=/tmp virtme_console=ttyS0 virtme_chdir=srv/vmksft/testing/wt-16", will be passed to user space.
[ 0.201094][ T0] random: crng init done
[ 0.201927][ T0] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
[ 0.204041][ T0] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.206015][ T0] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.207899][ T0] Fallback order for Node 0: 0
[ 0.207905][ T0] Built 1 zonelists, mobility grouping on. Total pages: 262045
[ 0.210377][ T0] Policy zone: DMA32
[ 0.211136][ T0] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[ 0.212654][ T0] stackdepot: allocating hash table via alloc_large_system_hash
[ 0.214169][ T0] stackdepot hash table entries: 1048576 (order: 12, 16777216 bytes, linear)
[ 0.223670][ T0] stackdepot: allocating space for 8192 stack pools via memblock
[ 0.247617][ T0] **********************************************************
[ 0.249045][ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.250439][ T0] ** **
[ 0.251827][ T0] ** This system shows unhashed kernel memory addresses **
[ 0.253218][ T0] ** via the console, logs, and other interfaces. This **
[ 0.254604][ T0] ** might reduce the security of your system. **
[ 0.255990][ T0] ** **
[ 0.257383][ T0] ** If you see this message and you are not debugging **
[ 0.258768][ T0] ** the kernel, report this immediately to your system **
[ 0.260154][ T0] ** administrator! **
[ 0.261546][ T0] ** **
[ 0.262932][ T0] ** Use hash_pointers=always to force this mode off **
[ 0.264324][ T0] ** **
[ 0.265710][ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.267094][ T0] **********************************************************
[ 0.268883][ T0] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Poking KASLR using RDRAND RDTSC...
[ 0.285812][ T0] ftrace: allocating 47521 entries in 188 pages
[ 0.286990][ T0] ftrace: allocated 188 pages with 5 groups
[ 0.288406][ T0] Dynamic Preempt: full
[ 0.290312][ T0] Running RCU self tests
[ 0.291099][ T0] Running RCU synchronous self tests
[ 0.292089][ T0] rcu: Preemptible hierarchical RCU implementation.
[ 0.293329][ T0] rcu: RCU event tracing is enabled.
[ 0.294334][ T0] rcu: RCU lockdep checking is enabled.
[ 0.295390][ T0] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4.
[ 0.296792][ T0] rcu: RCU callback double-/use-after-free debug is enabled.
[ 0.298200][ T0] Trampoline variant of Tasks RCU enabled.
[ 0.299304][ T0] Rude variant of Tasks RCU enabled.
[ 0.300309][ T0] Tracing variant of Tasks RCU enabled.
[ 0.301363][ T0] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[ 0.302969][ T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[ 0.304598][ T0] Running RCU synchronous self tests
[ 0.305604][ T0] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[ 0.307421][ T0] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[ 0.353585][ T0] NR_IRQS: 4352, nr_irqs: 848, preallocated irqs: 0
[ 0.354988][ T0] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[ 0.356466][ T0] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.358497][ T0]
[ 0.358917][ T0] =============================
[ 0.359823][ T0] [ BUG: Invalid wait context ]
[ 0.360727][ T0] 7.1.0-virtme #1 Not tainted
[ 0.361598][ T0] -----------------------------
[ 0.362503][ T0] swapper/0/0 is trying to lock:
[ 0.363424][ T0] ffffffff8a1c9ba0 (clocksource_mutex){....}-{4:4}, at: __clocksource_register_scale.cold+0x289/0x5c3
[ 0.365503][ T0] other info that might help us debug this:
[ 0.366604][ T0] context-{5:5}
[ 0.367243][ T0] 1 lock held by swapper/0/0:
[ 0.368110][ T0] #0: ffffffff8ca177f0 (&tkd->lock){....}-{2:2}, at: timekeeping_init+0x218/0x350
[ 0.369872][ T0] stack backtrace:
[ 0.370564][ T0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 7.1.0-virtme #1 PREEMPT(full)
[ 0.370568][ T0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 0.370569][ T0] Call Trace:
[ 0.370571][ T0]
[ 0.370574][ T0] dump_stack_lvl+0x6f/0xa0
[ 0.370579][ T0] __lock_acquire.cold+0x3a/0x66
[ 0.370582][ T0] ? console_unlock+0x12d/0x1f0
[ 0.370584][ T0] lock_acquire.part.0+0xbc/0x260
[ 0.370586][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.370588][ T0] ? rcu_is_watching+0x15/0xd0
[ 0.370590][ T0] ? lock_acquire+0x13c/0x160
[ 0.370592][ T0] __mutex_lock+0x1ac/0x1f10
[ 0.370595][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.370597][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.370598][ T0] ? wake_up_klogd_work_func+0x90/0x90
[ 0.370599][ T0] ? __lock_release.isra.0+0x6b/0x1a0
[ 0.370601][ T0] ? pcpu_alloc+0x11/0x440
[ 0.370603][ T0] ? ww_mutex_lock+0x160/0x160
[ 0.370605][ T0] ? snapshot_read.cold+0x1f/0x1f
[ 0.370607][ T0] ? debug_object_assert_init+0x340/0x340
[ 0.370610][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.370611][ T0] __clocksource_register_scale.cold+0x289/0x5c3
[ 0.370613][ T0] clocksource_default_clock+0x3b/0x70
[ 0.370614][ T0] timekeeping_init+0x229/0x350
[ 0.370616][ T0] ? read_persistent_wall_and_boot_offset+0x60/0x60
[ 0.370617][ T0] ? policy_nodemask+0x540/0x540
[ 0.370618][ T0] ? __raw_spin_lock_init+0x44/0x120
[ 0.370620][ T0] ? split_page+0x137/0x210
[ 0.370622][ T0] ? __split_page+0x19/0xd0
[ 0.370623][ T0] start_kernel+0x22e/0x3b0
[ 0.370626][ T0] x86_64_start_reservations+0x24/0x30
[ 0.370628][ T0] x86_64_start_kernel+0x12b/0x130
[ 0.370631][ T0] common_startup_64+0x13e/0x148
[ 0.370634][ T0]
[ 0.371084][ T0] Console: colour *CGA 80x25
[ 0.405059][ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.406679][ T0] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.407599][ T0] ... MAX_LOCK_DEPTH: 48
[ 0.408537][ T0] ... MAX_LOCKDEP_KEYS: 8192
[ 0.409508][ T0] ... CLASSHASH_SIZE: 4096
[ 0.410480][ T0] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.411468][ T0] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.412465][ T0] ... CHAINHASH_SIZE: 32768
[ 0.413454][ T0] memory used by lock dependency info: 6429 kB
[ 0.414623][ T0] memory used for stack traces: 16896 kB
[ 0.415693][ T0] per task-struct memory footprint: 1920 bytes
[ 0.416929][ T0] ACPI: Core revision 20260408
[ 0.418149][ T0] APIC: Switch to symmetric I/O mode setup
[ 0.420882][ T0] x2apic enabled
[ 0.425160][ T0] APIC: Switched APIC routing to: physical x2apic
[ 0.426375][ T0] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()
[ 0.427895][ T0] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()
[ 0.429784][ T0] kvm-guest: setup PV IPIs
[ 0.430705][ T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x257a3a7b45f, max_idle_ns: 440795312762 ns
[ 0.432873][ T0] Calibrating delay loop (skipped) preset value.. 5199.99 BogoMIPS (lpj=2599998)
[ 0.433868][ T0] x86/cpu: User Mode Instruction Prevention (UMIP) activated
[ 0.433868][ T0] numa_add_cpu cpu 0 node 0: mask now 0
[ 0.433868][ T0] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
[ 0.433868][ T0] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
[ 0.433868][ T0] mitigations: Enabled attack vectors: SMT mitigations: off
[ 0.433868][ T0] Speculative Store Bypass: Vulnerable
[ 0.433868][ T0] Spectre V2 : Vulnerable
[ 0.433868][ T0] Speculative Return Stack Overflow: Vulnerable
[ 0.433868][ T0] Spectre V1 : Vulnerable: __user pointer sanitization and usercopy barriers only; no swapgs barriers
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'
[ 0.433868][ T0] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
[ 0.433868][ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
[ 0.433868][ T0] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64
[ 0.433868][ T0] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512
[ 0.433868][ T0] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024
[ 0.433868][ T0] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8
[ 0.433868][ T0] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.
[ 0.433868][ T0] pid_max: default: 32768 minimum: 301
[ 0.433868][ T0] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[ 0.433868][ T0] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[ 0.433868][ T0] VFS: Finished mounting rootfs on nullfs
[ 0.433868][ T0] Running RCU synchronous self tests
[ 0.433868][ T0] Running RCU synchronous self tests
[ 0.433868][ T1] smpboot: CPU0: AMD EPYC 9655P 96-Core Processor (family: 0x1a, model: 0x2, stepping: 0x1)
[ 0.437122][ T1] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
[ 0.437880][ T1] ... version: 2
[ 0.438835][ T1] ... bit width: 48
[ 0.438874][ T1] ... generic counters: 6
[ 0.439827][ T1] ... generic bitmap: 000000000000003f
[ 0.439874][ T1] ... fixed-purpose counters: 0
[ 0.440814][ T1] ... fixed-purpose bitmap: 0000000000000000
[ 0.440874][ T1] ... value mask: 0000ffffffffffff
[ 0.441874][ T1] ... max period: 00007fffffffffff
[ 0.442874][ T1] ... global_ctrl mask: 000000000000003f
[ 0.444060][ T1] signal: max sigframe size: 3376
[ 0.445125][ T1] rcu: Hierarchical SRCU implementation.
[ 0.445878][ T1] rcu: Max phase no-delay instances is 400.
[ 0.451116][ T1] smp: Bringing up secondary CPUs ...
[ 0.454037][ T1] smpboot: x86: Booting SMP configuration:
[ 0.454886][ T1] .... node #0, CPUs: #1 #2 #3
[ 0.077410][ T0] numa_add_cpu cpu 1 node 0: mask now 0-1
[ 0.077410][ T0] numa_add_cpu cpu 2 node 0: mask now 0-2
[ 0.077410][ T0] numa_add_cpu cpu 3 node 0: mask now 0-3
[ 0.459860][ T1] smp: Brought up 1 node, 4 CPUs
[ 0.463803][ T1] smpboot: Total of 4 processors activated (20799.98 BogoMIPS)
[ 0.465616][ T1] Memory: 733508K/1048180K available (46347K kernel code, 12698K rwdata, 9812K rodata, 2548K init, 29380K bss, 304004K reserved, 0K cma-reserved)
[ 0.466788][ T1] devtmpfs: initialized
[ 0.467659][ T1] x86/mm: Memory block size: 128MB
[ 0.474488][ T1] Running RCU synchronous self tests
[ 0.474880][ T1] Running RCU synchronous self tests
[ 0.476197][ T1] Running RCU Tasks wait API self tests
[ 0.476913][ T1] Running RCU Tasks Rude wait API self tests
[ 0.477994][ T1] Running RCU Tasks Trace wait API self tests
[ 0.478959][ T1] posixtimers hash table entries: 2048 (order: 6, 147456 bytes, linear)
[ 0.480035][ T1] futex hash table entries: 1024 (131072 bytes on 1 NUMA nodes, total 128 KiB, linear).
[ 0.481814][ T1] PM: RTC time: 09:04:55, date: 2026-06-18
[ 0.483877][ T11] Callback from call_rcu_tasks_trace() invoked.
[ 0.485525][ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.486237][ T1] audit: initializing netlink subsys (disabled)
[ 0.487153][ T44] audit: type=2000 audit(1781773496.216:1): state=initialized audit_enabled=0 res=1
[ 0.488765][ T1] thermal_sys: Registered thermal governor 'step_wise'
[ 0.488955][ T1] cpuidle: using governor ladder
[ 0.492103][ T1] Freeing SMP alternatives memory: 40K
[ 0.494012][ T1] PCI: Fatal: No config space access function found
[ 0.495254][ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[ 0.501074][ T1] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
[ 0.502881][ T1] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
[ 0.504877][ T1] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.505874][ T1] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
[ 0.509250][ T1] ACPI: Added _OSI(Module Device)
[ 0.510875][ T1] ACPI: Added _OSI(Processor Device)
[ 0.511866][ T1] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.538836][ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 0.545721][ T1] ACPI: \_SB_: platform _OSC: OS support mask [002a2e8e]
[ 0.549598][ T1] ACPI: Interpreter enabled
[ 0.550318][ T1] ACPI: PM: (supports S0 S5)
[ 0.551876][ T1] ACPI: Using IOAPIC for interrupt routing
[ 0.553089][ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.554885][ T1] PCI: Using E820 reservations for host bridge windows
[ 0.577332][ T1] ACPI: PCI: Interrupt link L000 configured for IRQ 16
[ 0.579382][ T1] ACPI: PCI: Interrupt link L001 configured for IRQ 17
[ 0.581063][ T1] ACPI: PCI: Interrupt link L002 configured for IRQ 18
[ 0.582392][ T1] ACPI: PCI: Interrupt link L003 configured for IRQ 19
[ 0.584056][ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.585868][ T1] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
[ 0.587107][ T1] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[ 0.594724][ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource
[ 0.615308][ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[ 0.618346][ T1] PCI host bridge to bus 0000:00
[ 0.620744][ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xdfffffff window]
[ 0.621887][ T1] pci_bus 0000:00: root bus resource [mem 0xc000000000000-0xfffffffffffff window]
[ 0.623887][ T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.624987][ T1] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
[ 0.629477][ T1] iommu: Default domain type: Translated
[ 0.630875][ T1] iommu: DMA domain TLB invalidation policy: lazy mode
[ 0.634082][ T1] SCSI subsystem initialized
[ 0.635500][ T1] libata version 3.00 loaded.
[ 0.636710][ T1] pps_core: LinuxPPS API ver. 1 registered
[ 0.637930][ T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti
[ 0.639955][ T1] PTP clock support registered
[ 0.641882][ T1] Advanced Linux Sound Architecture Driver Initialized.
[ 0.646546][ T1] PCI: Using ACPI for IRQ routing
[ 0.646925][ T1] PCI: pci_cache_line_size set to 64 bytes
[ 0.647897][ T1] e820: register RAM buffer resource [mem 0x0009fc00-0x0009ffff]
[ 0.649891][ T1] e820: register RAM buffer resource [mem 0x3ffff000-0x3fffffff]
[ 0.651206][ T1] vgaarb: loaded
[ 0.652869][ T1] clocksource: Switched to clocksource kvm-clock
[ 0.656992][ T1] VFS: Disk quotas dquot_6.6.0
[ 0.658000][ T1] VFS: Dquot-cache hash table entries: 512 (4096 bytes)
[ 0.661667][ T1] acpi PNP0C02:00: Reserved [mem 0xe0000000-0xefffffff]
[ 0.663227][ T1] pnp: PnP ACPI init
[ 0.665082][ T1] pnp: PnP ACPI: found 1 devices
[ 0.685356][ T1] NET: Registered PF_INET protocol family
[ 0.686671][ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.689998][ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 4, 36864 bytes, linear)
[ 0.691779][ T42] Callback from call_rcu_tasks() invoked.
[ 0.691820][ T1] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.694615][ T1] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.696401][ T1] TCP bind hash table entries: 8192 (order: 9, 1179648 bytes, linear)
[ 0.698594][ T1] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.700241][ T1] UDP hash table entries: 512 (order: 5, 131072 bytes, linear)
[ 0.702216][ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.703578][ T1] pci_bus 0000:00: resource 4 [mem 0xc0000000-0xdfffffff window]
[ 0.705046][ T1] pci_bus 0000:00: resource 5 [mem 0xc000000000000-0xfffffffffffff window]
[ 0.706718][ T1] PCI: CLS 0 bytes, default 64
[ 0.708148][ T1] kvm_intel: VMX not supported by CPU 0
[ 0.709281][ T1] kvm_amd: TSC scaling supported
[ 0.710229][ T1] kvm_amd: Nested Virtualization enabled
[ 0.711293][ T1] kvm_amd: Nested Paging enabled
[ 0.712228][ T1] kvm_amd: LBR virtualization supported
[ 0.713297][ T1] kvm_amd: Virtual VMLOAD VMSAVE supported
[ 0.714392][ T1] kvm_amd: Virtual GIF supported
[ 0.715322][ T1] kvm_amd: Virtual NMI enabled
[ 0.721015][ T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x257a3a7b45f, max_idle_ns: 440795312762 ns
[ 0.729649][ T1] Initialise system trusted keyrings
[ 0.730967][ T1] workingset: timestamp_bits=56 (anon: 52) max_order=18 bucket_order=0 (anon: 0)
[ 0.739339][ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.740701][ T1] fuse: init (API version 7.45)
[ 0.742064][ T1] 9p: Installing v9fs 9p2000 file system support
[ 0.743817][ T1] Key type asymmetric registered
[ 0.744755][ T1] Asymmetric key parser 'x509' registered
[ 0.746339][ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 0.747988][ T1] io scheduler mq-deadline registered
[ 0.749003][ T1] io scheduler kyber registered
[ 0.752806][ T1] input: Power Button as /devices/platform/PNP0C0C:00/input/input0
[ 0.754777][ T1] ACPI: button: Power Button [PWRB]
[ 0.758054][ T1] virtiofs virtio0: discovered new tag: ROOTFS
[ 0.760096][ T1] virtiofs virtio0: virtio_fs_setup_dax: No cache capability
[ 0.764646][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.767683][ T1] 00:00: ttyS0 at I/O 0x3f8 (irq = 52, base_baud = 115200) is a 16550A
[ 0.820256][ T1] ACPI: bus type drm_connector registered
[ 0.842316][ T1] loop: module loaded
[ 0.848582][ T1] i8042: PNP: No PS/2 controller found.
[ 0.853743][ T1] rtc_cmos PNP0B00:00: registered as rtc0
[ 0.855082][ T1] rtc_cmos PNP0B00:00: setting system clock to 2026-06-18T09:04:56 UTC (1781773496)
[ 0.857127][ T1] rtc_cmos PNP0B00:00: alarms up to one day, 242 bytes nvram
[ 0.859864][ T52] printk: legacy console [hvc0] enabled
[ 0.860024][ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
[ 0.860920][ T52] printk: legacy bootconsole [earlyser0] disabled
_ _
__ _(_)_ __| |_ _ __ ___ ___ _ __ __ _
\ \ / / | __| __| _ _ \ / _ \_____| _ \ / _ |
\ V /| | | | |_| | | | | | __/_____| | | | (_| |
\_/ |_|_| \__|_| |_| |_|\___| |_| |_|\__ |
|___/
kernel version: 7.1.0-virtme x86_64
(CTRL+d to exit)
bash-5.3# PS1='xx__-> '
xx__-> ls /sys/kernel/debug/
acpi extfrag ref_tracker
bdi fail_function rseq
block fail_mempool_alloc sched
check_wx_pages fail_mempool_alloc_bulk slab
clear_warn_once fault_around_bytes sleep_time
debug_objects i2c stackdepot
device_component kmemleak suspend_stats
devices_deferred kprobes swiotlb
dma_buf kvm tracing
dmaengine mce virtio-ports
dri multigrain_timestamps wakeup_sources
dynamic_debug page_tables x86
error_injection ptp0
xx__-> export KSFT_MACHINE_SLOW=yes
xx__-> export kselftest_override_timeout=3600
xx__-> env
SHELL=/bin/bash
PWD=/srv/vmksft/testing/wt-16
nr_open=2147483584
virtme_hostname=vmksft-nf-dbg,debug-threads=on
KSFT_MACHINE_SLOW=yes
HOME=/root
virtme_chdir=srv/vmksft/testing/wt-16
kselftest_override_timeout=3600
virtme_rw_overlay7=/tmp
virtme_rw_overlay6=/var
virtme_rw_overlay5=/usr
virtme_rw_overlay4=/srv
virtme_rw_overlay3=/opt
virtme_rw_overlay2=/home
virtme_rw_overlay1=/lib
virtme_rw_overlay0=/etc
TERM=dumb
SHLVL=1
LD_LIBRARY_PATH=/srv/vmksft/tools/fs/usr/lib/:/home/virtme/tools/fs/lib64/:/home/virtme/tools/fs/usr/lib64/:/lib64/:
XDG_RUNTIME_DIR=/run/user/0
virtme_link_mods=/srv/vmksft/testing/wt-16/.virtme_mods/lib/modules/0.0.0
PATH=/srv/vmksft/tools/fs/bin:/srv/vmksft/tools/fs/sbin:/srv/vmksft/tools/fs/usr/bin:/srv/vmksft/tools/fs/usr/sbin:/bin:/sbin:/usr/bin:/usr/sbin:/usr/local/bin
virtme_console=ttyS0
_=/bin/env
xx__->