# vng -v -r arch/x86/boot/bzImage --user root --name vmksft-forwarding-dbg,debug-threads=on --cpus 4
early console in setup code
No EFI environment detected.
early console in extract_kernel
input_data: 0x000000000607a2c4
input_len: 0x00000000018bd0d0
output: 0x0000000001000000
output_len: 0x00000000051d18bc
kernel_total_size: 0x000000000698a000
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: 0x0000000004a49a30).
[ 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 Fri Jun 19 11:02:20 EDT 2026
[ 0.000000][ T0] Command line: virtme_hostname=vmksft-forwarding-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-4/.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-4 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.000003][ T0] kvm-clock: using sched offset of 371874773 cycles
[ 0.001261][ T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.005033][ T0] tsc: Detected 2599.998 MHz processor
[ 0.006215][ T0] e820: update [mem 0x00000000-0x00000fff] System RAM ==> device reserved
[ 0.008006][ T0] e820: remove [mem 0x000a0000-0x000fffff] System RAM
[ 0.009423][ T0] last_pfn = 0x3ffff max_arch_pfn = 0x10000000000
[ 0.010787][ T0] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
[ 0.012716][ T0] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
[ 0.016316][ T0] found SMP MP-table at [mem 0x000f5690-0x000f569f]
[ 0.017730][ T0] Using GB pages for direct mapping
[ 0.018945][ T0] ACPI: Early table checksum verification disabled
[ 0.020306][ T0] ACPI: RSDP 0x00000000000F54B0 000024 (v02 BOCHS )
[ 0.021694][ T0] ACPI: XSDT 0x000000003FFFFFCA 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.023682][ T0] ACPI: FACP 0x000000003FFFFE54 00010C (v05 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.025674][ T0] ACPI: DSDT 0x000000003FFFF240 000C14 (v02 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.027652][ T0] ACPI: APIC 0x000000003FFFFF60 00006A (v03 BOCHS BXPC 00000001 BXPC 00000001)
[ 0.029641][ T0] ACPI: Reserving FACP table memory at [mem 0x3ffffe54-0x3fffff5f]
[ 0.031359][ T0] ACPI: Reserving DSDT table memory at [mem 0x3ffff240-0x3ffffe53]
[ 0.033163][ T0] ACPI: Reserving APIC table memory at [mem 0x3fffff60-0x3fffffc9]
[ 0.035527][ T0] No NUMA configuration found
[ 0.036554][ T0] Faking a node at [mem 0x0000000000000000-0x000000003fffefff]
[ 0.038267][ T0] NODE_DATA(0) allocated [mem 0x3fff9e00-0x3fffefff]
[ 0.119016][ T0] KernelAddressSanitizer initialized (generic)
[ 0.120814][ T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.122303][ T0] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23
[ 0.124023][ T0] IOAPIC[1]: apic_id 1, version 32, address 0xfec10000, GSI 24-47
[ 0.125671][ T0] ACPI: Using ACPI (MADT) for SMP configuration information
[ 0.127189][ T0] TSC deadline timer available
[ 0.128176][ T0] CPU topo: Max. logical packages: 1
[ 0.129312][ T0] CPU topo: Max. logical nodes: 1
[ 0.130445][ T0] CPU topo: Num. nodes per package: 1
[ 0.131578][ T0] CPU topo: Max. logical dies: 1
[ 0.132718][ T0] CPU topo: Max. dies per package: 1
[ 0.133852][ T0] CPU topo: Max. threads per core: 1
[ 0.134986][ T0] CPU topo: Num. cores per package: 4
[ 0.136179][ T0] CPU topo: Num. threads per package: 4
[ 0.137372][ T0] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs
[ 0.138856][ T0] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
[ 0.140511][ T0] kvm-guest: KVM setup pv remote TLB flush
[ 0.141733][ T0] kvm-guest: setup PV sched yield
[ 0.142795][ T0] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.144554][ T0] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
[ 0.146329][ T0] [gap 0x40000000-0xfeffbfff] available for PCI devices
[ 0.147784][ T0] Booting paravirtualized kernel on KVM
[ 0.148946][ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.169037][ T0] Zone ranges:
[ 0.169747][ T0] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.171220][ T0] DMA32 [mem 0x0000000001000000-0x000000003fffefff]
[ 0.172704][ T0] Normal empty
[ 0.173472][ T0] Device empty
[ 0.174243][ T0] Movable zone start for each node
[ 0.175337][ T0] Early memory node ranges
[ 0.176270][ T0] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.177799][ T0] node 0: [mem 0x0000000000100000-0x000000003fffefff]
[ 0.179328][ T0] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffefff]
[ 0.181091][ T0] On node 0, zone DMA: 1 pages in unavailable ranges
[ 0.182701][ T0] On node 0, zone DMA: 97 pages in unavailable ranges
[ 0.186467][ T0] On node 0, zone DMA32: 1 pages in unavailable ranges
[ 0.188011][ T0] setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[ 0.191364][ T0] percpu: Embedded 67 pages/cpu s233936 r8192 d32304 u524288
[ 0.193113][ T0] pcpu-alloc: s233936 r8192 d32304 u524288 alloc=1*2097152
[ 0.194799][ T0] pcpu-alloc: [0] 0 1 2 3
[ 0.195902][ T0] Kernel command line: virtme_hostname=vmksft-forwarding-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-4/.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-4 rootfstype=virtiofs root=ROOTFS raid=noautodetect ro debug init=/usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init
[ 0.209440][ T0] Unknown kernel command line parameters "virtme_hostname=vmksft-forwarding-dbg,debug-threads=on nr_open=2147483584 virtme_link_mods=/srv/vmksft/testing/wt-4/.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-4", will be passed to user space.
[ 0.219342][ T0] random: crng init done
[ 0.220237][ T0] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
[ 0.222513][ T0] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
[ 0.224863][ T0] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
[ 0.227176][ T0] Fallback order for Node 0: 0
[ 0.227184][ T0] Built 1 zonelists, mobility grouping on. Total pages: 262045
[ 0.230056][ T0] Policy zone: DMA32
[ 0.230945][ T0] mem auto-init: stack:all(zero), heap alloc:off, heap free:off
[ 0.232719][ T0] stackdepot: allocating hash table via alloc_large_system_hash
[ 0.234473][ T0] stackdepot hash table entries: 1048576 (order: 12, 16777216 bytes, linear)
[ 0.245834][ T0] stackdepot: allocating space for 8192 stack pools via memblock
[ 0.270721][ T0] **********************************************************
[ 0.272290][ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.273838][ T0] ** **
[ 0.275394][ T0] ** This system shows unhashed kernel memory addresses **
[ 0.276942][ T0] ** via the console, logs, and other interfaces. This **
[ 0.278483][ T0] ** might reduce the security of your system. **
[ 0.280032][ T0] ** **
[ 0.281588][ T0] ** If you see this message and you are not debugging **
[ 0.283148][ T0] ** the kernel, report this immediately to your system **
[ 0.284707][ T0] ** administrator! **
[ 0.286258][ T0] ** **
[ 0.287823][ T0] ** Use hash_pointers=always to force this mode off **
[ 0.289380][ T0] ** **
[ 0.290943][ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.292502][ T0] **********************************************************
[ 0.294491][ T0] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Poking KASLR using RDRAND RDTSC...
[ 0.312215][ T0] ftrace: allocating 47064 entries in 184 pages
[ 0.313532][ T0] ftrace: allocated 184 pages with 4 groups
[ 0.315090][ T0] Dynamic Preempt: full
[ 0.317156][ T0] Running RCU self tests
[ 0.318041][ T0] Running RCU synchronous self tests
[ 0.319139][ T0] rcu: Preemptible hierarchical RCU implementation.
[ 0.320515][ T0] rcu: RCU event tracing is enabled.
[ 0.321645][ T0] rcu: RCU lockdep checking is enabled.
[ 0.322832][ T0] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4.
[ 0.324390][ T0] rcu: RCU callback double-/use-after-free debug is enabled.
[ 0.325959][ T0] Trampoline variant of Tasks RCU enabled.
[ 0.327190][ T0] Rude variant of Tasks RCU enabled.
[ 0.328310][ T0] Tracing variant of Tasks RCU enabled.
[ 0.329484][ T0] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[ 0.331277][ T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
[ 0.333092][ T0] Running RCU synchronous self tests
[ 0.334212][ T0] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[ 0.336250][ T0] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
[ 0.405856][ T0] NR_IRQS: 4352, nr_irqs: 848, preallocated irqs: 0
[ 0.407465][ T0] rcu: srcu_init: Setting srcu_struct sizes based on contention.
[ 0.409130][ T0] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.411429][ T0]
[ 0.411905][ T0] =============================
[ 0.412919][ T0] [ BUG: Invalid wait context ]
[ 0.413932][ T0] 7.1.0-virtme #1 Not tainted
[ 0.414909][ T0] -----------------------------
[ 0.415923][ T0] swapper/0/0 is trying to lock:
[ 0.416952][ T0] ffffffffa3bc93e0 (clocksource_mutex){....}-{4:4}, at: __clocksource_register_scale.cold+0x289/0x5c3
[ 0.419278][ T0] other info that might help us debug this:
[ 0.420514][ T0] context-{5:5}
[ 0.421227][ T0] 1 lock held by swapper/0/0:
[ 0.422202][ T0] #0: ffffffffa63eb7f0 (&tkd->lock){....}-{2:2}, at: timekeeping_init+0x218/0x350
[ 0.424176][ T0] stack backtrace:
[ 0.424954][ T0] CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Not tainted 7.1.0-virtme #1 PREEMPT(full)
[ 0.424958][ T0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[ 0.424960][ T0] Call Trace:
[ 0.424962][ T0]
[ 0.424965][ T0] dump_stack_lvl+0x6f/0xa0
[ 0.424970][ T0] __lock_acquire.cold+0x3a/0x66
[ 0.424974][ T0] ? console_unlock+0x12d/0x1f0
[ 0.424978][ T0] lock_acquire.part.0+0xbc/0x260
[ 0.424981][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.424983][ T0] ? rcu_is_watching+0x15/0xd0
[ 0.424986][ T0] ? lock_acquire+0x13c/0x160
[ 0.424988][ T0] __mutex_lock+0x1ac/0x1f10
[ 0.424992][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.424994][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.424995][ T0] ? wake_up_klogd_work_func+0x90/0x90
[ 0.424997][ T0] ? __lock_release.isra.0+0x6b/0x1a0
[ 0.424999][ T0] ? pcpu_alloc+0x11/0x440
[ 0.425002][ T0] ? ww_mutex_lock+0x160/0x160
[ 0.425004][ T0] ? snapshot_read.cold+0x1f/0x1f
[ 0.425006][ T0] ? debug_object_assert_init+0x340/0x340
[ 0.425009][ T0] ? __clocksource_register_scale.cold+0x289/0x5c3
[ 0.425010][ T0] __clocksource_register_scale.cold+0x289/0x5c3
[ 0.425012][ T0] clocksource_default_clock+0x3b/0x70
[ 0.425014][ T0] timekeeping_init+0x229/0x350
[ 0.425017][ T0] ? read_persistent_wall_and_boot_offset+0x60/0x60
[ 0.425018][ T0] ? policy_nodemask+0x540/0x540
[ 0.425022][ T0] ? __raw_spin_lock_init+0x44/0x120
[ 0.425024][ T0] ? split_page+0x137/0x210
[ 0.425027][ T0] ? __split_page+0x19/0xd0
[ 0.425029][ T0] start_kernel+0x22e/0x3b0
[ 0.425033][ T0] x86_64_start_reservations+0x24/0x30
[ 0.425035][ T0] x86_64_start_kernel+0x12b/0x130
[ 0.425037][ T0] common_startup_64+0x13e/0x148
[ 0.425041][ T0]
[ 0.425575][ T0] Console: colour *CGA 80x25
[ 0.463675][ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.465481][ T0] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.466509][ T0] ... MAX_LOCK_DEPTH: 48
[ 0.467552][ T0] ... MAX_LOCKDEP_KEYS: 8192
[ 0.468639][ T0] ... CLASSHASH_SIZE: 4096
[ 0.469720][ T0] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.470823][ T0] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.471926][ T0] ... CHAINHASH_SIZE: 32768
[ 0.473025][ T0] memory used by lock dependency info: 6429 kB
[ 0.474328][ T0] memory used for stack traces: 16896 kB
[ 0.475527][ T0] per task-struct memory footprint: 1920 bytes
[ 0.476910][ T0] ACPI: Core revision 20260408
[ 0.478260][ T0] APIC: Switch to symmetric I/O mode setup
[ 0.481339][ T0] x2apic enabled
[ 0.486273][ T0] APIC: Switched APIC routing to: physical x2apic
[ 0.487645][ T0] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()
[ 0.489344][ T0] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()
[ 0.491452][ T0] kvm-guest: setup PV IPIs
[ 0.492517][ T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x257a3a7b45f, max_idle_ns: 440795312762 ns
[ 0.494941][ T0] Calibrating delay loop (skipped) preset value.. 5199.99 BogoMIPS (lpj=2599998)
[ 0.495936][ T0] x86/cpu: User Mode Instruction Prevention (UMIP) activated
[ 0.495936][ T0] numa_add_cpu cpu 0 node 0: mask now 0
[ 0.495936][ T0] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
[ 0.495936][ T0] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
[ 0.495936][ T0] mitigations: Enabled attack vectors: SMT mitigations: off
[ 0.495936][ T0] Speculative Store Bypass: Vulnerable
[ 0.495936][ T0] Spectre V2 : Vulnerable
[ 0.495936][ T0] Speculative Return Stack Overflow: Vulnerable
[ 0.495936][ T0] Spectre V1 : Vulnerable: __user pointer sanitization and usercopy barriers only; no swapgs barriers
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'
[ 0.495936][ T0] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
[ 0.495936][ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
[ 0.495936][ T0] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64
[ 0.495936][ T0] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512
[ 0.495936][ T0] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024
[ 0.495936][ T0] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8
[ 0.495936][ T0] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.
[ 0.495936][ T0] pid_max: default: 32768 minimum: 301
[ 0.495936][ T0] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[ 0.495936][ T0] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
[ 0.495936][ T0] VFS: Finished mounting rootfs on nullfs
[ 0.495936][ T0] Running RCU synchronous self tests
[ 0.495936][ T0] Running RCU synchronous self tests
[ 0.495936][ T1] smpboot: CPU0: AMD EPYC 9655P 96-Core Processor (family: 0x1a, model: 0x2, stepping: 0x1)
[ 0.499215][ T1] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
[ 0.499949][ T1] ... version: 2
[ 0.500942][ T1] ... bit width: 48
[ 0.501942][ T1] ... generic counters: 6
[ 0.502942][ T1] ... generic bitmap: 000000000000003f
[ 0.503942][ T1] ... fixed-purpose counters: 0
[ 0.504944][ T1] ... fixed-purpose bitmap: 0000000000000000
[ 0.505944][ T1] ... value mask: 0000ffffffffffff
[ 0.506944][ T1] ... max period: 00007fffffffffff
[ 0.507943][ T1] ... global_ctrl mask: 000000000000003f
[ 0.509166][ T1] signal: max sigframe size: 3376
[ 0.510214][ T1] rcu: Hierarchical SRCU implementation.
[ 0.510946][ T1] rcu: Max phase no-delay instances is 400.
[ 0.517160][ T1] smp: Bringing up secondary CPUs ...
[ 0.520120][ T1] smpboot: x86: Booting SMP configuration:
[ 0.520956][ T1] .... node #0, CPUs: #1 #2 #3
[ 0.086817][ T0] numa_add_cpu cpu 1 node 0: mask now 0-1
[ 0.086817][ T0] numa_add_cpu cpu 2 node 0: mask now 0-2
[ 0.086817][ T0] numa_add_cpu cpu 3 node 0: mask now 0-3
[ 0.526315][ T1] smp: Brought up 1 node, 4 CPUs
[ 0.530953][ T1] smpboot: Total of 4 processors activated (20799.98 BogoMIPS)
[ 0.533943][ T1] Memory: 733752K/1048180K available (45826K kernel code, 12619K rwdata, 9480K rodata, 2520K init, 29376K bss, 303792K reserved, 0K cma-reserved)
[ 0.535908][ T1] devtmpfs: initialized
[ 0.536795][ T1] x86/mm: Memory block size: 128MB
[ 0.544115][ T1] Running RCU synchronous self tests
[ 0.544974][ T1] Running RCU synchronous self tests
[ 0.546404][ T1] Running RCU Tasks wait API self tests
[ 0.546993][ T1] Running RCU Tasks Rude wait API self tests
[ 0.547944][ T1] Running RCU Tasks Trace wait API self tests
[ 0.549047][ T1] posixtimers hash table entries: 2048 (order: 6, 147456 bytes, linear)
[ 0.550156][ T1] futex hash table entries: 1024 (131072 bytes on 1 NUMA nodes, total 128 KiB, linear).
[ 0.551962][ T1] PM: RTC time: 15:11:44, date: 2026-06-19
[ 0.553959][ T11] Callback from call_rcu_tasks_trace() invoked.
[ 0.556714][ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.559036][ T1] thermal_sys: Registered thermal governor 'step_wise'
[ 0.559129][ T1] cpuidle: using governor ladder
[ 0.562510][ T1] Freeing SMP alternatives memory: 36K
[ 0.564253][ T1] PCI: Fatal: No config space access function found
[ 0.565366][ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[ 0.569796][ T1] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
[ 0.569981][ T1] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
[ 0.570944][ T1] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
[ 0.572956][ T1] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
[ 0.576999][ T1] ACPI: Added _OSI(Module Device)
[ 0.577955][ T1] ACPI: Added _OSI(Processor Device)
[ 0.578951][ T1] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.609766][ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 0.617255][ T1] ACPI: \_SB_: platform _OSC: OS support mask [002a2e8e]
[ 0.620953][ T1] ACPI: Interpreter enabled
[ 0.622084][ T1] ACPI: PM: (supports S0 S5)
[ 0.623359][ T1] ACPI: Using IOAPIC for interrupt routing
[ 0.625182][ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.628062][ T1] PCI: Using E820 reservations for host bridge windows
[ 0.653178][ T1] ACPI: PCI: Interrupt link L000 configured for IRQ 16
[ 0.655448][ T1] ACPI: PCI: Interrupt link L001 configured for IRQ 17
[ 0.657382][ T1] ACPI: PCI: Interrupt link L002 configured for IRQ 18
[ 0.658197][ T1] ACPI: PCI: Interrupt link L003 configured for IRQ 19
[ 0.660713][ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.663328][ T1] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
[ 0.665406][ T1] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[ 0.675234][ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource
[ 0.699752][ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[ 0.703541][ T1] PCI host bridge to bus 0000:00
[ 0.704867][ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xdfffffff window]
[ 0.706957][ T1] pci_bus 0000:00: root bus resource [mem 0xc000000000000-0xfffffffffffff window]
[ 0.708971][ T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.710062][ T1] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint
[ 0.715868][ T1] iommu: Default domain type: Translated
[ 0.716943][ T1] iommu: DMA domain TLB invalidation policy: lazy mode
[ 0.720404][ T1] SCSI subsystem initialized
[ 0.722519][ T1] libata version 3.00 loaded.
[ 0.723895][ T1] pps_core: LinuxPPS API ver. 1 registered
[ 0.724943][ T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti
[ 0.727040][ T1] PTP clock support registered
[ 0.729376][ T1] Advanced Linux Sound Architecture Driver Initialized.
[ 0.733565][ T1] PCI: Using ACPI for IRQ routing
[ 0.734944][ T1] PCI: pci_cache_line_size set to 64 bytes
[ 0.735968][ T1] e820: register RAM buffer resource [mem 0x0009fc00-0x0009ffff]
[ 0.737963][ T1] e820: register RAM buffer resource [mem 0x3ffff000-0x3fffffff]
[ 0.739549][ T1] vgaarb: loaded
[ 0.741110][ T1] clocksource: Switched to clocksource kvm-clock
[ 0.744702][ T1] VFS: Disk quotas dquot_6.6.0
[ 0.745836][ T1] VFS: Dquot-cache hash table entries: 512 (4096 bytes)
[ 0.751045][ T1] acpi PNP0C02:00: Reserved [mem 0xe0000000-0xefffffff]
[ 0.752839][ T1] pnp: PnP ACPI init
[ 0.754977][ T1] pnp: PnP ACPI: found 1 devices
[ 0.759862][ T42] Callback from call_rcu_tasks() invoked.
[ 0.780837][ T1] NET: Registered PF_INET protocol family
[ 0.782412][ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 0.785986][ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 4, 36864 bytes, linear)
[ 0.788070][ T1] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.790067][ T1] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 0.792100][ T1] TCP bind hash table entries: 8192 (order: 9, 1179648 bytes, linear)
[ 0.794496][ T1] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.796338][ T1] UDP hash table entries: 512 (order: 5, 131072 bytes, linear)
[ 0.798517][ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 0.800054][ T1] pci_bus 0000:00: resource 4 [mem 0xc0000000-0xdfffffff window]
[ 0.801704][ T1] pci_bus 0000:00: resource 5 [mem 0xc000000000000-0xfffffffffffff window]
[ 0.803635][ T1] PCI: CLS 0 bytes, default 64
[ 0.805288][ T1] kvm_intel: VMX not supported by CPU 2
[ 0.806564][ T1] kvm_amd: TSC scaling supported
[ 0.807617][ T1] kvm_amd: Nested Virtualization enabled
[ 0.808812][ T1] kvm_amd: Nested Paging enabled
[ 0.809868][ T1] kvm_amd: LBR virtualization supported
[ 0.811068][ T1] kvm_amd: Virtual VMLOAD VMSAVE supported
[ 0.812312][ T1] kvm_amd: Virtual GIF supported
[ 0.813360][ T1] kvm_amd: Virtual NMI enabled
[ 0.821387][ T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x257a3a7b45f, max_idle_ns: 440795312762 ns
[ 0.831168][ T1] Initialise system trusted keyrings
[ 0.832661][ T1] workingset: timestamp_bits=56 (anon: 52) max_order=18 bucket_order=0 (anon: 0)
[ 0.841713][ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 0.843238][ T1] fuse: init (API version 7.45)
[ 0.844755][ T1] 9p: Installing v9fs 9p2000 file system support
[ 0.846548][ T1] Key type asymmetric registered
[ 0.847680][ T1] Asymmetric key parser 'x509' registered
[ 0.849193][ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 0.851044][ T1] io scheduler mq-deadline registered
[ 0.852180][ T1] io scheduler kyber registered
[ 0.856456][ T1] input: Power Button as /devices/platform/PNP0C0C:00/input/input0
[ 0.858640][ T1] ACPI: button: Power Button [PWRB]
[ 0.862359][ T1] virtiofs virtio0: discovered new tag: ROOTFS
[ 0.864585][ T1] virtiofs virtio0: virtio_fs_setup_dax: No cache capability
[ 0.869492][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.873088][ T1] 00:00: ttyS0 at I/O 0x3f8 (irq = 52, base_baud = 115200) is a 16550A
[ 0.943745][ T1] ACPI: bus type drm_connector registered
[ 0.969459][ T1] loop: module loaded
[ 0.976761][ T1] i8042: PNP: No PS/2 controller found.
[ 0.982643][ T1] rtc_cmos PNP0B00:00: registered as rtc0
[ 0.984173][ T1] rtc_cmos PNP0B00:00: setting system clock to 2026-06-19T15:11:45 UTC (1781881905)
[ 0.986526][ T1] rtc_cmos PNP0B00:00: alarms up to one day, 242 bytes nvram
[ 0.988135][ T52] printk: legacy console [hvc0] enabled
[ 0.989317][ T52] printk: legacy bootconsole [earlyser0] disabled
[ 0.989767][ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
_ _
__ _(_)_ __| |_ _ __ ___ ___ _ __ __ _
\ \ / / | __| __| _ _ \ / _ \_____| _ \ / _ |
\ V /| | | | |_| | | | | | __/_____| | | | (_| |
\_/ |_|_| \__|_| |_| |_|\___| |_| |_|\__ |
|___/
kernel version: 7.1.0-virtme x86_64
(CTRL+d to exit)
bash-5.3# PS1='xx__-> '
xx__-> ls /sys/kernel/debug/
acpi dmaengine mce stackdepot
bdi dri multigrain_timestamps suspend_stats
block dynamic_debug page_tables swiotlb
check_wx_pages extfrag ptp0 tracing
clear_warn_once fault_around_bytes ref_tracker virtio-ports
debug_objects i2c rseq wakeup_sources
device_component kmemleak sched x86
devices_deferred kprobes slab
dma_buf kvm sleep_time
xx__-> <4/:/srv/vmksft/tools/fs/usr/lib64/:$LD_LIBRARY_PATH
xx__-> export KSFT_MACHINE_SLOW=yes
xx__-> export kselftest_override_timeout=21600
xx__-> env
SHELL=/bin/bash
PWD=/srv/vmksft/testing/wt-4
nr_open=2147483584
virtme_hostname=vmksft-forwarding-dbg,debug-threads=on
KSFT_MACHINE_SLOW=yes
HOME=/root
virtme_chdir=srv/vmksft/testing/wt-4
kselftest_override_timeout=21600
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=/lib64/:/srv/vmksft/tools/fs/usr/lib/:/srv/vmksft/tools/fs/lib64/:/srv/vmksft/tools/fs/usr/lib64/:
XDG_RUNTIME_DIR=/run/user/0
virtme_link_mods=/srv/vmksft/testing/wt-4/.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__->