reserved # 161.28 [+0.01] [ 0.006817] [ T0] e820: remove [mem 0x000a0000-0x000fffff] usable # 161.28 [+0.01] [ 0.007992] [ T0] last_pfn = 0x3ffff max_arch_pfn = 0x10000000000 # 161.29 [+0.01] [ 0.009184] [ T0] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs # 161.29 [+0.01] [ 0.010872] [ T0] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT # 161.30 [+0.01] [ 0.014221] [ T0] found SMP MP-table at [mem 0x000f5690-0x000f569f] # 161.30 [+0.01] [ 0.015442] [ T0] Using GB pages for direct mapping # 161.31 [+0.00] [ 0.016513] [ T0] ACPI: Early table checksum verification disabled # 161.31 [+0.01] [ 0.017701] [ T0] ACPI: RSDP 0x00000000000F54B0 000024 (v02 BOCHS ) # 161.32 [+0.01] [ 0.018910] [ T0] ACPI: XSDT 0x000000003FFFFFCA 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) # 161.33 [+0.01] [ 0.020646] [ T0] ACPI: FACP 0x000000003FFFFE54 00010C (v05 BOCHS BXPC 00000001 BXPC 00000001) # 161.33 [+0.01] [ 0.022379] [ T0] ACPI: DSDT 0x000000003FFFF240 000C14 (v02 BOCHS BXPC 00000001 BXPC 00000001) # 161.34 [+0.01] [ 0.024105] [ T0] ACPI: APIC 0x000000003FFFFF60 00006A (v03 BOCHS BXPC 00000001 BXPC 00000001) # 161.35 [+0.01] [ 0.025835] [ T0] ACPI: Reserving FACP table memory at [mem 0x3ffffe54-0x3fffff5f] # 161.35 [+0.01] [ 0.027287] [ T0] ACPI: Reserving DSDT table memory at [mem 0x3ffff240-0x3ffffe53] # 161.36 [+0.01] [ 0.028740] [ T0] ACPI: Reserving APIC table memory at [mem 0x3fffff60-0x3fffffc9] # 161.37 [+0.01] [ 0.030731] [ T0] No NUMA configuration found # 161.37 [+0.00] [ 0.031584] [ T0] Faking a node at [mem 0x0000000000000000-0x000000003fffefff] # 161.37 [+0.01] [ 0.032973] [ T0] NODE_DATA(0) allocated [mem 0x3fffa100-0x3fffefff] # 161.38 [+0.01] [ 0.042449] [ T0] Zone ranges: # 161.38 [+0.00] [ 0.043068] [ T0] DMA [mem 0x0000000000001000-0x0000000000ffffff] # 161.39 [+0.01] [ 0.044368] [ T0] DMA32 [mem 0x0000000001000000-0x000000003fffefff] # 161.39 [+0.01] [ 0.045659] [ T0] Normal empty # 161.40 [+0.00] [ 0.046338] [ T0] Device empty # 161.40 [+0.00] [ 0.047010] [ T0] Movable zone start for each node # 161.40 [+0.00] [ 0.047946] [ T0] Early memory node ranges # 161.41 [+0.00] [ 0.048750] [ T0] node 0: [mem 0x0000000000001000-0x000000000009efff] # 161.41 [+0.01] [ 0.050059] [ T0] node 0: [mem 0x0000000000100000-0x000000003fffefff] # 161.42 [+0.01] [ 0.051373] [ T0] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffefff] # 161.42 [+0.01] [ 0.052833] [ T0] On node 0, zone DMA: 1 pages in unavailable ranges # 161.43 [+0.01] [ 0.054097] [ T0] On node 0, zone DMA: 97 pages in unavailable ranges # 161.43 [+0.01] [ 0.057543] [ T0] On node 0, zone DMA32: 1 pages in unavailable ranges # 161.44 [+0.01] [ 0.129163] [ T0] KernelAddressSanitizer initialized (generic) # 161.44 [+0.00] [ 0.130787] [ T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) # 161.45 [+0.01] [ 0.132120] [ T0] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 # 161.46 [+0.01] [ 0.133651] [ T0] IOAPIC[1]: apic_id 1, version 32, address 0xfec10000, GSI 24-47 # 161.46 [+0.01] [ 0.135100] [ T0] ACPI: Using ACPI (MADT) for SMP configuration information # 161.47 [+0.01] [ 0.136454] [ T0] TSC deadline timer available # 161.47 [+0.00] [ 0.137332] [ T0] CPU topo: Max. logical packages: 1 # 161.48 [+0.00] [ 0.138337] [ T0] CPU topo: Max. logical dies: 1 # 161.48 [+0.00] [ 0.139352] [ T0] CPU topo: Max. dies per package: 1 # 161.48 [+0.00] [ 0.140362] [ T0] CPU topo: Max. threads per core: 1 # 161.49 [+0.00] [ 0.141366] [ T0] CPU topo: Num. cores per package: 4 # 161.49 [+0.00] [ 0.142420] [ T0] CPU topo: Num. threads per package: 4 # 161.50 [+0.00] [ 0.143473] [ T0] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs # 161.50 [+0.01] [ 0.144788] [ T0] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() # 161.51 [+0.01] [ 0.146260] [ T0] kvm-guest: KVM setup pv remote TLB flush # 161.51 [+0.00] [ 0.147333] [ T0] kvm-guest: setup PV sched yield # 161.52 [+0.00] [ 0.148290] [ T0] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] # 161.52 [+0.01] [ 0.149860] [ T0] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] # 161.53 [+0.01] [ 0.151430] [ T0] [mem 0x40000000-0xfeffbfff] available for PCI devices # 161.54 [+0.01] [ 0.152713] [ T0] Booting paravirtualized kernel on KVM # 161.54 [+0.00] [ 0.153740] [ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns # 161.55 [+0.01] [ 0.164770] [ T0] setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 # 161.56 [+0.01] [ 0.167309] [ T0] percpu: Embedded 66 pages/cpu s232080 r8192 d30064 u524288 # 161.56 [+0.01] [ 0.168684] [ T0] pcpu-alloc: s232080 r8192 d30064 u524288 alloc=1*2097152 # 161.57 [+0.01] [ 0.170018] [ T0] pcpu-alloc: [0] 0 1 2 3 # 161.57 [+0.00] [ 0.170887] [ 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 console=hvc0 earlyprintk=serial,ttyS0,115200 virtme_console=ttyS0 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 # 161.61 [+0.04] [ 0.181659] [ 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. # 161.65 [+0.03] [ 0.189814] [ T0] random: crng init done # 161.65 [+0.00] [ 0.190598] [ T0] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes # 161.65 [+0.01] [ 0.192601] [ T0] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) # 161.66 [+0.01] [ 0.194468] [ T0] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) # 161.67 [+0.01] [ 0.196303] [ T0] Fallback order for Node 0: 0 # 161.67 [+0.00] [ 0.196309] [ T0] Built 1 zonelists, mobility grouping on. Total pages: 262045 # 161.68 [+0.01] [ 0.198625] [ T0] Policy zone: DMA32 # 161.68 [+0.00] [ 0.199345] [ T0] mem auto-init: stack:all(zero), heap alloc:off, heap free:off # 161.69 [+0.01] [ 0.200766] [ T0] stackdepot: allocating hash table via alloc_large_system_hash # 161.69 [+0.01] [ 0.202192] [ T0] stackdepot hash table entries: 1048576 (order: 12, 16777216 bytes, linear) # 161.70 [+0.01] [ 0.211070] [ T0] stackdepot: allocating space for 8192 stack pools via memblock # 161.71 [+0.01] [ 0.235512] [ T0] ********************************************************** # 161.71 [+0.01] [ 0.236905] [ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 161.72 [+0.01] [ 0.238284] [ T0] ** ** # 161.72 [+0.01] [ 0.239656] [ T0] ** This system shows unhashed kernel memory addresses ** # 161.73 [+0.01] [ 0.241031] [ T0] ** via the console, logs, and other interfaces. This ** # 161.74 [+0.01] [ 0.242411] [ T0] ** might reduce the security of your system. ** # 161.74 [+0.01] [ 0.243792] [ T0] ** ** # 161.75 [+0.01] [ 0.245165] [ T0] ** If you see this message and you are not debugging ** # 161.75 [+0.01] [ 0.246543] [ T0] ** the kernel, report this immediately to your system ** # 161.76 [+0.01] [ 0.247914] [ T0] ** administrator! ** # 161.76 [+0.01] [ 0.249294] [ T0] ** ** # 161.77 [+0.01] [ 0.250680] [ T0] ** Use hash_pointers=always to force this mode off ** # 161.78 [+0.01] [ 0.252050] [ T0] ** ** # 161.78 [+0.01] [ 0.253428] [ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 161.79 [+0.01] [ 0.254800] [ T0] ********************************************************** # 161.79 [+0.01] [ 0.256609] [ T0] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 # 161.80 [+0.01] [ 0.273482] [ T0] ftrace: allocating 46476 entries in 184 pages # 161.80 [+0.00] [ 0.274648] [ T0] ftrace: allocated 184 pages with 4 groups # 161.81 [+0.00] [ 0.276100] [ T0] Dynamic Preempt: full # 161.81 [+0.00] [ 0.278002] [ T0] Running RCU self tests # 161.81 [+0.00] [ 0.278798] [ T0] Running RCU synchronous self tests # 161.82 [+0.00] [ 0.279778] [ T0] rcu: Preemptible hierarchical RCU implementation. # 161.82 [+0.01] [ 0.281003] [ T0] rcu: RCU event tracing is enabled. # 161.83 [+0.00] [ 0.281999] [ T0] rcu: RCU lockdep checking is enabled. # 161.83 [+0.00] [ 0.283042] [ T0] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. # 161.84 [+0.01] [ 0.284434] [ T0] rcu: RCU callback double-/use-after-free debug is enabled. # 161.84 [+0.01] [ 0.285820] [ T0] Trampoline variant of Tasks RCU enabled. # 161.85 [+0.00] [ 0.286912] [ T0] Rude variant of Tasks RCU enabled. # 161.85 [+0.00] [ 0.287907] [ T0] Tracing variant of Tasks RCU enabled. # 161.86 [+0.00] [ 0.288951] [ T0] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. # 161.86 [+0.01] [ 0.290540] [ T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 # 161.87 [+0.01] [ 0.292168] [ T0] Running RCU synchronous self tests # 161.87 [+0.00] [ 0.293165] [ T0] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 161.88 [+0.01] [ 0.294968] [ T0] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 161.89 [+0.01] [ 0.296849] [ T0] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 161.90 [+0.01] [ 0.346239] [ T0] NR_IRQS: 4352, nr_irqs: 848, preallocated irqs: 0 # 161.90 [+0.01] [ 0.347700] [ T0] rcu: srcu_init: Setting srcu_struct sizes based on contention. # 161.91 [+0.01] [ 0.349952] [ T0] Console: colour *CGA 80x25 # 161.91 [+0.00] [ 0.350851] [ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar # 161.92 [+0.01] [ 0.352460] [ T0] ... MAX_LOCKDEP_SUBCLASSES: 8 # 161.92 [+0.00] [ 0.353375] [ T0] ... MAX_LOCK_DEPTH: 48 # 161.93 [+0.00] [ 0.354305] [ T0] ... MAX_LOCKDEP_KEYS: 8192 # 161.93 [+0.00] [ 0.355269] [ T0] ... CLASSHASH_SIZE: 4096 # 161.93 [+0.00] [ 0.356226] [ T0] ... MAX_LOCKDEP_ENTRIES: 32768 # 161.94 [+0.00] [ 0.357204] [ T0] ... MAX_LOCKDEP_CHAINS: 65536 # 161.94 [+0.00] [ 0.358184] [ T0] ... CHAINHASH_SIZE: 32768 # 161.95 [+0.00] [ 0.359164] [ T0] memory used by lock dependency info: 6429 kB # 161.95 [+0.00] [ 0.360343] [ T0] memory used for stack traces: 4224 kB # 161.96 [+0.00] [ 0.361389] [ T0] per task-struct memory footprint: 1920 bytes # 161.96 [+0.00] [ 0.362683] [ T0] ACPI: Core revision 20250807 # 161.96 [+0.00] [ 0.364185] [ T0] APIC: Switch to symmetric I/O mode setup # 161.97 [+0.00] [ 0.367042] [ T0] x2apic enabled # 161.97 [+0.00] [ 0.374687] [ T0] APIC: Switched APIC routing to: physical x2apic # 161.98 [+0.01] [ 0.375890] [ T0] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() # 161.98 [+0.01] [ 0.377408] [ T0] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() # 161.99 [+0.01] [ 0.379290] [ T0] kvm-guest: setup PV IPIs # 161.99 [+0.00] [ 0.380287] [ T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x257a3c3232d, max_idle_ns: 440795236700 ns # 162.00 [+0.01] [ 0.382448] [ T0] Calibrating delay loop (skipped) preset value.. 5200.00 BogoMIPS (lpj=2600000) # 162.01 [+0.01] [ 0.383439] [ T0] RDSEED32 is broken. Disabling the corresponding CPUID bit. # 162.02 [+0.01] [ 0.383439] [ T0] x86/cpu: User Mode Instruction Prevention (UMIP) activated # 162.02 [+0.01] [ 0.383439] [ T0] numa_add_cpu cpu 0 node 0: mask now 0 # 162.03 [+0.00] [ 0.383439] [ T0] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 # 162.03 [+0.01] [ 0.383439] [ T0] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 # 162.04 [+0.01] [ 0.383439] [ T0] mitigations: Enabled attack vectors: SMT mitigations: off # 162.04 [+0.01] [ 0.383439] [ T0] Speculative Store Bypass: Vulnerable # 162.05 [+0.00] [ 0.383439] [ T0] Spectre V2 : Vulnerable # 162.05 [+0.00] [ 0.383439] [ T0] Speculative Return Stack Overflow: Vulnerable # 162.06 [+0.01] [ 0.383439] [ T0] Spectre V1 : Vulnerable: __user pointer sanitization and usercopy barriers only; no swapgs barriers # 162.07 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' # 162.07 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' # 162.08 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' # 162.08 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' # 162.09 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' # 162.10 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' # 162.10 [+0.01] [ 0.383439] [ T0] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' # 162.11 [+0.01] [ 0.383439] [ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 # 162.12 [+0.01] [ 0.383439] [ T0] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 # 162.12 [+0.01] [ 0.383439] [ T0] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 # 162.13 [+0.01] [ 0.383439] [ T0] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 # 162.13 [+0.01] [ 0.383439] [ T0] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 # 162.14 [+0.01] [ 0.383439] [ T0] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. # 162.15 [+0.01] [ 0.383439] [ T0] Freeing SMP alternatives memory: 36K # 162.15 [+0.00] [ 0.383439] [ T0] pid_max: default: 32768 minimum: 301 # 162.16 [+0.00] [ 0.383439] [ T0] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 162.16 [+0.01] [ 0.383439] [ T0] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 162.17 [+0.01] [ 0.383439] [ T0] Running RCU synchronous self tests # 162.17 [+0.00] [ 0.383439] [ T0] Running RCU synchronous self tests # 162.18 [+0.00] [ 0.383439] [ T1] smpboot: CPU0: AMD EPYC 9655P 96-Core Processor (family: 0x1a, model: 0x2, stepping: 0x1) # 162.19 [+0.01] [ 0.387835] [ T1] Performance Events: Fam17h+ core perfctr, AMD PMU driver. # 162.19 [+0.01] [ 0.388462] [ T1] ... version: 2 # 162.20 [+0.00] [ 0.389406] [ T1] ... bit width: 48 # 162.20 [+0.00] [ 0.389448] [ T1] ... generic counters: 6 # 162.21 [+0.00] [ 0.390388] [ T1] ... generic bitmap: 000000000000003f # 162.21 [+0.01] [ 0.390448] [ T1] ... fixed-purpose counters: 0 # 162.22 [+0.00] [ 0.391387] [ T1] ... fixed-purpose bitmap: 0000000000000000 # 162.22 [+0.01] [ 0.391448] [ T1] ... value mask: 0000ffffffffffff # 162.23 [+0.01] [ 0.392449] [ T1] ... max period: 00007fffffffffff # 162.23 [+0.01] [ 0.393447] [ T1] ... global_ctrl mask: 000000000000003f # 162.24 [+0.01] [ 0.394730] [ T1] signal: max sigframe size: 3376 # 162.24 [+0.00] [ 0.395869] [ T1] rcu: Hierarchical SRCU implementation. # 162.24 [+0.00] [ 0.396458] [ T1] rcu: Max phase no-delay instances is 400. # 162.25 [+0.00] [ 0.405886] [ T1] smp: Bringing up secondary CPUs ... # 162.25 [+0.00] [ 0.408958] [ T1] smpboot: x86: Booting SMP configuration: # 162.26 [+0.00] [ 0.409493] [ T1] .... node #0, CPUs: #1 #2 #3 # 162.26 [+0.00] [ 0.034293] [ T0] numa_add_cpu cpu 1 node 0: mask now 0-1 # 162.27 [+0.00] [ 0.034293] [ T0] numa_add_cpu cpu 2 node 0: mask now 0-2 # 162.27 [+0.00] [ 0.034293] [ T0] numa_add_cpu cpu 3 node 0: mask now 0-3 # 162.28 [+0.00] [ 0.414976] [ T1] smp: Brought up 1 node, 4 CPUs # 162.28 [+0.00] [ 0.419387] [ T1] smpboot: Total of 4 processors activated (20800.00 BogoMIPS) # 162.29 [+0.01] [ 0.422335] [ T1] Memory: 749204K/1048180K available (43965K kernel code, 12511K rwdata, 9108K rodata, 2444K init, 16968K bss, 288364K reserved, 0K cma-reserved) # 162.30 [+0.01] [ 0.423828] [ T1] devtmpfs: initialized # 162.30 [+0.00] [ 0.425614] [ T1] x86/mm: Memory block size: 128MB # 162.30 [+0.00] [ 0.437663] [ T1] Running RCU synchronous self tests # 162.31 [+0.00] [ 0.438604] [ T1] Running RCU synchronous self tests # 162.31 [+0.00] [ 0.440182] [ T1] Running RCU Tasks wait API self tests # 162.32 [+0.00] [ 0.440564] [ T1] Running RCU Tasks Rude wait API self tests # 162.32 [+0.00] [ 0.441450] [ T1] Running RCU Tasks Trace wait API self tests # 162.33 [+0.00] [ 0.455669] [ T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns # 162.33 [+0.01] [ 0.456531] [ T1] posixtimers hash table entries: 2048 (order: 6, 147456 bytes, linear) # 162.34 [+0.01] [ 0.457624] [ T1] futex hash table entries: 1024 (131072 bytes on 1 NUMA nodes, total 128 KiB, linear). # 162.35 [+0.01] [ 0.460041] [ T1] PM: RTC time: 18:08:30, date: 2025-12-19 # 162.35 [+0.00] [ 0.463774] [ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family # 162.36 [+0.01] [ 0.467449] [ T1] thermal_sys: Registered thermal governor 'step_wise' # 162.36 [+0.01] [ 0.467611] [ T1] cpuidle: using governor ladder # 162.37 [+0.00] [ 0.472748] [ T1] PCI: Fatal: No config space access function found # 162.37 [+0.01] [ 0.474101] [ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. # 162.38 [+0.01] [ 0.474722] [ T43] Callback from call_rcu_tasks_trace() invoked. # 162.38 [+0.00] [ 0.478130] [ T1] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages # 162.39 [+0.01] [ 0.479455] [ T1] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page # 162.40 [+0.01] [ 0.480449] [ T1] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages # 162.40 [+0.01] [ 0.482448] [ T1] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page # 162.41 [+0.01] [ 0.488413] [ T1] ACPI: Added _OSI(Module Device) # 162.41 [+0.00] [ 0.489453] [ T1] ACPI: Added _OSI(Processor Device) # 162.42 [+0.00] [ 0.490485] [ T1] ACPI: Added _OSI(Processor Aggregator Device) # 162.42 [+0.00] [ 0.539943] [ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded # 162.43 [+0.01] [ 0.562761] [ T1] ACPI: Interpreter enabled # 162.43 [+0.00] [ 0.563743] [ T1] ACPI: PM: (supports S0 S5) # 162.44 [+0.00] [ 0.565579] [ T1] ACPI: Using IOAPIC for interrupt routing # 162.44 [+0.00] [ 0.566801] [ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug # 162.45 [+0.01] [ 0.568449] [ T1] PCI: Using E820 reservations for host bridge windows # 162.45 [+0.01] [ 0.610275] [ T1] ACPI: PCI: Interrupt link L000 configured for IRQ 16 # 162.46 [+0.01] [ 0.612784] [ T1] ACPI: PCI: Interrupt link L001 configured for IRQ 17 # 162.46 [+0.01] [ 0.613805] [ T1] ACPI: PCI: Interrupt link L002 configured for IRQ 18 # 162.47 [+0.01] [ 0.615742] [ T1] ACPI: PCI: Interrupt link L003 configured for IRQ 19 # 162.47 [+0.01] [ 0.616773] [ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) # 162.48 [+0.01] [ 0.618879] [ T1] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] # 162.49 [+0.01] [ 0.620450] [ T1] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] # 162.50 [+0.01] [ 0.632098] [ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource # 162.50 [+0.01] [ 0.646871] [ T41] Callback from call_rcu_tasks() invoked. # 162.51 [+0.00] [ 0.655662] [ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) # 162.51 [+0.01] [ 0.660044] [ T1] PCI host bridge to bus 0000:00 # 162.52 [+0.00] [ 0.662040] [ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xdfffffff window] # 162.52 [+0.01] [ 0.663475] [ T1] pci_bus 0000:00: root bus resource [mem 0xc000000000000-0xfffffffffffff window] # 162.53 [+0.01] [ 0.665469] [ T1] pci_bus 0000:00: root bus resource [bus 00-ff] # 162.54 [+0.01] [ 0.666684] [ T1] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint # 162.54 [+0.01] [ 0.672416] [ T1] iommu: Default domain type: Translated # 162.55 [+0.00] [ 0.673450] [ T1] iommu: DMA domain TLB invalidation policy: lazy mode # 162.55 [+0.01] [ 0.679114] [ T1] SCSI subsystem initialized # 162.56 [+0.00] [ 0.680197] [ T1] libata version 3.00 loaded. # 162.56 [+0.00] [ 0.683222] [ T1] pps_core: LinuxPPS API ver. 1 registered # 162.57 [+0.00] [ 0.684453] [ T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti # 162.57 [+0.01] [ 0.686640] [ T1] PTP clock support registered # 162.58 [+0.00] [ 0.689298] [ T1] Advanced Linux Sound Architecture Driver Initialized. # 162.58 [+0.01] [ 0.694832] [ T1] PCI: Using ACPI for IRQ routing # 162.59 [+0.00] [ 0.695449] [ T1] PCI: pci_cache_line_size set to 64 bytes # 162.59 [+0.00] [ 0.696481] [ T1] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] # 162.60 [+0.01] [ 0.698510] [ T1] e820: reserve RAM buffer [mem 0x3ffff000-0x3fffffff] # 162.60 [+0.01] [ 0.700168] [ T1] vgaarb: loaded # 162.61 [+0.00] [ 0.701439] [ T1] clocksource: Switched to clocksource kvm-clock # 162.61 [+0.01] [ 0.725808] [ T1] VFS: Disk quotas dquot_6.6.0 # 162.61 [+0.00] [ 0.726807] [ T1] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) # 162.62 [+0.01] [ 0.732654] [ T1] pnp: PnP ACPI init # 162.62 [+0.00] [ 0.736999] [ T1] system 00:02: [mem 0xe0000000-0xefffffff window] has been reserved # 162.63 [+0.01] [ 0.738784] [ T1] pnp: PnP ACPI: found 3 devices # 162.63 [+0.00] [ 0.773117] [ T1] NET: Registered PF_INET protocol family # 162.64 [+0.00] [ 0.774502] [ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) # 162.65 [+0.01] [ 0.778864] [ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 4, 36864 bytes, linear) # 162.65 [+0.01] [ 0.781027] [ T1] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) # 162.66 [+0.01] [ 0.782830] [ T1] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) # 162.67 [+0.01] [ 0.784649] [ T1] TCP bind hash table entries: 8192 (order: 9, 1179648 bytes, linear) # 162.67 [+0.01] [ 0.786352] [ T1] TCP: Hash tables configured (established 8192 bind 8192) # 162.68 [+0.01] [ 0.788081] [ T1] UDP hash table entries: 512 (order: 5, 131072 bytes, linear) # 162.68 [+0.01] [ 0.789570] [ T1] UDP-Lite hash table entries: 512 (order: 5, 131072 bytes, linear) # 162.69 [+0.01] [ 0.791869] [ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family # 162.70 [+0.01] [ 0.793251] [ T1] pci_bus 0000:00: resource 4 [mem 0xc0000000-0xdfffffff window] # 162.70 [+0.01] [ 0.794724] [ T1] pci_bus 0000:00: resource 5 [mem 0xc000000000000-0xfffffffffffff window] # 162.71 [+0.01] [ 0.796414] [ T1] PCI: CLS 0 bytes, default 64 # 162.71 [+0.00] [ 0.797542] [ T1] kvm_intel: VMX not supported by CPU 1 # 162.72 [+0.00] [ 0.799637] [ T1] kvm_amd: TSC scaling supported # 162.72 [+0.00] [ 0.800592] [ T1] kvm_amd: Nested Virtualization enabled # 162.72 [+0.00] [ 0.801664] [ T1] kvm_amd: Nested Paging enabled # 162.73 [+0.00] [ 0.802604] [ T1] kvm_amd: LBR virtualization supported # 162.73 [+0.00] [ 0.803690] [ T1] kvm_amd: Virtual VMLOAD VMSAVE supported # 162.74 [+0.00] [ 0.804794] [ T1] kvm_amd: Virtual GIF supported # 162.74 [+0.00] [ 0.805731] [ T1] kvm_amd: Virtual NMI enabled # 162.75 [+0.00] [ 0.814218] [ T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x257a3c3232d, max_idle_ns: 440795236700 ns # 162.75 [+0.01] [ 0.827530] [ T1] Initialise system trusted keyrings # 162.76 [+0.00] [ 0.828979] [ T1] workingset: timestamp_bits=56 max_order=18 bucket_order=0 # 162.76 [+0.01] [ 0.842667] [ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher # 162.77 [+0.01] [ 0.844070] [ T1] fuse: init (API version 7.45) # 162.77 [+0.00] [ 0.845726] [ T1] 9p: Installing v9fs 9p2000 file system support # 162.78 [+0.00] [ 0.855149] [ T1] Key type asymmetric registered # 162.78 [+0.00] [ 0.856118] [ T1] Asymmetric key parser 'x509' registered # 162.79 [+0.00] [ 0.857607] [ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) # 162.79 [+0.01] [ 0.859394] [ T1] io scheduler mq-deadline registered # 162.80 [+0.00] [ 0.860452] [ T1] io scheduler kyber registered # 162.80 [+0.00] [ 0.865471] [ T1] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 # 162.81 [+0.01] [ 0.868110] [ T1] ACPI: button: Power Button [PWRB] # 162.81 [+0.00] [ 0.872201] [ T1] virtiofs virtio0: discovered new tag: ROOTFS # 162.82 [+0.00] [ 0.874398] [ T1] virtiofs virtio0: virtio_fs_setup_dax: No cache capability # 162.82 [+0.01] [ 0.882827] [ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled # 162.83 [+0.01] [ 0.885913] [ T1] 00:00: ttyS0 at I/O 0x3f8 (irq = 51, base_baud = 115200) is a 16550A # 162.83 [+0.01] [ 0.974080] [ T1] ACPI: bus type drm_connector registered # 162.84 [+0.00] [ 1.014934] [ T1] loop: module loaded # 162.84 [+0.00] [ 1.027565] [ T1] i8042: PNP: No PS/2 controller found. # 162.85 [+0.00] [ 1.035317] [ T1] rtc_cmos 00:01: registered as rtc0 # 162.85 [+0.00] [ 1.036431] [ T66] printk: legacy console [hvc0] enabled # 162.86 [+0.00] [ 1.036541] [ T1] rtc_cmos 00:01: setting system clock to 2025-12-19T18:08:31 UTC (1766167711) # 162.86 [+0.01] [ 1.037524] [ T66] printk: legacy bootconsole [earlyser0] disabled # 162.87 [+0.01] [ 1.039891] [ T1] rtc_cmos 00:01: alarms up to one day, 242 bytes nvram # 162.87 [+0.01] [ 1.044268] [ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev # 162.88 [+0.01] [ 1.051301] [ T1] NET: Registered PF_INET6 protocol family # 162.88 [+0.00] [ 1.055456] [ T1] Segment Routing with IPv6 # 162.89 [+0.00] [ 1.055831] [ T1] In-situ OAM (IOAM) with IPv6 # 162.89 [+0.00] [ 1.056141] [ T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver # 162.90 [+0.01] [ 1.059257] [ T1] NET: Registered PF_PACKET protocol family # 162.90 [+0.00] [ 1.059465] [ T1] 9pnet: Installing 9P2000 support # 162.91 [+0.00] [ 1.059787] [ T1] Key type dns_resolver registered # 162.91 [+0.00] [ 1.060380] [ T1] NET: Registered PF_VSOCK protocol family # 162.91 [+0.00] [ 1.064680] [ T1] IPI shorthand broadcast: enabled # 162.92 [+0.00] [ 1.169493] [ T1] sched_clock: Marking stable (1136002170, 33293830)->(1241146940, -71850940) # 162.93 [+0.01] [ 1.171307] [ T1] registered taskstats version 1 # 162.93 [+0.00] [ 1.173090] [ T1] Loading compiled-in X.509 certificates # 162.93 [+0.00] [ 1.257741] [ T1] Demotion targets for Node 0: null # 162.94 [+0.00] [ 1.257933] [ T1] kmemleak: Kernel memory leak detector initialized (mem pool available: 12101) # 162.94 [+0.01] [ 1.258125] [ T1] page_owner is disabled # 162.95 [+0.00] [ 1.258730] [ T1] PM: Magic number: 5:440:140 # 162.95 [+0.00] [ 1.258880] [ T1] netconsole: network logging started # 162.96 [+0.00] [ 1.260290] [ T1] ALSA device list: # 162.96 [+0.00] [ 1.260397] [ T1] No soundcards found. # 162.96 [+0.00] [ 1.262011] [ T1] check access for rdinit=/init failed: -2, ignoring # 162.97 [+0.01] [ 1.262174] [ T1] md: Skipping autodetection of RAID arrays. (raid=autodetect will force) # 162.97 [+0.01] [ 1.264434] [ T1] VFS: Mounted root (virtiofs filesystem) readonly on device 0:21. # 162.98 [+0.01] [ 1.265132] [ T1] devtmpfs: mounted # 162.98 [+0.00] [ 1.292437] [ T1] Freeing unused kernel image (initmem) memory: 2444K # 162.99 [+0.01] [ 1.292662] [ T1] Write protecting the kernel read-only data: 55296k # 162.99 [+0.01] [ 1.293333] [ T1] Freeing unused kernel image (text/rodata gap) memory: 1088K # 163.00 [+0.01] [ 1.293824] [ T1] Freeing unused kernel image (rodata/data gap) memory: 1132K # 163.01 [+0.01] [ 1.294085] [ T1] Run /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init as init process # 163.01 [+0.01] [ 1.294261] [ T1] with arguments: # 163.02 [+0.00] [ 1.294352] [ T1] /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init # 163.02 [+0.01] [ 1.294520] [ T1] with environment: # 163.03 [+0.00] [ 1.294603] [ T1] HOME=/ # 163.03 [+0.00] [ 1.294690] [ T1] TERM=dumb # 163.03 [+0.00] [ 1.294768] [ T1] virtme_hostname=vmksft-forwarding-dbg,debug-threads=on # 163.04 [+0.01] [ 1.294974] [ T1] nr_open=2147483584 # 163.04 [+0.00] [ 1.295050] [ T1] virtme_link_mods=/srv/vmksft/testing/wt-4/.virtme_mods/lib/modules/0.0.0 # 163.05 [+0.01] [ 1.295227] [ T1] virtme_rw_overlay0=/etc # 163.05 [+0.00] [ 1.295386] [ T1] virtme_rw_overlay1=/lib # 163.05 [+0.00] [ 1.295499] [ T1] virtme_rw_overlay2=/home # 163.06 [+0.00] [ 1.295603] [ T1] virtme_rw_overlay3=/opt # 163.06 [+0.00] [ 1.295706] [ T1] virtme_rw_overlay4=/srv # 163.07 [+0.00] [ 1.295866] [ T1] virtme_rw_overlay5=/usr # 163.07 [+0.00] [ 1.295968] [ T1] virtme_rw_overlay6=/var # 163.07 [+0.00] [ 1.296069] [ T1] virtme_rw_overlay7=/tmp # 163.08 [+0.00] [ 1.296170] [ T1] virtme_console=ttyS0 # 163.08 [+0.00] [ 1.296331] [ T1] virtme_chdir=srv/vmksft/testing/wt-4 # 163.09 [+0.00] [ 1.315838] [ T1] virtme-ng-init: mount devtmpfs -> /dev: EBUSY: Device or resource busy # 163.09 [+0.01] [ 1.328438] [ T1] overlayfs: failed to set xattr on upper # 163.10 [+0.00] [ 1.328624] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.10 [+0.01] [ 1.328785] [ T1] overlayfs: ...falling back to uuid=null. # 163.11 [+0.00] [ 1.331103] [ T1] overlayfs: failed to set xattr on upper # 163.11 [+0.00] [ 1.331235] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.12 [+0.01] [ 1.331397] [ T1] overlayfs: ...falling back to uuid=null. # 163.12 [+0.00] [ 1.333239] [ T1] overlayfs: failed to set xattr on upper # 163.13 [+0.00] [ 1.333394] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.13 [+0.01] [ 1.333557] [ T1] overlayfs: ...falling back to uuid=null. # 163.14 [+0.00] [ 1.335548] [ T1] overlayfs: failed to set xattr on upper # 163.14 [+0.00] [ 1.335677] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.15 [+0.01] [ 1.335827] [ T1] overlayfs: ...falling back to uuid=null. # 163.15 [+0.00] [ 1.337710] [ T1] overlayfs: failed to set xattr on upper # 163.16 [+0.00] [ 1.337845] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.16 [+0.01] [ 1.337994] [ T1] overlayfs: ...falling back to uuid=null. # 163.17 [+0.00] [ 1.340224] [ T1] overlayfs: failed to set xattr on upper # 163.17 [+0.00] [ 1.340371] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.18 [+0.01] [ 1.340527] [ T1] overlayfs: ...falling back to uuid=null. # 163.18 [+0.00] [ 1.342394] [ T1] overlayfs: failed to set xattr on upper # 163.19 [+0.00] [ 1.342529] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.19 [+0.01] [ 1.342679] [ T1] overlayfs: ...falling back to uuid=null. # 163.20 [+0.00] [ 1.344510] [ T1] overlayfs: failed to set xattr on upper # 163.20 [+0.00] [ 1.344644] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 163.21 [+0.01] [ 1.344796] [ T1] overlayfs: ...falling back to uuid=null. # 163.21 [+0.00] [ 3.505708] [ T73] systemd-tmpfile (73) used greatest stack depth: 23856 bytes left # 163.22 [+0.01] [ 3.505985] [ T1] virtme-ng-init: Failed to read '/usr/lib/tmpfiles.d/audit.conf': Permission denied # 163.22 [+0.01] Failed to opendir() '/proc/self/fd/3': Permission denied # 163.23 [+0.01] [ 3.567361] [ T74] virtme-ng-init: Starting systemd-udevd version 258.3-2.fc43 # 163.24 [+0.01] [ 3.567735] [ T74] virtme-ng-init: triggering udev coldplug # 163.24 [+0.00] [ 6.036758] [ T74] virtme-ng-init: waiting for udev to settle # 163.24 [+0.00] [ 7.069031] [ T74] virtme-ng-init: udev is done # 163.25 [+0.00] [ 7.071739] [ T1] virtme-ng-init: initialization done # 163.25 [+0.00] [ 10.971278] [ T308] gre: GRE over IPv4 demultiplexer driver # 163.26 [+0.00] [ 11.011694] [ T308] ip6_gre: GRE over IPv6 tunneling driver # 163.26 [+0.00] [ 11.053683] [ T12] ip6_tunnel: g1 xmit: Local address not yet configured! # 163.27 [+0.01] [ 11.095975] [ T12] ip6_tunnel: g1 xmit: Local address not yet configured! # 163.27 [+0.01] [ 11.493616] [ T330] 8021q: 802.1Q VLAN Support v1.8 # 163.28 [+0.00] [ 12.367560] [ T369] GACT probability NOT on # 163.28 [+0.00] [ 12.676265] [ T12] ip6_tunnel: g2 xmit: Local address not yet configured! # 163.29 [+0.01] [ 12.708385] [ T12] ip6_tunnel: g2 xmit: Local address not yet configured! # 163.29 [+0.01] [ 595.383040] [T17500] br1: port 1(veth1) entered blocking state # 163.30 [+0.00] [ 595.383375] [T17500] br1: port 1(veth1) entered disabled state # 163.30 [+0.00] [ 595.383684] [T17500] veth1: entered allmulticast mode # 163.31 [+0.00] [ 595.385196] [T17500] veth1: entered promiscuous mode # 163.31 [+0.00] [ 595.461393] [ T37] br1: port 1(veth1) entered blocking state # 163.31 [+0.00] [ 595.461684] [ T37] br1: port 1(veth1) entered forwarding state # 163.32 [+0.00] [ 601.100075] [T17549] br1: port 2(vx1) entered blocking state # 163.32 [+0.00] [ 601.101661] [T17549] br1: port 2(vx1) entered disabled state # 163.33 [+0.00] [ 601.107218] [T17549] vx1: entered allmulticast mode # 163.33 [+0.00] [ 601.108802] [T17549] vx1: entered promiscuous mode # 163.34 [+0.00] [ 601.109656] [T17549] br1: port 2(vx1) entered blocking state # 163.34 [+0.00] [ 601.109911] [T17549] br1: port 2(vx1) entered forwarding state # 163.35 [+0.00] [ 621.031015] [T19505] vx1: left allmulticast mode # 163.35 [+0.00] [ 621.031265] [T19505] vx1: left promiscuous mode # 163.35 [+0.00] [ 621.031657] [T19505] br1: port 2(vx1) entered disabled state # 163.36 [+0.00] [ 621.236014] [T19525] br1: port 2(vx1) entered blocking state # 163.36 [+0.00] [ 621.236216] [T19525] br1: port 2(vx1) entered disabled state # 163.37 [+0.00] [ 621.236404] [T19525] vx1: entered allmulticast mode # 163.37 [+0.00] [ 621.237907] [T19525] vx1: entered promiscuous mode # 163.37 [+0.00] [ 621.238863] [T19525] br1: port 2(vx1) entered blocking state # 163.38 [+0.00] [ 621.239028] [T19525] br1: port 2(vx1) entered forwarding state # 163.38 [+0.00] [ 641.101449] [T21480] vx1: left allmulticast mode # 163.39 [+0.00] [ 641.101659] [T21480] vx1: left promiscuous mode # 163.39 [+0.00] [ 641.101894] [T21480] br1: port 2(vx1) entered disabled state # 163.40 [+0.00] [ 641.369588] [T21510] br1: port 2(vx1) entered blocking state # 163.40 [+0.00] [ 641.369826] [T21510] br1: port 2(vx1) entered disabled state # 163.41 [+0.00] [ 641.370062] [T21510] vx1: entered allmulticast mode # 163.41 [+0.00] [ 641.372089] [T21510] vx1: entered promiscuous mode # 163.41 [+0.00] [ 641.372743] [T21510] br1: port 2(vx1) entered blocking state # 163.42 [+0.00] [ 641.372951] [T21510] br1: port 2(vx1) entered forwarding state # 163.42 [+0.00] [ 661.053872] [T23465] vx1: left allmulticast mode # 163.43 [+0.00] [ 661.054082] [T23465] vx1: left promiscuous mode # 163.43 [+0.00] [ 661.054338] [T23465] br1: port 2(vx1) entered disabled state # 163.43 [+0.00] [ 661.349697] [T23495] br1: port 2(vx1) entered blocking state # 163.44 [+0.00] [ 661.349889] [T23495] br1: port 2(vx1) entered disabled state # 163.44 [+0.00] [ 661.350062] [T23495] vx1: entered allmulticast mode # 163.45 [+0.00] [ 661.351592] [T23495] vx1: entered promiscuous mode # 163.45 [+0.00] [ 661.352147] [T23495] br1: port 2(vx1) entered blocking state # 163.46 [+0.00] [ 661.352316] [T23495] br1: port 2(vx1) entered forwarding state # 163.46 [+0.00] [ 681.125141] [T25450] vx1: left allmulticast mode # 163.47 [+0.00] [ 681.125347] [T25450] vx1: left promiscuous mode # 163.47 [+0.00] [ 681.125592] [T25450] br1: port 2(vx1) entered disabled state # 163.47 [+0.00] [ 681.399797] [T25480] br1: port 2(vx1) entered blocking state # 163.48 [+0.00] [ 681.399982] [T25480] br1: port 2(vx1) entered disabled state # 163.48 [+0.00] [ 681.400152] [T25480] vx1: entered allmulticast mode # 163.49 [+0.00] [ 681.401661] [T25480] vx1: entered promiscuous mode # 163.49 [+0.00] [ 681.402164] [T25480] br1: port 2(vx1) entered blocking state # 163.50 [+0.00] [ 681.402326] [T25480] br1: port 2(vx1) entered forwarding state # 163.50 [+0.00] [ 701.133823] [T27435] vx1: left allmulticast mode # 163.50 [+0.00] [ 701.134014] [T27435] vx1: left promiscuous mode # 163.51 [+0.00] [ 701.134249] [T27435] br1: port 2(vx1) entered disabled state # 163.51 [+0.00] [ 701.402748] [T27465] br1: port 2(vx1) entered blocking state # 163.52 [+0.00] [ 701.403013] [T27465] br1: port 2(vx1) entered disabled state # 163.52 [+0.00] [ 701.403323] [T27465] vx1: entered allmulticast mode # 163.53 [+0.00] [ 701.407054] [T27465] vx1: entered promiscuous mode # 163.53 [+0.00] [ 701.407975] [T27465] br1: port 2(vx1) entered blocking state # 163.53 [+0.00] [ 701.408191] [T27465] br1: port 2(vx1) entered forwarding state # 163.54 [+0.00] [ 721.201478] [T29420] vx1: left allmulticast mode # 163.54 [+0.00] [ 721.201676] [T29420] vx1: left promiscuous mode # 163.55 [+0.00] [ 721.201904] [T29420] br1: port 2(vx1) entered disabled state # 163.55 [+0.00] [ 721.470272] [T29450] br1: port 2(vx1) entered blocking state # 163.55 [+0.00] [ 721.470466] [T29450] br1: port 2(vx1) entered disabled state # 163.56 [+0.00] [ 721.470631] [T29450] vx1: entered allmulticast mode # 163.56 [+0.00] [ 721.472091] [T29450] vx1: entered promiscuous mode # 163.57 [+0.00] [ 721.472634] [T29450] br1: port 2(vx1) entered blocking state # 163.57 [+0.00] [ 721.472782] [T29450] br1: port 2(vx1) entered forwarding state # 163.58 [+0.00] [ 740.810326] [T31405] vx1: left allmulticast mode # 163.58 [+0.00] [ 740.810567] [T31405] vx1: left promiscuous mode # 163.58 [+0.00] [ 740.810858] [T31405] br1: port 2(vx1) entered disabled state # 163.59 [+0.00] [ 741.139687] [T31428] br1: port 1(veth1) entered disabled state # 163.59 [+0.00] [ 741.165769] [T31430] veth1: left allmulticast mode # 163.60 [+0.00] [ 741.165945] [T31430] veth1: left promiscuous mode # 163.60 [+0.00] [ 741.166172] [T31430] br1: port 1(veth1) entered disabled state # 163.61 [+0.00] [ 749.577645] [T31576] ip_gre: GRE over IPv4 tunneling driver # 163.61 [+0.00] [ 840.311846] [T32106] br10: port 1(veth1.10) entered blocking state # 163.62 [+0.00] [ 840.312074] [T32106] br10: port 1(veth1.10) entered disabled state # 163.62 [+0.00] [ 840.312272] [T32106] veth1.10: entered allmulticast mode # 163.62 [+0.00] [ 840.312426] [T32106] veth1: entered allmulticast mode # 163.63 [+0.00] [ 840.313921] [T32106] veth1.10: entered promiscuous mode # 163.63 [+0.00] [ 840.314067] [T32106] veth1: entered promiscuous mode # 163.64 [+0.00] [ 840.482100] [T32124] br11: port 1(veth1.11) entered blocking state # 163.64 [+0.00] [ 840.482348] [T32124] br11: port 1(veth1.11) entered disabled state # 163.65 [+0.01] [ 840.482547] [T32124] veth1.11: entered allmulticast mode # 163.65 [+0.00] [ 840.484024] [T32124] veth1.11: entered promiscuous mode # 163.66 [+0.00] [ 840.750489] [T32154] br10: port 2(veth2.10) entered blocking state # 163.66 [+0.01] [ 840.750709] [T32154] br10: port 2(veth2.10) entered disabled state # 163.67 [+0.00] [ 840.750905] [T32154] veth2.10: entered allmulticast mode # 163.67 [+0.00] [ 840.751046] [T32154] veth2: entered allmulticast mode # 163.67 [+0.00] [ 840.752559] [T32154] veth2.10: entered promiscuous mode # 163.68 [+0.00] [ 840.752705] [T32154] veth2: entered promiscuous mode # 163.68 [+0.00] [ 840.904993] [T32171] br11: port 2(veth2.11) entered blocking state # 163.69 [+0.00] [ 840.905200] [T32171] br11: port 2(veth2.11) entered disabled state # 163.69 [+0.00] [ 840.905397] [T32171] veth2.11: entered allmulticast mode # 163.70 [+0.00] [ 840.906877] [T32171] veth2.11: entered promiscuous mode # 163.70 [+0.00] [ 841.047795] [T32183] br10: port 2(veth2.10) entered blocking state # 163.71 [+0.00] [ 841.048021] [T32183] br10: port 2(veth2.10) entered forwarding state # 163.71 [+0.01] [ 841.048525] [T32183] br10: port 1(veth1.10) entered blocking state # 163.72 [+0.00] [ 841.048715] [T32183] br10: port 1(veth1.10) entered forwarding state # 163.72 [+0.01] [ 841.085784] [T32188] br11: port 2(veth2.11) entered blocking state # 163.73 [+0.00] [ 841.085999] [T32188] br11: port 2(veth2.11) entered forwarding state # 163.73 [+0.01] [ 841.086334] [T32188] br11: port 1(veth1.11) entered blocking state # 163.74 [+0.01] [ 841.086530] [T32188] br11: port 1(veth1.11) entered forwarding state # 163.74 [+0.01] [ 915.327226] [T32531] br11: port 2(veth2.11) entered disabled state # 163.75 [+0.00] [ 915.327861] [T32531] br11: port 1(veth1.11) entered disabled state # 163.75 [+0.00] [ 915.353497] [T32533] br10: port 2(veth2.10) entered disabled state # 163.76 [+0.00] [ 915.353909] [T32533] br10: port 1(veth1.10) entered disabled state # 163.76 [+0.00] [ 915.413187] [T32537] veth2.11: left allmulticast mode # 163.77 [+0.00] [ 915.413917] [T32537] veth2.11: left promiscuous mode # 163.77 [+0.00] [ 915.414361] [T32537] br11: port 2(veth2.11) entered disabled state # 163.77 [+0.00] [ 915.527251] [T32543] veth2.10: left allmulticast mode # 163.78 [+0.00] [ 915.527431] [T32543] veth2: left allmulticast mode # 163.78 [+0.00] [ 915.527586] [T32543] veth2.10: left promiscuous mode # 163.79 [+0.00] [ 915.527733] [T32543] veth2: left promiscuous mode # 163.79 [+0.00] [ 915.528094] [T32543] br10: port 2(veth2.10) entered disabled state # 163.80 [+0.00] [ 915.695229] [T32553] veth1.11: left allmulticast mode # 163.80 [+0.00] [ 915.695461] [T32553] veth1.11: left promiscuous mode # 163.80 [+0.00] [ 915.695899] [T32553] br11: port 1(veth1.11) entered disabled state # 163.81 [+0.00] [ 915.802844] [T32559] veth1.10: left allmulticast mode # 163.81 [+0.00] [ 915.803019] [T32559] veth1: left allmulticast mode # 163.82 [+0.00] [ 915.803171] [T32559] veth1.10: left promiscuous mode # 163.82 [+0.00] [ 915.803323] [T32559] veth1: left promiscuous mode # 163.82 [+0.00] [ 915.803680] [T32559] br10: port 1(veth1.10) entered disabled state # 163.83 [+0.00] [ 925.338443] [ T347] br10: port 1(veth1.10) entered blocking state # 163.83 [+0.00] [ 925.338718] [ T347] br10: port 1(veth1.10) entered disabled state # 163.84 [+0.00] [ 925.338973] [ T347] veth1.10: entered allmulticast mode # 163.84 [+0.00] [ 925.339163] [ T347] veth1: entered allmulticast mode # 163.85 [+0.00] [ 925.341198] [ T347] veth1.10: entered promiscuous mode # 163.85 [+0.00] [ 925.341401] [ T347] veth1: entered promiscuous mode # 163.86 [+0.00] [ 925.504662] [ T364] br11: port 1(veth1.11) entered blocking state # 163.86 [+0.00] [ 925.504913] [ T364] br11: port 1(veth1.11) entered disabled state # 163.87 [+0.01] [ 925.505170] [ T364] veth1.11: entered allmulticast mode # 163.87 [+0.00] [ 925.506949] [ T364] veth1.11: entered promiscuous mode # 163.87 [+0.00] [ 925.794803] [ T394] br10: port 2(veth2.10) entered blocking state # 163.88 [+0.00] [ 925.795063] [ T394] br10: port 2(veth2.10) entered disabled state # 163.88 [+0.00] [ 925.795335] [ T394] veth2.10: entered allmulticast mode # 163.89 [+0.00] [ 925.795519] [ T394] veth2: entered allmulticast mode # 163.89 [+0.00] [ 925.797259] [ T394] veth2.10: entered promiscuous mode # 163.90 [+0.00] [ 925.797465] [ T394] veth2: entered promiscuous mode # 163.90 [+0.00] [ 925.963670] [ T412] br11: port 2(veth2.11) entered blocking state # 163.91 [+0.00] [ 925.963920] [ T412] br11: port 2(veth2.11) entered disabled state # 163.91 [+0.00] [ 925.964180] [ T412] veth2.11: entered allmulticast mode # 163.92 [+0.00] [ 925.965720] [ T412] veth2.11: entered promiscuous mode # 163.92 [+0.00] [ 926.100885] [ T425] br10: port 2(veth2.10) entered blocking state # 163.92 [+0.00] [ 926.101104] [ T425] br10: port 2(veth2.10) entered forwarding state # 163.93 [+0.01] [ 926.101444] [ T425] br10: port 1(veth1.10) entered blocking state # 163.93 [+0.00] [ 926.101631] [ T425] br10: port 1(veth1.10) entered forwarding state # 163.94 [+0.01] [ 926.138693] [ T430] br11: port 2(veth2.11) entered blocking state # 163.94 [+0.00] [ 926.138917] [ T430] br11: port 2(veth2.11) entered forwarding state # 163.95 [+0.01] [ 926.139248] [ T430] br11: port 1(veth1.11) entered blocking state # 163.95 [+0.00] [ 926.139448] [ T430] br11: port 1(veth1.11) entered forwarding state # 163.96 [+0.01] [ 950.273938] [ T553] br11: port 2(veth2.11) entered disabled state # 163.96 [+0.00] [ 950.274464] [ T553] br11: port 1(veth1.11) entered disabled state # 163.97 [+0.00] [ 950.299169] [ T555] br10: port 2(veth2.10) entered disabled state # 163.97 [+0.00] [ 950.299640] [ T555] br10: port 1(veth1.10) entered disabled state # 163.98 [+0.00] [ 950.356338] [ T559] veth2.11: left allmulticast mode # 163.98 [+0.00] [ 950.356543] [ T559] veth2.11: left promiscuous mode # 163.99 [+0.00] [ 950.356961] [ T559] br11: port 2(veth2.11) entered disabled state # 163.99 [+0.00] [ 950.481356] [ T565] veth2.10: left allmulticast mode # 164.00 [+0.00] [ 950.481572] [ T565] veth2: left allmulticast mode # 164.00 [+0.00] [ 950.481783] [ T565] veth2.10: left promiscuous mode # 164.01 [+0.00] [ 950.481976] [ T565] veth2: left promiscuous mode # 164.01 [+0.00] [ 950.482417] [ T565] br10: port 2(veth2.10) entered disabled state # 164.01 [+0.00] [ 950.658855] [ T575] veth1.11: left allmulticast mode # 164.02 [+0.00] [ 950.659076] [ T575] veth1.11: left promiscuous mode # 164.02 [+0.00] [ 950.659527] [ T575] br11: port 1(veth1.11) entered disabled state # 164.03 [+0.00] [ 950.772375] [ T584] veth1.10: left allmulticast mode # 164.03 [+0.00] [ 950.772549] [ T584] veth1: left allmulticast mode # 164.04 [+0.00] [ 950.772699] [ T584] veth1.10: left promiscuous mode # 164.04 [+0.00] [ 950.772837] [ T584] veth1: left promiscuous mode # 164.04 [+0.00] [ 950.773193] [ T584] br10: port 1(veth1.10) entered disabled state # 164.05 [+0.00] [ 959.162819] [ T726] br1: port 1(veth1) entered blocking state # 164.05 [+0.00] [ 959.163068] [ T726] br1: port 1(veth1) entered disabled state # 164.06 [+0.00] [ 959.163269] [ T726] veth1: entered allmulticast mode # 164.06 [+0.00] [ 959.164836] [ T726] veth1: entered promiscuous mode # 164.07 [+0.00] [ 959.196679] [ T48] br1: port 1(veth1) entered blocking state # 164.07 [+0.00] [ 959.196884] [ T48] br1: port 1(veth1) entered forwarding state # 164.07 [+0.00] [ 959.218954] [ T729] br1: port 2(veth2) entered blocking state # 164.08 [+0.00] [ 959.219202] [ T729] br1: port 2(veth2) entered disabled state # 164.08 [+0.00] [ 959.221465] [ T729] veth2: entered allmulticast mode # 164.09 [+0.00] [ 959.223011] [ T729] veth2: entered promiscuous mode # 164.09 [+0.00] [ 959.248667] [ T226] br1: port 2(veth2) entered blocking state # 164.10 [+0.00] [ 959.248905] [ T226] br1: port 2(veth2) entered forwarding state # 164.10 [+0.00] [ 977.616658] [ T941] br1: port 2(veth2) entered disabled state # 164.11 [+0.00] [ 977.640466] [ T942] veth2: left allmulticast mode # 164.11 [+0.00] [ 977.640652] [ T942] veth2: left promiscuous mode # 164.11 [+0.00] [ 977.640886] [ T942] br1: port 2(veth2) entered disabled state # 164.12 [+0.00] [ 977.668881] [ T943] br1: port 1(veth1) entered disabled state # 164.12 [+0.00] [ 977.692906] [ T944] veth1: left allmulticast mode # 164.13 [+0.00] [ 977.693115] [ T944] veth1: left promiscuous mode # 164.13 [+0.00] [ 977.693444] [ T944] br1: port 1(veth1) entered disabled state # 164.14 [+0.00] [ 1031.416039] [ T1825] br1: port 1(veth1) entered blocking state # 164.14 [+0.00] [ 1031.416269] [ T1825] br1: port 1(veth1) entered disabled state # 164.14 [+0.00] [ 1031.416516] [ T1825] veth1: entered allmulticast mode # 164.15 [+0.00] [ 1031.418536] [ T1825] veth1: entered promiscuous mode # 164.15 [+0.00] [ 1031.469870] [ T1828] br1: port 2(veth2) entered blocking state # 164.16 [+0.00] [ 1031.470114] [ T1828] br1: port 2(veth2) entered disabled state # 164.16 [+0.00] [ 1031.470386] [ T1828] veth2: entered allmulticast mode # 164.17 [+0.00] [ 1031.471948] [ T1828] veth2: entered promiscuous mode # 164.17 [+0.00] [ 1031.525085] [ T1830] br1: port 2(veth2) entered blocking state # 164.17 [+0.00] [ 1031.525343] [ T1830] br1: port 2(veth2) entered forwarding state # 164.18 [+0.00] [ 1031.525741] [ T1830] br1: port 1(veth1) entered blocking state # 164.18 [+0.00] [ 1031.525970] [ T1830] br1: port 1(veth1) entered forwarding state # 164.19 [+0.00] [ 1036.933649] [ T1854] tc (1854) used greatest stack depth: 23656 bytes left # 164.19 [+0.01] [ 1041.771933] [ T2143] br1: port 2(veth2) entered disabled state # 164.20 [+0.00] [ 1041.772439] [ T2143] br1: port 1(veth1) entered disabled state # 164.20 [+0.00] [ 1041.817361] [ T2145] veth2: left allmulticast mode # 164.21 [+0.00] [ 1041.817543] [ T2145] veth2: left promiscuous mode # 164.21 [+0.00] [ 1041.817777] [ T2145] br1: port 2(veth2) entered disabled state # 164.22 [+0.00] [ 1041.869392] [ T2147] veth1: left allmulticast mode # 164.22 [+0.00] [ 1041.869613] [ T2147] veth1: left promiscuous mode # 164.22 [+0.00] [ 1041.869917] [ T2147] br1: port 1(veth1) entered disabled state # 164.23 [+0.00] [ 1058.286166] [ T2494] Mirror/redirect action on # 164.23 [+0.00] [ 1070.942144] [ C0] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 4550841748 wd_nsec: 4550842029 ok 1 selftests: net/forwarding: tc_actions.sh make: Leaving directory '/srv/vmksft/testing/wt-4/tools/testing/selftests' xx__-> echo $? 0 xx__-> echo scan > /sys/kernel/debug/kmemleak xx__->