make -C tools/testing/selftests TARGETS="net/forwarding" TEST_PROGS=tc_acttions.sh TEST_GEN_PROGS="" run_tests make: Entering directory '/home/virtme/testing/wt-4/tools/testing/selftests' make[1]: Entering directory '/home/virtme/testing/wt-4/tools/testing/selftests/net/forwarding' make[1]: Nothing to be done for 'all'. make[1]: Leaving directory '/home/virtme/testing/wt-4/tools/testing/selftests/net/forwarding' make[1]: Entering directory '/home/virtme/testing/wt-4/tools/testing/selftests/net/forwarding' TAP version 13 1..1 # overriding timeout to 21600 # selftests: net/forwarding: tc_actions.sh # 15.01 [+15.01] TEST: gact drop and ok (skip_hw) [ OK ] # 17.59 [+2.58] TEST: mirred egress flower redirect (skip_hw) [ OK ] # 20.03 [+2.43] TEST: mirred egress flower mirror (skip_hw) [ OK ] # 22.78 [+2.76] TEST: mirred egress matchall mirror (skip_hw) [ OK ] # 28.78 [+6.00] TEST: mirred_egress_to_ingress (skip_hw) [ OK ] # 29.78 [+1.00] P2 # 29.97 [+0.19] P2.1 # 30.23 [+0.26] P2.2 # 30.53 [+0.30] P2.3 # 30.53 [+0.00] P1 # 30.81 [+0.28] P1.1 # 31.13 [+0.32] P1.2 # 84.09 [+52.96] P3 # 91.86 [+7.77] TEST: mirred_egress_to_ingress_tcp (skip_hw) [ OK ] # 92.79 [+0.93] TEST: ingress_2nd_vlan_push (skip_hw) [ OK ] # 93.97 [+1.18] TEST: egress_2nd_vlan_push (skip_hw) [ OK ] # 94.13 [+0.16] INFO: Could not test offloaded functionality # 94.20 [+0.07] [ 0.000000] Linux version 6.17.0-rc2-virtme (virtme@netdev-3.bots.linux.dev) (gcc (GCC) 11.5.0 20240719 (Red Hat 11.5.0-5), GNU ld version 2.41-50.amzn2023.0.3) #1 SMP PREEMPT_DYNAMIC Tue Aug 26 05:05:01 PDT 2025 # 94.21 [+0.01] [ 0.000000] Command line: virtme_hostname=virtme-ng nr_open=1073741816 virtme_link_mods=/home/virtme/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 virtme_chdir=home/virtme/testing/wt-4 rootfstype=virtiofs root=ROOTFS raid=noautodetect ro init=/home/virtme/virtme-ng/virtme/guest/virtme-init # 94.23 [+0.02] [ 0.000000] BIOS-provided physical RAM map: # 94.23 [+0.00] [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable # 94.23 [+0.00] [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved # 94.23 [+0.00] [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved # 94.23 [+0.00] [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003fffefff] usable # 94.24 [+0.00] [ 0.000000] BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] reserved # 94.24 [+0.00] [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved # 94.24 [+0.00] [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved # 94.24 [+0.00] [ 0.000000] printk: legacy bootconsole [earlyser0] enabled # 94.25 [+0.00] [ 0.000000] NX (Execute Disable) protection: active # 94.25 [+0.00] [ 0.000000] APIC: Static calls initialized # 94.25 [+0.00] [ 0.000000] SMBIOS 2.4 present. # 94.25 [+0.00] [ 0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011 # 94.25 [+0.00] [ 0.000000] DMI: Memory slots populated: 1/1 # 94.25 [+0.00] [ 0.000000] Hypervisor detected: KVM # 94.25 [+0.00] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 # 94.26 [+0.00] [ 0.000003] kvm-clock: using sched offset of 603707980 cycles # 94.26 [+0.00] [ 0.000403] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns # 94.26 [+0.00] [ 0.001598] tsc: Detected 3000.000 MHz processor # 94.26 [+0.00] [ 0.002049] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved # 94.27 [+0.00] [ 0.002059] e820: remove [mem 0x000a0000-0x000fffff] usable # 94.27 [+0.00] [ 0.002068] last_pfn = 0x3ffff max_arch_pfn = 0x400000000 # 94.27 [+0.00] [ 0.002514] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs # 94.27 [+0.00] [ 0.003114] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT # 94.27 [+0.00] [ 0.010686] found SMP MP-table at [mem 0x000f4470-0x000f447f] # 94.28 [+0.00] [ 0.011153] Using GB pages for direct mapping # 94.28 [+0.00] [ 0.011853] ACPI: Early table checksum verification disabled # 94.28 [+0.00] [ 0.012281] ACPI: RSDP 0x00000000000F4290 000024 (v02 BOCHS ) # 94.28 [+0.00] [ 0.012731] ACPI: XSDT 0x000000003FFFFFB0 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) # 94.28 [+0.00] [ 0.013369] ACPI: FACP 0x000000003FFFFE3A 00010C (v05 BOCHS BXPC 00000001 BXPC 00000001) # 94.29 [+0.00] [ 0.013998] ACPI: DSDT 0x000000003FFFF200 000C3A (v02 BOCHS BXPC 00000001 BXPC 00000001) # 94.29 [+0.00] [ 0.014631] ACPI: APIC 0x000000003FFFFF46 00006A (v03 BOCHS BXPC 00000001 BXPC 00000001) # 94.29 [+0.00] [ 0.015244] ACPI: Reserving FACP table memory at [mem 0x3ffffe3a-0x3fffff45] # 94.30 [+0.00] [ 0.015771] ACPI: Reserving DSDT table memory at [mem 0x3ffff200-0x3ffffe39] # 94.30 [+0.00] [ 0.016279] ACPI: Reserving APIC table memory at [mem 0x3fffff46-0x3fffffaf] # 94.30 [+0.00] [ 0.017354] No NUMA configuration found # 94.30 [+0.00] [ 0.017669] Faking a node at [mem 0x0000000000000000-0x000000003fffefff] # 94.30 [+0.00] [ 0.018161] NODE_DATA(0) allocated [mem 0x3fffa100-0x3fffefff] # 94.31 [+0.00] [ 0.033105] Zone ranges: # 94.31 [+0.00] [ 0.033443] DMA [mem 0x0000000000001000-0x0000000000ffffff] # 94.31 [+0.00] [ 0.034125] DMA32 [mem 0x0000000001000000-0x000000003fffefff] # 94.31 [+0.00] [ 0.034803] Normal empty # 94.31 [+0.00] [ 0.035160] Device empty # 94.31 [+0.00] [ 0.035516] Movable zone start for each node # 94.32 [+0.00] [ 0.036005] Early memory node ranges # 94.32 [+0.00] [ 0.036417] node 0: [mem 0x0000000000001000-0x000000000009efff] # 94.32 [+0.00] [ 0.037034] node 0: [mem 0x0000000000100000-0x000000003fffefff] # 94.32 [+0.00] [ 0.037570] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffefff] # 94.32 [+0.00] [ 0.038099] On node 0, zone DMA: 1 pages in unavailable ranges # 94.33 [+0.00] [ 0.038710] On node 0, zone DMA: 97 pages in unavailable ranges # 94.33 [+0.00] [ 0.048162] On node 0, zone DMA32: 1 pages in unavailable ranges # 94.33 [+0.00] [ 0.163212] kasan: KernelAddressSanitizer initialized # 94.33 [+0.00] [ 0.163814] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) # 94.33 [+0.00] [ 0.164297] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 # 94.34 [+0.00] [ 0.164838] IOAPIC[1]: apic_id 1, version 32, address 0xfec10000, GSI 24-47 # 94.34 [+0.00] [ 0.165352] ACPI: Using ACPI (MADT) for SMP configuration information # 94.34 [+0.00] [ 0.165824] TSC deadline timer available # 94.34 [+0.00] [ 0.166138] CPU topo: Max. logical packages: 1 # 94.34 [+0.00] [ 0.166491] CPU topo: Max. logical dies: 1 # 94.34 [+0.00] [ 0.166845] CPU topo: Max. dies per package: 1 # 94.35 [+0.00] [ 0.167203] CPU topo: Max. threads per core: 1 # 94.36 [+0.01] [ 0.167555] CPU topo: Num. cores per package: 4 # 94.36 [+0.00] [ 0.167925] CPU topo: Num. threads per package: 4 # 94.36 [+0.00] [ 0.168300] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs # 94.37 [+0.00] [ 0.168795] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() # 94.37 [+0.00] [ 0.169322] kvm-guest: KVM setup pv remote TLB flush # 94.37 [+0.00] [ 0.169712] kvm-guest: setup PV sched yield # 94.37 [+0.00] [ 0.170059] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] # 94.38 [+0.00] [ 0.170606] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] # 94.38 [+0.00] [ 0.171154] [mem 0x40000000-0xfeffbfff] available for PCI devices # 94.38 [+0.00] [ 0.171602] Booting paravirtualized kernel on KVM # 94.38 [+0.00] [ 0.171960] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns # 94.39 [+0.00] [ 0.187027] setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 # 94.39 [+0.00] [ 0.189307] percpu: Embedded 66 pages/cpu s229712 r8192 d32432 u524288 # 94.39 [+0.00] [ 0.189832] pcpu-alloc: s229712 r8192 d32432 u524288 alloc=1*2097152 # 94.39 [+0.00] [ 0.189839] pcpu-alloc: [0] 0 1 2 3 # 94.39 [+0.00] [ 0.189913] Kernel command line: virtme_hostname=virtme-ng nr_open=1073741816 virtme_link_mods=/home/virtme/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 virtme_chdir=home/virtme/testing/wt-4 rootfstype=virtiofs root=ROOTFS raid=noautodetect ro init=/home/virtme/virtme-ng/virtme/guest/virtme-init # 94.41 [+0.02] [ 0.193550] Unknown kernel command line parameters "virtme_hostname=virtme-ng nr_open=1073741816 virtme_link_mods=/home/virtme/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=home/virtme/testing/wt-4", will be passed to user space. # 94.42 [+0.01] [ 0.196284] random: crng init done # 94.42 [+0.00] [ 0.196558] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes # 94.43 [+0.00] [ 0.197901] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) # 94.43 [+0.00] [ 0.198870] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) # 94.43 [+0.00] [ 0.199808] Fallback order for Node 0: 0 # 94.43 [+0.00] [ 0.199815] Built 1 zonelists, mobility grouping on. Total pages: 262045 # 94.44 [+0.00] [ 0.200591] Policy zone: DMA32 # 94.44 [+0.00] [ 0.200832] mem auto-init: stack:off, heap alloc:off, heap free:off # 94.44 [+0.00] [ 0.201272] stackdepot: allocating hash table via alloc_large_system_hash # 94.44 [+0.00] [ 0.201745] stackdepot hash table entries: 1048576 (order: 12, 16777216 bytes, linear) # 94.44 [+0.00] [ 0.215091] stackdepot: allocating space for 8192 stack pools via memblock # 94.45 [+0.00] [ 0.274702] ********************************************************** # 94.45 [+0.00] [ 0.275196] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 94.45 [+0.00] [ 0.275652] ** ** # 94.45 [+0.00] [ 0.276105] ** This system shows unhashed kernel memory addresses ** # 94.46 [+0.00] [ 0.276563] ** via the console, logs, and other interfaces. This ** # 94.46 [+0.00] [ 0.277017] ** might reduce the security of your system. ** # 94.46 [+0.00] [ 0.277472] ** ** # 94.46 [+0.00] [ 0.277928] ** If you see this message and you are not debugging ** # 94.47 [+0.00] [ 0.278380] ** the kernel, report this immediately to your system ** # 94.47 [+0.00] [ 0.278836] ** administrator! ** # 94.48 [+0.01] [ 0.279292] ** ** # 94.48 [+0.00] [ 0.279762] ** Use hash_pointers=always to force this mode off ** # 94.48 [+0.00] [ 0.280215] ** ** # 94.49 [+0.00] [ 0.280672] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 94.49 [+0.00] [ 0.281125] ********************************************************** # 94.49 [+0.00] [ 0.282441] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 # 94.49 [+0.00] [ 0.302743] ftrace: allocating 45817 entries in 180 pages # 94.50 [+0.00] [ 0.303160] ftrace: allocated 180 pages with 4 groups # 94.50 [+0.00] [ 0.304106] Dynamic Preempt: full # 94.50 [+0.00] [ 0.306686] Running RCU self tests # 94.50 [+0.00] [ 0.306953] Running RCU synchronous self tests # 94.50 [+0.00] [ 0.307276] rcu: Preemptible hierarchical RCU implementation. # 94.50 [+0.00] [ 0.307686] rcu: RCU event tracing is enabled. # 94.50 [+0.00] [ 0.308016] rcu: RCU lockdep checking is enabled. # 94.51 [+0.00] [ 0.308361] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. # 94.51 [+0.00] [ 0.308822] rcu: RCU callback double-/use-after-free debug is enabled. # 94.51 [+0.00] [ 0.309284] Trampoline variant of Tasks RCU enabled. # 94.51 [+0.00] [ 0.309660] Rude variant of Tasks RCU enabled. # 94.51 [+0.00] [ 0.309986] Tracing variant of Tasks RCU enabled. # 94.52 [+0.00] [ 0.310332] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. # 94.52 [+0.00] [ 0.310856] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 # 94.52 [+0.00] [ 0.311615] Running RCU synchronous self tests # 94.52 [+0.00] [ 0.311962] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 94.53 [+0.00] [ 0.312571] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 94.53 [+0.00] [ 0.313212] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 94.53 [+0.00] [ 0.418904] NR_IRQS: 4352, nr_irqs: 848, preallocated irqs: 0 # 94.53 [+0.00] [ 0.419753] rcu: srcu_init: Setting srcu_struct sizes based on contention. # 94.54 [+0.00] [ 0.421558] Console: colour *CGA 80x25 # 94.54 [+0.00] [ 0.421936] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar # 94.54 [+0.00] [ 0.422471] ... MAX_LOCKDEP_SUBCLASSES: 8 # 94.54 [+0.00] [ 0.422773] ... MAX_LOCK_DEPTH: 48 # 94.54 [+0.00] [ 0.423080] ... MAX_LOCKDEP_KEYS: 8192 # 94.54 [+0.00] [ 0.423400] ... CLASSHASH_SIZE: 4096 # 94.55 [+0.00] [ 0.423720] ... MAX_LOCKDEP_ENTRIES: 32768 # 94.55 [+0.00] [ 0.424048] ... MAX_LOCKDEP_CHAINS: 65536 # 94.55 [+0.00] [ 0.424373] ... CHAINHASH_SIZE: 32768 # 94.55 [+0.00] [ 0.424698] memory used by lock dependency info: 6429 kB # 94.55 [+0.00] [ 0.425082] memory used for stack traces: 4224 kB # 94.55 [+0.00] [ 0.425426] per task-struct memory footprint: 1920 bytes # 94.56 [+0.00] [ 0.426041] ACPI: Core revision 20250404 # 94.56 [+0.00] [ 0.427592] APIC: Switch to symmetric I/O mode setup # 94.56 [+0.00] [ 0.428516] x2apic enabled # 94.56 [+0.00] [ 0.432231] APIC: Switched APIC routing to: physical x2apic # 94.56 [+0.00] [ 0.432684] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() # 94.56 [+0.00] [ 0.433203] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() # 94.57 [+0.00] [ 0.433913] kvm-guest: setup PV IPIs # 94.57 [+0.00] [ 0.434468] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2b3e459bf4c, max_idle_ns: 440795289890 ns # 94.57 [+0.00] [ 0.435261] Calibrating delay loop (skipped) preset value.. 6000.00 BogoMIPS (lpj=3000000) # 94.58 [+0.00] [ 0.436005] x86/cpu: User Mode Instruction Prevention (UMIP) activated # 94.58 [+0.00] [ 0.436245] numa_add_cpu cpu 0 node 0: mask now 0 # 94.58 [+0.00] [ 0.436245] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 # 94.58 [+0.00] [ 0.436245] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 # 94.58 [+0.00] [ 0.436245] mitigations: Enabled attack vectors: SMT mitigations: off # 94.59 [+0.00] [ 0.436245] Speculative Store Bypass: Vulnerable # 94.59 [+0.00] [ 0.436245] Spectre V2 : Vulnerable # 94.59 [+0.00] [ 0.436245] RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! # 94.59 [+0.00] [ 0.436245] RETBleed: Vulnerable # 94.59 [+0.00] [ 0.436245] ITS: Vulnerable # 94.59 [+0.00] [ 0.436245] MMIO Stale Data: Vulnerable # 94.60 [+0.00] [ 0.436245] Spectre V1 : Vulnerable: __user pointer sanitization and usercopy barriers only; no swapgs barriers # 94.60 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' # 94.60 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' # 94.60 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' # 94.61 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' # 94.61 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' # 94.61 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' # 94.61 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' # 94.61 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' # 94.62 [+0.00] [ 0.436245] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' # 94.62 [+0.00] [ 0.436245] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 # 94.62 [+0.00] [ 0.436245] x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 # 94.62 [+0.00] [ 0.436245] x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 # 94.63 [+0.00] [ 0.436245] x86/fpu: xstate_offset[5]: 960, xstate_sizes[5]: 64 # 94.63 [+0.00] [ 0.436245] x86/fpu: xstate_offset[6]: 1024, xstate_sizes[6]: 512 # 94.63 [+0.00] [ 0.436245] x86/fpu: xstate_offset[7]: 1536, xstate_sizes[7]: 1024 # 94.63 [+0.00] [ 0.436245] x86/fpu: xstate_offset[9]: 2560, xstate_sizes[9]: 8 # 94.63 [+0.00] [ 0.436245] x86/fpu: Enabled xstate features 0x2ff, context size is 2568 bytes, using 'compacted' format. # 94.64 [+0.00] [ 0.436245] Freeing SMP alternatives memory: 36K # 94.64 [+0.00] [ 0.436245] pid_max: default: 32768 minimum: 301 # 94.64 [+0.00] [ 0.436245] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 94.64 [+0.00] [ 0.436245] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 94.65 [+0.00] [ 0.436245] Running RCU synchronous self tests # 94.65 [+0.00] [ 0.436245] Running RCU synchronous self tests # 94.65 [+0.00] [ 0.436245] smpboot: CPU0: Intel(R) Xeon(R) Platinum 8275CL CPU @ 3.00GHz (family: 0x6, model: 0x55, stepping: 0x7) # 94.65 [+0.00] [ 0.443571] Performance Events: Skylake events, full-width counters, Intel PMU driver. # 94.66 [+0.00] [ 0.444277] ... version: 2 # 94.66 [+0.00] [ 0.444714] ... bit width: 48 # 94.66 [+0.00] [ 0.445142] ... generic registers: 4 # 94.66 [+0.00] [ 0.445254] ... value mask: 0000ffffffffffff # 94.66 [+0.00] [ 0.445794] ... max period: 00007fffffffffff # 94.66 [+0.00] [ 0.446255] ... fixed-purpose events: 3 # 94.67 [+0.00] [ 0.446681] ... event mask: 000000070000000f # 94.67 [+0.00] [ 0.448110] signal: max sigframe size: 3632 # 94.67 [+0.00] [ 0.449590] rcu: Hierarchical SRCU implementation. # 94.67 [+0.00] [ 0.450124] rcu: Max phase no-delay instances is 400. # 94.68 [+0.01] [ 0.471307] smp: Bringing up secondary CPUs ... # 94.68 [+0.00] [ 0.477824] smpboot: x86: Booting SMP configuration: # 94.69 [+0.00] [ 0.478284] .... node #0, CPUs: #1 #2 #3 # 94.69 [+0.00] [ 0.016001] numa_add_cpu cpu 1 node 0: mask now 0-1 # 94.69 [+0.00] [ 0.016001] numa_add_cpu cpu 2 node 0: mask now 0-2 # 94.69 [+0.00] [ 0.016001] numa_add_cpu cpu 3 node 0: mask now 0-3 # 94.70 [+0.00] [ 0.491301] smp: Brought up 1 node, 4 CPUs # 94.70 [+0.00] [ 0.492265] smpboot: Total of 4 processors activated (24000.00 BogoMIPS) # 94.70 [+0.00] [ 0.502161] Memory: 765848K/1048180K available (40290K kernel code, 12386K rwdata, 8844K rodata, 2688K init, 18256K bss, 271232K reserved, 0K cma-reserved) # 94.71 [+0.01] [ 0.506426] devtmpfs: initialized # 94.71 [+0.00] [ 0.511892] x86/mm: Memory block size: 128MB # 94.71 [+0.00] [ 0.538168] Running RCU synchronous self tests # 94.71 [+0.00] [ 0.538369] Running RCU synchronous self tests # 94.71 [+0.00] [ 0.541300] Running RCU Tasks wait API self tests # 94.72 [+0.00] [ 0.542245] Running RCU Tasks Rude wait API self tests # 94.72 [+0.00] [ 0.542245] Running RCU Tasks Trace wait API self tests # 94.72 [+0.00] [ 0.556299] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns # 94.72 [+0.00] [ 0.557508] posixtimers hash table entries: 2048 (order: 5, 147456 bytes, linear) # 94.73 [+0.00] [ 0.558688] futex hash table entries: 1024 (131072 bytes on 1 NUMA nodes, total 128 KiB, linear). # 94.73 [+0.00] [ 0.564198] PM: RTC time: 12:23:19, date: 2025-08-26 # 94.73 [+0.00] [ 0.574019] NET: Registered PF_NETLINK/PF_ROUTE protocol family # 94.73 [+0.00] [ 0.576279] Callback from call_rcu_tasks_trace() invoked. # 94.73 [+0.00] [ 0.581655] thermal_sys: Registered thermal governor 'step_wise' # 94.74 [+0.00] [ 0.582349] cpuidle: using governor ladder # 94.74 [+0.00] [ 0.587587] PCI: Fatal: No config space access function found # 94.74 [+0.00] [ 0.589452] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. # 94.74 [+0.00] [ 0.597610] HugeTLB: allocation took 0ms with hugepage_allocation_threads=1 # 94.74 [+0.00] [ 0.598278] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages # 94.75 [+0.00] [ 0.598969] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page # 94.75 [+0.00] [ 0.600257] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages # 94.75 [+0.00] [ 0.600966] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page # 94.75 [+0.00] [ 0.610630] ACPI: Added _OSI(Module Device) # 94.76 [+0.00] [ 0.610979] ACPI: Added _OSI(Processor Device) # 94.76 [+0.00] [ 0.611252] ACPI: Added _OSI(Processor Aggregator Device) # 94.76 [+0.00] [ 0.733018] ACPI: 1 ACPI AML tables successfully acquired and loaded # 94.76 [+0.00] [ 0.747604] Callback from call_rcu_tasks() invoked. # 94.76 [+0.00] [ 0.782274] ACPI: Interpreter enabled # 94.76 [+0.00] [ 0.783804] ACPI: PM: (supports S0 S5) # 94.77 [+0.00] [ 0.784257] ACPI: Using IOAPIC for interrupt routing # 94.77 [+0.00] [ 0.786417] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug # 94.77 [+0.00] [ 0.787255] PCI: Using E820 reservations for host bridge windows # 94.77 [+0.00] [ 0.912595] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) # 94.78 [+0.00] [ 0.914042] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] # 94.78 [+0.00] [ 0.915254] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] # 94.78 [+0.00] [ 0.943610] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource # 94.78 [+0.00] [ 0.980350] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) # 94.79 [+0.00] [ 0.987306] PCI host bridge to bus 0000:00 # 94.79 [+0.00] [ 0.991354] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xdfffffff window] # 94.79 [+0.00] [ 0.991923] pci_bus 0000:00: root bus resource [mem 0x300000000000-0x3fffffffffff window] # 94.79 [+0.00] [ 0.992293] pci_bus 0000:00: root bus resource [bus 00-ff] # 94.80 [+0.01] [ 0.992998] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint # 94.81 [+0.01] [ 1.002096] ACPI: PCI: Interrupt link GSI0 configured for IRQ 16 # 94.81 [+0.00] [ 1.004646] ACPI: PCI: Interrupt link GSI1 configured for IRQ 17 # 94.81 [+0.00] [ 1.006775] ACPI: PCI: Interrupt link GSI2 configured for IRQ 18 # 94.82 [+0.00] [ 1.008572] ACPI: PCI: Interrupt link GSI3 configured for IRQ 19 # 94.82 [+0.00] [ 1.013232] iommu: Default domain type: Translated # 94.82 [+0.00] [ 1.013255] iommu: DMA domain TLB invalidation policy: lazy mode # 94.82 [+0.00] [ 1.028587] SCSI subsystem initialized # 94.82 [+0.00] [ 1.031711] libata version 3.00 loaded. # 94.82 [+0.00] [ 1.036443] pps_core: LinuxPPS API ver. 1 registered # 94.83 [+0.00] [ 1.037006] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti # 94.83 [+0.00] [ 1.038930] PTP clock support registered # 94.83 [+0.00] [ 1.045676] Advanced Linux Sound Architecture Driver Initialized. # 94.83 [+0.00] [ 1.062660] PCI: Using ACPI for IRQ routing # 94.84 [+0.00] [ 1.063152] PCI: pci_cache_line_size set to 64 bytes # 94.84 [+0.00] [ 1.063188] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] # 94.84 [+0.00] [ 1.063345] e820: reserve RAM buffer [mem 0x3ffff000-0x3fffffff] # 94.84 [+0.00] [ 1.065735] vgaarb: loaded # 94.84 [+0.00] [ 1.069308] clocksource: Switched to clocksource kvm-clock # 94.84 [+0.00] [ 1.126966] VFS: Disk quotas dquot_6.6.0 # 94.85 [+0.00] [ 1.127576] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) # 94.85 [+0.00] [ 1.137048] pnp: PnP ACPI init # 94.85 [+0.00] [ 1.145575] system 00:02: [mem 0xe0000000-0xefffffff window] has been reserved # 94.85 [+0.00] [ 1.146511] pnp: PnP ACPI: found 3 devices # 94.85 [+0.00] [ 1.234956] NET: Registered PF_INET protocol family # 94.85 [+0.00] [ 1.236193] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) # 94.86 [+0.00] [ 1.242799] tcp_listen_portaddr_hash hash table entries: 512 (order: 3, 36864 bytes, linear) # 94.86 [+0.00] [ 1.243635] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) # 94.86 [+0.00] [ 1.244434] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) # 94.87 [+0.00] [ 1.245348] TCP bind hash table entries: 8192 (order: 8, 1179648 bytes, linear) # 94.87 [+0.00] [ 1.246245] TCP: Hash tables configured (established 8192 bind 8192) # 94.87 [+0.00] [ 1.247452] UDP hash table entries: 512 (order: 5, 131072 bytes, linear) # 94.87 [+0.00] [ 1.248109] UDP-Lite hash table entries: 512 (order: 5, 131072 bytes, linear) # 94.88 [+0.00] [ 1.250497] NET: Registered PF_UNIX/PF_LOCAL protocol family # 94.88 [+0.00] [ 1.251221] pci_bus 0000:00: resource 4 [mem 0xc0000000-0xdfffffff window] # 94.88 [+0.00] [ 1.251709] pci_bus 0000:00: resource 5 [mem 0x300000000000-0x3fffffffffff window] # 94.88 [+0.00] [ 1.252547] PCI: CLS 0 bytes, default 64 # 94.88 [+0.00] [ 1.255087] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer # 94.89 [+0.00] [ 1.269880] kvm_amd: CPU 3 isn't AMD or Hygon # 94.89 [+0.00] [ 1.270372] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2b3e459bf4c, max_idle_ns: 440795289890 ns # 94.89 [+0.00] [ 1.299459] Initialise system trusted keyrings # 94.89 [+0.00] [ 1.301155] workingset: timestamp_bits=56 max_order=18 bucket_order=0 # 94.90 [+0.00] [ 1.330747] squashfs: version 4.0 (2009/01/31) Phillip Lougher # 94.90 [+0.00] [ 1.331508] fuse: init (API version 7.44) # 94.90 [+0.00] [ 1.333552] 9p: Installing v9fs 9p2000 file system support # 94.90 [+0.00] [ 1.350942] Key type asymmetric registered # 94.90 [+0.00] [ 1.351327] Asymmetric key parser 'x509' registered # 94.90 [+0.00] [ 1.352533] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) # 94.91 [+0.00] [ 1.353484] io scheduler mq-deadline registered # 94.91 [+0.00] [ 1.353825] io scheduler kyber registered # 94.91 [+0.00] [ 1.363878] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 # 94.91 [+0.00] [ 1.366773] ACPI: button: Power Button [PWRB] # 94.91 [+0.00] [ 1.373671] virtiofs virtio0: discovered new tag: ROOTFS # 94.92 [+0.00] [ 1.375863] virtiofs virtio0: virtio_fs_setup_dax: No cache capability # 94.92 [+0.00] [ 1.388838] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled # 94.92 [+0.00] [ 1.393417] 00:00: ttyS0 at I/O 0x3f8 (irq = 51, base_baud = 115200) is a 16550A # 94.92 [+0.00] [ 1.649560] Non-volatile memory driver v1.3 # 94.92 [+0.00] [ 1.650588] ACPI: bus type drm_connector registered # 94.93 [+0.00] [ 1.765414] loop: module loaded # 94.93 [+0.00] [ 1.781264] printk: legacy console [hvc0] enabled # 94.93 [+0.00] [ 1.781652] printk: legacy bootconsole [earlyser0] disabled # 94.93 [+0.00] [ 1.796061] i8042: PNP: No PS/2 controller found. # 94.93 [+0.00] [ 1.811879] rtc_cmos 00:01: registered as rtc0 # 94.93 [+0.00] [ 1.812461] rtc_cmos 00:01: setting system clock to 2025-08-26T12:23:20 UTC (1756211000) # 94.94 [+0.00] [ 1.814345] rtc_cmos 00:01: alarms up to one day, 242 bytes nvram # 94.94 [+0.00] [ 1.821555] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev # 94.94 [+0.00] [ 1.838408] NET: Registered PF_INET6 protocol family # 94.94 [+0.00] [ 1.850226] Segment Routing with IPv6 # 94.94 [+0.00] [ 1.851296] In-situ OAM (IOAM) with IPv6 # 94.95 [+0.00] [ 1.852044] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver # 94.95 [+0.00] [ 1.860921] NET: Registered PF_PACKET protocol family # 94.95 [+0.00] [ 1.861520] 9pnet: Installing 9P2000 support # 94.95 [+0.00] [ 1.862574] Key type dns_resolver registered # 94.95 [+0.00] [ 1.873215] IPI shorthand broadcast: enabled # 94.95 [+0.00] [ 2.174698] sched_clock: Marking stable (2159007887, 15001916)->(2219520122, -45510319) # 94.96 [+0.00] [ 2.180341] registered taskstats version 1 # 94.96 [+0.00] [ 2.185680] Loading compiled-in X.509 certificates # 94.96 [+0.00] [ 2.382963] Demotion targets for Node 0: null # 94.96 [+0.00] [ 2.383518] kmemleak: Kernel memory leak detector initialized (mem pool available: 14856) # 94.96 [+0.00] [ 2.383992] page_owner is disabled # 94.97 [+0.00] [ 2.385609] PM: Magic number: 5:63:381 # 94.97 [+0.00] [ 2.385999] netconsole: network logging started # 94.97 [+0.00] [ 2.389382] ALSA device list: # 94.97 [+0.00] [ 2.389633] No soundcards found. # 94.97 [+0.00] [ 2.392424] check access for rdinit=/init failed: -2, ignoring # 94.97 [+0.00] [ 2.392755] md: Skipping autodetection of RAID arrays. (raid=autodetect will force) # 94.98 [+0.00] [ 2.398622] VFS: Mounted root (virtiofs filesystem) readonly on device 0:20. # 94.98 [+0.00] [ 2.400248] devtmpfs: mounted # 94.98 [+0.00] [ 2.465917] Freeing unused kernel image (initmem) memory: 2688K # 94.98 [+0.00] [ 2.469076] Write protecting the kernel read-only data: 51200k # 94.98 [+0.00] [ 2.471929] Freeing unused kernel image (text/rodata gap) memory: 668K # 94.99 [+0.00] [ 2.474402] Freeing unused kernel image (rodata/data gap) memory: 1396K # 94.99 [+0.00] [ 2.474851] Run /home/virtme/virtme-ng/virtme/guest/virtme-init as init process # 94.99 [+0.00] [ 2.475202] with arguments: # 94.99 [+0.00] [ 2.475209] /home/virtme/virtme-ng/virtme/guest/virtme-init # 94.99 [+0.00] [ 2.475215] with environment: # 95.00 [+0.00] [ 2.475219] HOME=/ # 95.00 [+0.00] [ 2.475225] TERM=linux # 95.00 [+0.00] [ 2.475229] virtme_hostname=virtme-ng # 95.00 [+0.00] [ 2.475232] nr_open=1073741816 # 95.00 [+0.00] [ 2.475235] virtme_link_mods=/home/virtme/testing/wt-4/.virtme_mods/lib/modules/0.0.0 # 95.00 [+0.00] [ 2.475238] virtme_rw_overlay0=/etc # 95.00 [+0.00] [ 2.475241] virtme_rw_overlay1=/lib # 95.01 [+0.00] [ 2.475244] virtme_rw_overlay2=/home # 95.01 [+0.00] [ 2.475247] virtme_rw_overlay3=/opt # 95.01 [+0.00] [ 2.475250] virtme_rw_overlay4=/srv # 95.01 [+0.00] [ 2.475252] virtme_rw_overlay5=/usr # 95.01 [+0.00] [ 2.475255] virtme_rw_overlay6=/var # 95.01 [+0.00] [ 2.475257] virtme_rw_overlay7=/tmp # 95.01 [+0.00] [ 2.475260] virtme_console=ttyS0 # 95.02 [+0.00] [ 2.475263] virtme_chdir=home/virtme/testing/wt-4 # 95.02 [+0.00] [ 2.757767] mount (72) used greatest stack depth: 26032 bytes left # 95.02 [+0.00] [ 2.972765] mkdir (75) used greatest stack depth: 25496 bytes left # 95.02 [+0.00] [ 3.063694] overlayfs: failed to set xattr on upper # 95.02 [+0.00] [ 3.064290] overlayfs: ...falling back to redirect_dir=nofollow. # 95.02 [+0.00] [ 3.064859] overlayfs: ...falling back to uuid=null. # 95.03 [+0.00] [ 3.146912] overlayfs: failed to set xattr on upper # 95.03 [+0.00] [ 3.147225] overlayfs: ...falling back to redirect_dir=nofollow. # 95.03 [+0.00] [ 3.147693] overlayfs: ...falling back to uuid=null. # 95.03 [+0.00] [ 3.161498] mount (78) used greatest stack depth: 25408 bytes left # 95.03 [+0.00] [ 3.234988] overlayfs: failed to set xattr on upper # 95.04 [+0.00] [ 3.235343] overlayfs: ...falling back to redirect_dir=nofollow. # 95.04 [+0.00] [ 3.235707] overlayfs: ...falling back to uuid=null. # 95.04 [+0.00] [ 3.307670] overlayfs: failed to set xattr on upper # 95.06 [+0.02] [ 3.308025] overlayfs: ...falling back to redirect_dir=nofollow. # 95.06 [+0.00] [ 3.308350] overlayfs: ...falling back to uuid=null. # 95.06 [+0.00] [ 3.388175] overlayfs: failed to set xattr on upper # 95.06 [+0.00] [ 3.388503] overlayfs: ...falling back to redirect_dir=nofollow. # 95.06 [+0.00] [ 3.388838] overlayfs: ...falling back to uuid=null. # 95.07 [+0.00] [ 3.472556] overlayfs: failed to set xattr on upper # 95.07 [+0.00] [ 3.472868] overlayfs: ...falling back to redirect_dir=nofollow. # 95.07 [+0.00] [ 3.473348] overlayfs: ...falling back to uuid=null. # 95.07 [+0.00] [ 3.560486] overlayfs: failed to set xattr on upper # 95.07 [+0.00] [ 3.560793] overlayfs: ...falling back to redirect_dir=nofollow. # 95.08 [+0.00] [ 3.561145] overlayfs: ...falling back to uuid=null. # 95.08 [+0.00] [ 3.620671] overlayfs: failed to set xattr on upper # 95.08 [+0.00] [ 3.621024] overlayfs: ...falling back to redirect_dir=nofollow. # 95.08 [+0.00] [ 3.621474] overlayfs: ...falling back to uuid=null. # 95.08 [+0.00] [ 3.906781] virtme-init (107) used greatest stack depth: 24976 bytes left # 95.08 [+0.00] [ 4.541642] virtme-init: basic initialization done # 95.09 [+0.00] [ 4.625516] virtme-init: starting udevd # 95.09 [+0.00] [ 4.626524] virtme-init: running systemd-tmpfiles # 95.09 [+0.00] [ 4.972714] virtme-init: triggering udev coldplug # 95.09 [+0.00] [ 8.218215] virtme-init: waiting for udev to settle # 95.09 [+0.00] [ 9.152401] virtme-init: udev is done # 95.09 [+0.00] [ 10.156909] virtme-init: Setting hostname to virtme-ng... # 95.10 [+0.00] [ 10.319349] ip (167) used greatest stack depth: 24944 bytes left # 95.10 [+0.00] [ 16.119091] ip (250) used greatest stack depth: 24768 bytes left # 95.10 [+0.00] [ 16.759328] ip (259) used greatest stack depth: 24528 bytes left # 95.10 [+0.00] [ 23.703244] br1: port 1(vx1) entered blocking state # 95.10 [+0.00] [ 23.703975] br1: port 1(vx1) entered disabled state # 95.11 [+0.00] [ 23.704702] vx1: entered allmulticast mode # 95.11 [+0.00] [ 23.710923] vx1: entered promiscuous mode # 95.11 [+0.00] [ 23.715877] br1: port 1(vx1) entered blocking state # 95.11 [+0.00] [ 23.716583] br1: port 1(vx1) entered forwarding state # 95.11 [+0.00] [ 23.874194] br1: port 2(veth1) entered blocking state # 95.11 [+0.00] [ 23.874630] br1: port 2(veth1) entered disabled state # 95.12 [+0.00] [ 23.875068] veth1: entered allmulticast mode # 95.12 [+0.00] [ 23.878878] veth1: entered promiscuous mode # 95.12 [+0.00] [ 23.997184] br1: port 2(veth1) entered blocking state # 95.12 [+0.00] [ 23.997997] br1: port 2(veth1) entered forwarding state # 95.12 [+0.00] [ 24.145326] br1: port 3(veth2) entered blocking state # 95.12 [+0.00] [ 24.145982] br1: port 3(veth2) entered disabled state # 95.13 [+0.00] [ 24.147487] veth2: entered allmulticast mode # 95.13 [+0.00] [ 24.153282] veth2: entered promiscuous mode # 95.13 [+0.00] [ 24.278868] br1: port 3(veth2) entered blocking state # 95.13 [+0.00] [ 24.279372] br1: port 3(veth2) entered forwarding state # 95.13 [+0.00] [ 29.267630] br2: port 1(w1) entered blocking state # 95.13 [+0.00] [ 29.268029] br2: port 1(w1) entered disabled state # 95.14 [+0.00] [ 29.268399] w1: entered allmulticast mode # 95.14 [+0.00] [ 29.272011] w1: entered promiscuous mode # 95.14 [+0.00] [ 30.057848] br2: port 2(vx2) entered blocking state # 95.14 [+0.00] [ 30.058943] br2: port 2(vx2) entered disabled state # 95.14 [+0.00] [ 30.059350] vx2: entered allmulticast mode # 95.14 [+0.00] [ 30.062788] vx2: entered promiscuous mode # 95.14 [+0.00] [ 30.064153] br2: port 2(vx2) entered blocking state # 95.15 [+0.00] [ 30.064512] br2: port 2(vx2) entered forwarding state # 95.15 [+0.00] [ 31.014986] br2: port 1(w1) entered blocking state # 95.15 [+0.00] [ 31.015601] br2: port 1(w1) entered forwarding state # 95.15 [+0.00] [ 33.624496] br2: port 1(w1) entered blocking state # 95.15 [+0.00] [ 33.624942] br2: port 1(w1) entered disabled state # 95.15 [+0.00] [ 33.625778] w1: entered allmulticast mode # 95.16 [+0.00] [ 33.630707] w1: entered promiscuous mode # 95.16 [+0.00] [ 34.352370] br2: port 2(vx2) entered blocking state # 95.16 [+0.00] [ 34.352911] br2: port 2(vx2) entered disabled state # 95.16 [+0.00] [ 34.354236] vx2: entered allmulticast mode # 95.16 [+0.00] [ 34.359558] vx2: entered promiscuous mode # 95.16 [+0.00] [ 34.361458] br2: port 2(vx2) entered blocking state # 95.17 [+0.00] [ 34.362126] br2: port 2(vx2) entered forwarding state # 95.17 [+0.00] [ 35.391777] br2: port 1(w1) entered blocking state # 95.17 [+0.00] [ 35.392194] br2: port 1(w1) entered forwarding state # 95.17 [+0.00] [ 48.866470] GACT probability NOT on # 95.17 [+0.00] [ 76.165052] veth3: entered promiscuous mode # 95.17 [+0.00] [ 119.231690] veth3: left promiscuous mode # 95.18 [+0.00] [ 147.452775] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.18 [+0.00] [ 147.554524] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.18 [+0.00] [ 147.655572] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.18 [+0.00] [ 147.756655] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.18 [+0.00] [ 147.857774] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.18 [+0.00] [ 147.958815] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.19 [+0.00] [ 148.059858] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.19 [+0.00] [ 148.160866] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.19 [+0.00] [ 148.261955] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.19 [+0.00] [ 148.363267] vxlan: non-ECT from 192.0.2.34 with TOS=0x1 # 95.19 [+0.00] [ 152.528126] net_ratelimit: 3 callbacks suppressed # 95.20 [+0.00] [ 152.528138] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.20 [+0.00] [ 152.629817] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.20 [+0.00] [ 152.731095] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.20 [+0.00] [ 152.832309] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.20 [+0.00] [ 152.933546] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.20 [+0.00] [ 153.034813] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.21 [+0.00] [ 153.136049] vxlan: non-ECT from 192.0.2.34 with TOS=0x2 # 95.21 [+0.00] [ 212.426095] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.21 [+0.00] [ 212.528141] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.21 [+0.00] [ 212.629244] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.21 [+0.00] [ 212.730259] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 212.831171] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 212.932135] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 213.033143] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 213.134083] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 213.235059] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.22 [+0.00] [ 213.336275] vxlan: non-ECT from 192.0.2.34 with TOS=0x3 # 95.23 [+0.00] [ 214.556242] vx1: left allmulticast mode # 95.23 [+0.00] [ 214.556856] vx1: left promiscuous mode # 95.23 [+0.00] [ 214.557730] br1: port 1(vx1) entered disabled state # 95.23 [+0.00] [ 219.806160] br1: port 1(vx1) entered blocking state # 95.23 [+0.00] [ 219.806527] br1: port 1(vx1) entered disabled state # 95.23 [+0.00] [ 219.806892] vx1: entered allmulticast mode # 95.24 [+0.00] [ 219.810448] vx1: entered promiscuous mode # 95.24 [+0.00] [ 219.811705] br1: port 1(vx1) entered blocking state # 95.24 [+0.00] [ 219.812069] br1: port 1(vx1) entered forwarding state # 95.24 [+0.00] [ 258.914406] veth3: entered promiscuous mode # 95.24 [+0.00] [ 301.523473] veth3: left promiscuous mode # 95.24 [+0.00] [ 303.504334] vx1: left allmulticast mode # 95.24 [+0.00] [ 303.504705] vx1: left promiscuous mode # 95.25 [+0.00] [ 303.505337] br1: port 1(vx1) entered disabled state # 95.25 [+0.00] [ 308.752707] br1: port 1(vx1) entered blocking state # 95.25 [+0.00] [ 308.753106] br1: port 1(vx1) entered disabled state # 95.25 [+0.00] [ 308.753473] vx1: entered allmulticast mode # 95.25 [+0.00] [ 308.757371] vx1: entered promiscuous mode # 95.25 [+0.00] [ 308.758589] br1: port 1(vx1) entered blocking state # 95.26 [+0.00] [ 308.758939] br1: port 1(vx1) entered forwarding state # 95.26 [+0.00] [ 402.835214] sched: DL replenish lagged too much # 95.26 [+0.00] [ 443.924208] tc (4179) used greatest stack depth: 23976 bytes left # 95.26 [+0.00] [ 450.586722] vx1: left allmulticast mode # 95.26 [+0.00] [ 450.587159] vx1: left promiscuous mode # 95.26 [+0.00] [ 450.587687] br1: port 1(vx1) entered disabled state # 95.27 [+0.00] [ 455.803581] br1: port 1(vx1) entered blocking state # 95.27 [+0.00] [ 455.803936] br1: port 1(vx1) entered disabled state # 95.27 [+0.00] [ 455.804790] vx1: entered allmulticast mode # 95.27 [+0.00] [ 455.808212] vx1: entered promiscuous mode # 95.27 [+0.00] [ 455.810430] br1: port 1(vx1) entered blocking state # 95.27 [+0.00] [ 455.810754] br1: port 1(vx1) entered forwarding state # 95.28 [+0.00] [ 463.078302] vx2: left allmulticast mode # 95.28 [+0.00] [ 463.078825] vx2: left promiscuous mode # 95.28 [+0.00] [ 463.080870] br2: port 2(vx2) entered disabled state # 95.28 [+0.00] [ 463.090825] w1: left allmulticast mode # 95.28 [+0.00] [ 463.091205] w1: left promiscuous mode # 95.28 [+0.00] [ 463.091692] br2: port 1(w1) entered disabled state # 95.28 [+0.00] [ 463.548105] vx2: left allmulticast mode # 95.29 [+0.00] [ 463.548462] vx2: left promiscuous mode # 95.29 [+0.00] [ 463.548951] br2: port 2(vx2) entered disabled state # 95.29 [+0.00] [ 463.551883] w1: left allmulticast mode # 95.29 [+0.00] [ 463.552609] w1: left promiscuous mode # 95.29 [+0.00] [ 463.553098] br2: port 1(w1) entered disabled state # 95.29 [+0.00] [ 466.384836] vx1: left allmulticast mode # 95.29 [+0.00] [ 466.385217] vx1: left promiscuous mode # 95.30 [+0.00] [ 466.385732] br1: port 1(vx1) entered disabled state # 95.30 [+0.00] [ 466.780274] br1: port 3(veth2) entered disabled state # 95.30 [+0.00] [ 466.908221] veth2: left allmulticast mode # 95.30 [+0.00] [ 466.908598] veth2: left promiscuous mode # 95.30 [+0.00] [ 466.909119] br1: port 3(veth2) entered disabled state # 95.30 [+0.00] [ 467.053736] br1: port 2(veth1) entered disabled state # 95.31 [+0.00] [ 467.197170] veth1: left allmulticast mode # 95.31 [+0.00] [ 467.197574] veth1: left promiscuous mode # 95.31 [+0.00] [ 467.198673] br1: port 2(veth1) entered disabled state # 95.31 [+0.00] [ 484.604790] br1: port 1(veth1) entered blocking state # 95.31 [+0.00] [ 484.605554] br1: port 1(veth1) entered disabled state # 95.31 [+0.00] [ 484.605955] veth1: entered allmulticast mode # 95.31 [+0.00] [ 484.609257] veth1: entered promiscuous mode # 95.32 [+0.00] [ 484.914164] br1: port 1(veth1) entered blocking state # 95.32 [+0.00] [ 484.914594] br1: port 1(veth1) entered forwarding state # 95.32 [+0.00] [ 492.183890] br1: port 2(vx1) entered blocking state # 95.32 [+0.00] [ 492.184302] br1: port 2(vx1) entered disabled state # 95.32 [+0.00] [ 492.184682] vx1: entered allmulticast mode # 95.32 [+0.00] [ 492.188644] vx1: entered promiscuous mode # 95.33 [+0.00] [ 492.190722] br1: port 2(vx1) entered blocking state # 95.33 [+0.00] [ 492.191097] br1: port 2(vx1) entered forwarding state # 95.33 [+0.00] [ 546.117619] vx1: left allmulticast mode # 95.33 [+0.00] [ 546.119090] vx1: left promiscuous mode # 95.33 [+0.00] [ 546.119890] br1: port 2(vx1) entered disabled state # 95.33 [+0.00] [ 546.781515] br1: port 2(vx1) entered blocking state # 95.34 [+0.00] [ 546.781873] br1: port 2(vx1) entered disabled state # 95.34 [+0.00] [ 546.782263] vx1: entered allmulticast mode # 95.34 [+0.00] [ 546.786855] vx1: entered promiscuous mode # 95.34 [+0.00] [ 546.788040] br1: port 2(vx1) entered blocking state # 95.34 [+0.00] [ 546.788371] br1: port 2(vx1) entered forwarding state # 95.34 [+0.00] [ 599.844627] vx1: left allmulticast mode # 95.35 [+0.00] [ 599.844955] vx1: left promiscuous mode # 95.35 [+0.00] [ 599.845454] br1: port 2(vx1) entered disabled state # 95.35 [+0.00] [ 600.698410] br1: port 2(vx1) entered blocking state # 95.35 [+0.00] [ 600.698780] br1: port 2(vx1) entered disabled state # 95.35 [+0.00] [ 600.699159] vx1: entered allmulticast mode # 95.35 [+0.00] [ 600.703275] vx1: entered promiscuous mode # 95.35 [+0.00] [ 600.704483] br1: port 2(vx1) entered blocking state # 95.36 [+0.00] [ 600.704861] br1: port 2(vx1) entered forwarding state # 95.36 [+0.00] [ 654.143470] vx1: left allmulticast mode # 95.36 [+0.00] [ 654.143970] vx1: left promiscuous mode # 95.36 [+0.00] [ 654.146153] br1: port 2(vx1) entered disabled state # 95.36 [+0.00] [ 655.023449] br1: port 2(vx1) entered blocking state # 95.36 [+0.00] [ 655.023882] br1: port 2(vx1) entered disabled state # 95.37 [+0.00] [ 655.024316] vx1: entered allmulticast mode # 95.37 [+0.00] [ 655.028136] vx1: entered promiscuous mode # 95.37 [+0.00] [ 655.029455] br1: port 2(vx1) entered blocking state # 95.37 [+0.00] [ 655.029830] br1: port 2(vx1) entered forwarding state # 95.37 [+0.00] [ 707.526433] vx1: left allmulticast mode # 95.37 [+0.00] [ 707.526827] vx1: left promiscuous mode # 95.38 [+0.00] [ 707.527512] br1: port 2(vx1) entered disabled state # 95.38 [+0.00] [ 708.259688] br1: port 2(vx1) entered blocking state # 95.38 [+0.00] [ 708.260085] br1: port 2(vx1) entered disabled state # 95.38 [+0.00] [ 708.260451] vx1: entered allmulticast mode # 95.38 [+0.00] [ 708.264586] vx1: entered promiscuous mode # 95.38 [+0.00] [ 708.265873] br1: port 2(vx1) entered blocking state # 95.39 [+0.00] [ 708.266216] br1: port 2(vx1) entered forwarding state # 95.39 [+0.00] [ 761.307930] vx1: left allmulticast mode # 95.39 [+0.00] [ 761.308456] vx1: left promiscuous mode # 95.40 [+0.01] [ 761.308958] br1: port 2(vx1) entered disabled state # 95.40 [+0.00] [ 762.118705] br1: port 2(vx1) entered blocking state # 95.40 [+0.00] [ 762.119108] br1: port 2(vx1) entered disabled state # 95.41 [+0.00] [ 762.119475] vx1: entered allmulticast mode # 95.41 [+0.00] [ 762.123268] vx1: entered promiscuous mode # 95.41 [+0.00] [ 762.124915] br1: port 2(vx1) entered blocking state # 95.41 [+0.00] [ 762.125264] br1: port 2(vx1) entered forwarding state # 95.41 [+0.00] [ 815.304585] vx1: left allmulticast mode # 95.41 [+0.00] [ 815.304982] vx1: left promiscuous mode # 95.42 [+0.00] [ 815.305517] br1: port 2(vx1) entered disabled state # 95.42 [+0.00] [ 816.155254] br1: port 2(vx1) entered blocking state # 95.42 [+0.00] [ 816.155622] br1: port 2(vx1) entered disabled state # 95.42 [+0.00] [ 816.155976] vx1: entered allmulticast mode # 95.42 [+0.00] [ 816.159405] vx1: entered promiscuous mode # 95.42 [+0.00] [ 816.160608] br1: port 2(vx1) entered blocking state # 95.43 [+0.00] [ 816.160939] br1: port 2(vx1) entered forwarding state # 95.43 [+0.00] [ 869.129228] vx1: left allmulticast mode # 95.43 [+0.00] [ 869.129861] vx1: left promiscuous mode # 95.43 [+0.00] [ 869.130719] br1: port 2(vx1) entered disabled state # 95.43 [+0.00] [ 870.339527] br1: port 1(veth1) entered disabled state # 95.43 [+0.00] [ 870.499306] veth1: left allmulticast mode # 95.44 [+0.00] [ 870.499721] veth1: left promiscuous mode # 95.44 [+0.00] [ 870.500243] br1: port 1(veth1) entered disabled state # 95.44 [+0.00] [ 888.523256] gre: GRE over IPv4 demultiplexer driver # 95.44 [+0.00] [ 888.546671] ip_gre: GRE over IPv4 tunneling driver # 95.44 [+0.00] [ 890.749588] 8021q: 802.1Q VLAN Support v1.8 # 95.44 [+0.00] [ 1089.511580] br0: port 1(veth1) entered blocking state # 95.45 [+0.00] [ 1089.512065] br0: port 1(veth1) entered disabled state # 95.45 [+0.00] [ 1089.512518] veth1: entered allmulticast mode # 95.45 [+0.00] [ 1089.517540] veth1: entered promiscuous mode # 95.45 [+0.00] [ 1089.667739] br0: port 2(veth2) entered blocking state # 95.45 [+0.00] [ 1089.668157] br0: port 2(veth2) entered disabled state # 95.45 [+0.00] [ 1089.668574] veth2: entered allmulticast mode # 95.46 [+0.00] [ 1089.671920] veth2: entered promiscuous mode # 95.46 [+0.00] [ 1089.885775] br0: port 1(veth1) entered blocking state # 95.46 [+0.00] [ 1089.886224] br0: port 1(veth1) entered forwarding state # 95.46 [+0.00] [ 1089.994283] br0: port 2(veth2) entered blocking state # 95.46 [+0.00] [ 1089.994709] br0: port 2(veth2) entered forwarding state # 95.46 [+0.00] [ 1099.014502] veth0: entered promiscuous mode # 95.47 [+0.00] [ 1125.870991] veth0: left promiscuous mode # 95.47 [+0.00] [ 1126.301431] veth3: entered promiscuous mode # 95.47 [+0.00] [ 1128.387940] veth3: left promiscuous mode # 95.47 [+0.00] [ 1128.633294] veth3: entered promiscuous mode # 95.47 [+0.00] [ 1130.741066] veth3: left promiscuous mode # 95.47 [+0.00] [ 1130.966629] veth3: entered promiscuous mode # 95.47 [+0.00] [ 1133.094216] veth3: left promiscuous mode # 95.48 [+0.00] [ 1133.288905] veth3: entered promiscuous mode # 95.48 [+0.00] [ 1135.446888] veth3: left promiscuous mode # 95.48 [+0.00] [ 1160.046530] veth3: entered promiscuous mode # 95.48 [+0.00] [ 1163.529463] veth3: left promiscuous mode # 95.48 [+0.00] [ 1164.038838] veth3: entered promiscuous mode # 95.48 [+0.00] [ 1167.668610] veth3: left promiscuous mode # 95.48 [+0.00] [ 1168.181777] veth3: entered promiscuous mode # 95.49 [+0.00] [ 1183.071753] br0: port 1(veth1) entered disabled state # 95.49 [+0.00] [ 1183.170753] br0: port 1(veth1) entered blocking state # 95.49 [+0.00] [ 1183.171432] br0: port 1(veth1) entered forwarding state # 95.49 [+0.00] [ 1194.218270] veth1: left allmulticast mode # 95.49 [+0.00] [ 1194.218595] veth1: left promiscuous mode # 95.49 [+0.00] [ 1194.219077] br0: port 1(veth1) entered disabled state # 95.50 [+0.00] [ 1194.331562] br0: port 1(veth1) entered blocking state # 95.50 [+0.00] [ 1194.331978] br0: port 1(veth1) entered disabled state # 95.50 [+0.00] [ 1194.332426] veth1: entered allmulticast mode # 95.50 [+0.00] [ 1194.335891] veth1: entered promiscuous mode # 95.50 [+0.00] [ 1194.336701] br0: port 1(veth1) entered blocking state # 95.50 [+0.00] [ 1194.337142] br0: port 1(veth1) entered forwarding state # 95.51 [+0.00] [ 1199.608875] veth3: left promiscuous mode # 95.51 [+0.00] [ 1199.947726] br0: port 2(veth2) entered disabled state # 95.51 [+0.00] [ 1200.047919] br0: port 1(veth1) entered disabled state # 95.51 [+0.00] [ 1200.182683] veth1: left allmulticast mode # 95.51 [+0.00] [ 1200.183030] veth1: left promiscuous mode # 95.51 [+0.00] [ 1200.183509] br0: port 1(veth1) entered disabled state # 95.52 [+0.00] [ 1200.185552] veth2: left allmulticast mode # 95.52 [+0.00] [ 1200.185855] veth2: left promiscuous mode # 95.52 [+0.00] [ 1200.186723] br0: port 2(veth2) entered disabled state # 95.52 [+0.00] [ 1228.037902] Mirror/redirect action on # 95.52 [+0.00] [ 1240.980919] tc (19727) used greatest stack depth: 23728 bytes left ok 1 selftests: net/forwarding: tc_actions.sh make[1]: Leaving directory '/home/virtme/testing/wt-4/tools/testing/selftests/net/forwarding' make: Leaving directory '/home/virtme/testing/wt-4/tools/testing/selftests' xx__-> echo $? 0 xx__-> echo scan > /sys/kernel/debug/kmemleak && cat /sys/kernel/debug/kmemleak xx__-> echo scan > /sys/kernel/debug/kmemleak && cat /sys/kernel/debug/kmemleak xx__->