reserved # 77.29 [+0.00] [ 0.007133] [ T0] e820: remove [mem 0x000a0000-0x000fffff] usable # 77.29 [+0.00] [ 0.008361] [ T0] last_pfn = 0x3ffff max_arch_pfn = 0x10000000000 # 77.29 [+0.00] [ 0.009608] [ T0] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs # 77.30 [+0.00] [ 0.011377] [ T0] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT # 77.30 [+0.00] [ 0.014867] [ T0] found SMP MP-table at [mem 0x000f5690-0x000f569f] # 77.30 [+0.00] [ 0.016147] [ T0] Using GB pages for direct mapping # 77.30 [+0.00] [ 0.017279] [ T0] ACPI: Early table checksum verification disabled # 77.31 [+0.00] [ 0.018522] [ T0] ACPI: RSDP 0x00000000000F54B0 000024 (v02 BOCHS ) # 77.31 [+0.00] [ 0.019782] [ T0] ACPI: XSDT 0x000000003FFFFFCA 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) # 77.31 [+0.00] [ 0.021588] [ T0] ACPI: FACP 0x000000003FFFFE54 00010C (v05 BOCHS BXPC 00000001 BXPC 00000001) # 77.32 [+0.00] [ 0.023397] [ T0] ACPI: DSDT 0x000000003FFFF240 000C14 (v02 BOCHS BXPC 00000001 BXPC 00000001) # 77.32 [+0.00] [ 0.025200] [ T0] ACPI: APIC 0x000000003FFFFF60 00006A (v03 BOCHS BXPC 00000001 BXPC 00000001) # 77.32 [+0.00] [ 0.026999] [ T0] ACPI: Reserving FACP table memory at [mem 0x3ffffe54-0x3fffff5f] # 77.33 [+0.00] [ 0.028531] [ T0] ACPI: Reserving DSDT table memory at [mem 0x3ffff240-0x3ffffe53] # 77.33 [+0.00] [ 0.030043] [ T0] ACPI: Reserving APIC table memory at [mem 0x3fffff60-0x3fffffc9] # 77.33 [+0.00] [ 0.032101] [ T0] No NUMA configuration found # 77.33 [+0.00] [ 0.032984] [ T0] Faking a node at [mem 0x0000000000000000-0x000000003fffefff] # 77.34 [+0.00] [ 0.034436] [ T0] NODE_DATA(0) allocated [mem 0x3fffa100-0x3fffefff] # 77.34 [+0.00] [ 0.044397] [ T0] Zone ranges: # 77.34 [+0.00] [ 0.045046] [ T0] DMA [mem 0x0000000000001000-0x0000000000ffffff] # 77.34 [+0.00] [ 0.046404] [ T0] DMA32 [mem 0x0000000001000000-0x000000003fffefff] # 77.35 [+0.00] [ 0.047746] [ T0] Normal empty # 77.35 [+0.00] [ 0.048451] [ T0] Device empty # 77.35 [+0.00] [ 0.049154] [ T0] Movable zone start for each node # 77.35 [+0.00] [ 0.050125] [ T0] Early memory node ranges # 77.35 [+0.00] [ 0.050954] [ T0] node 0: [mem 0x0000000000001000-0x000000000009efff] # 77.35 [+0.00] [ 0.052317] [ T0] node 0: [mem 0x0000000000100000-0x000000003fffefff] # 77.36 [+0.00] [ 0.053674] [ T0] Initmem setup node 0 [mem 0x0000000000001000-0x000000003fffefff] # 77.36 [+0.00] [ 0.055214] [ T0] On node 0, zone DMA: 1 pages in unavailable ranges # 77.36 [+0.00] [ 0.056529] [ T0] On node 0, zone DMA: 97 pages in unavailable ranges # 77.36 [+0.00] [ 0.060309] [ T0] On node 0, zone DMA32: 1 pages in unavailable ranges # 77.37 [+0.00] [ 0.137042] [ T0] KernelAddressSanitizer initialized (generic) # 77.37 [+0.00] [ 0.138720] [ T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) # 77.37 [+0.00] [ 0.140104] [ T0] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 # 77.37 [+0.00] [ 0.141686] [ T0] IOAPIC[1]: apic_id 1, version 32, address 0xfec10000, GSI 24-47 # 77.38 [+0.00] [ 0.143193] [ T0] ACPI: Using ACPI (MADT) for SMP configuration information # 77.38 [+0.00] [ 0.144589] [ T0] TSC deadline timer available # 77.38 [+0.00] [ 0.145495] [ T0] CPU topo: Max. logical packages: 1 # 77.38 [+0.00] [ 0.146547] [ T0] CPU topo: Max. logical dies: 1 # 77.38 [+0.00] [ 0.147583] [ T0] CPU topo: Max. dies per package: 1 # 77.39 [+0.00] [ 0.148622] [ T0] CPU topo: Max. threads per core: 1 # 77.39 [+0.00] [ 0.149662] [ T0] CPU topo: Num. cores per package: 4 # 77.39 [+0.00] [ 0.150751] [ T0] CPU topo: Num. threads per package: 4 # 77.39 [+0.00] [ 0.151838] [ T0] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs # 77.39 [+0.00] [ 0.153206] [ T0] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() # 77.40 [+0.00] [ 0.154718] [ T0] kvm-guest: KVM setup pv remote TLB flush # 77.40 [+0.00] [ 0.155825] [ T0] kvm-guest: setup PV sched yield # 77.40 [+0.00] [ 0.156856] [ T0] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] # 77.40 [+0.00] [ 0.158496] [ T0] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] # 77.41 [+0.00] [ 0.160126] [ T0] [mem 0x40000000-0xfeffbfff] available for PCI devices # 77.41 [+0.00] [ 0.161456] [ T0] Booting paravirtualized kernel on KVM # 77.41 [+0.00] [ 0.162570] [ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns # 77.41 [+0.00] [ 0.174849] [ T0] setup_percpu: NR_CPUS:64 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 # 77.42 [+0.00] [ 0.177872] [ T0] percpu: Embedded 66 pages/cpu s231824 r8192 d30320 u524288 # 77.42 [+0.00] [ 0.179425] [ T0] pcpu-alloc: s231824 r8192 d30320 u524288 alloc=1*2097152 # 77.42 [+0.00] [ 0.180816] [ T0] pcpu-alloc: [0] 0 1 2 3 # 77.42 [+0.00] [ 0.181782] [ 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 # 77.44 [+0.02] [ 0.193372] [ 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. # 77.45 [+0.01] [ 0.201777] [ T0] random: crng init done # 77.46 [+0.00] [ 0.202585] [ T0] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes # 77.46 [+0.00] [ 0.204665] [ T0] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) # 77.46 [+0.00] [ 0.206595] [ T0] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) # 77.46 [+0.00] [ 0.208469] [ T0] Fallback order for Node 0: 0 # 77.47 [+0.00] [ 0.208476] [ T0] Built 1 zonelists, mobility grouping on. Total pages: 262045 # 77.47 [+0.00] [ 0.210860] [ T0] Policy zone: DMA32 # 77.47 [+0.00] [ 0.211601] [ T0] mem auto-init: stack:all(zero), heap alloc:off, heap free:off # 77.47 [+0.00] [ 0.213072] [ T0] stackdepot: allocating hash table via alloc_large_system_hash # 77.48 [+0.00] [ 0.214538] [ T0] stackdepot hash table entries: 1048576 (order: 12, 16777216 bytes, linear) # 77.48 [+0.00] [ 0.223975] [ T0] stackdepot: allocating space for 8192 stack pools via memblock # 77.48 [+0.00] [ 0.248017] [ T0] ********************************************************** # 77.48 [+0.00] [ 0.249461] [ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 77.49 [+0.00] [ 0.250874] [ T0] ** ** # 77.49 [+0.00] [ 0.252297] [ T0] ** This system shows unhashed kernel memory addresses ** # 77.49 [+0.00] [ 0.253707] [ T0] ** via the console, logs, and other interfaces. This ** # 77.49 [+0.00] [ 0.255126] [ T0] ** might reduce the security of your system. ** # 77.50 [+0.00] [ 0.256538] [ T0] ** ** # 77.50 [+0.00] [ 0.257943] [ T0] ** If you see this message and you are not debugging ** # 77.50 [+0.00] [ 0.259358] [ T0] ** the kernel, report this immediately to your system ** # 77.50 [+0.00] [ 0.260767] [ T0] ** administrator! ** # 77.51 [+0.00] [ 0.262184] [ T0] ** ** # 77.51 [+0.00] [ 0.263601] [ T0] ** Use hash_pointers=always to force this mode off ** # 77.51 [+0.00] [ 0.265014] [ T0] ** ** # 77.51 [+0.00] [ 0.266434] [ T0] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** # 77.52 [+0.00] [ 0.267847] [ T0] ********************************************************** # 77.52 [+0.00] [ 0.269701] [ T0] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 # 77.52 [+0.00] [ 0.287109] [ T0] ftrace: allocating 46387 entries in 184 pages # 77.52 [+0.00] [ 0.288314] [ T0] ftrace: allocated 184 pages with 4 groups # 77.52 [+0.00] [ 0.289761] [ T0] Dynamic Preempt: full # 77.53 [+0.00] [ 0.291691] [ T0] Running RCU self tests # 77.53 [+0.00] [ 0.292500] [ T0] Running RCU synchronous self tests # 77.53 [+0.00] [ 0.293510] [ T0] rcu: Preemptible hierarchical RCU implementation. # 77.53 [+0.00] [ 0.294769] [ T0] rcu: RCU event tracing is enabled. # 77.53 [+0.00] [ 0.295794] [ T0] rcu: RCU lockdep checking is enabled. # 77.54 [+0.00] [ 0.296870] [ T0] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. # 77.54 [+0.00] [ 0.298310] [ T0] rcu: RCU callback double-/use-after-free debug is enabled. # 77.54 [+0.00] [ 0.299739] [ T0] Trampoline variant of Tasks RCU enabled. # 77.54 [+0.00] [ 0.300864] [ T0] Rude variant of Tasks RCU enabled. # 77.54 [+0.00] [ 0.301912] [ T0] Tracing variant of Tasks RCU enabled. # 77.55 [+0.00] [ 0.302989] [ T0] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. # 77.55 [+0.00] [ 0.304629] [ T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 # 77.55 [+0.00] [ 0.306320] [ T0] Running RCU synchronous self tests # 77.55 [+0.00] [ 0.307348] [ T0] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 77.56 [+0.00] [ 0.309210] [ T0] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 77.56 [+0.00] [ 0.311150] [ T0] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. # 77.56 [+0.00] [ 0.359891] [ T0] NR_IRQS: 4352, nr_irqs: 848, preallocated irqs: 0 # 77.57 [+0.00] [ 0.361400] [ T0] rcu: srcu_init: Setting srcu_struct sizes based on contention. # 77.57 [+0.00] [ 0.363740] [ T0] Console: colour *CGA 80x25 # 77.57 [+0.00] [ 0.364668] [ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar # 77.57 [+0.00] [ 0.366326] [ T0] ... MAX_LOCKDEP_SUBCLASSES: 8 # 77.58 [+0.00] [ 0.367268] [ T0] ... MAX_LOCK_DEPTH: 48 # 77.58 [+0.00] [ 0.368227] [ T0] ... MAX_LOCKDEP_KEYS: 8192 # 77.58 [+0.00] [ 0.369221] [ T0] ... CLASSHASH_SIZE: 4096 # 77.58 [+0.00] [ 0.370214] [ T0] ... MAX_LOCKDEP_ENTRIES: 32768 # 77.58 [+0.00] [ 0.371224] [ T0] ... MAX_LOCKDEP_CHAINS: 65536 # 77.58 [+0.00] [ 0.372232] [ T0] ... CHAINHASH_SIZE: 32768 # 77.59 [+0.00] [ 0.373241] [ T0] memory used by lock dependency info: 6429 kB # 77.59 [+0.00] [ 0.374437] [ T0] memory used for stack traces: 4224 kB # 77.59 [+0.00] [ 0.375514] [ T0] per task-struct memory footprint: 1920 bytes # 77.59 [+0.00] [ 0.376854] [ T0] ACPI: Core revision 20250807 # 77.59 [+0.00] [ 0.378419] [ T0] APIC: Switch to symmetric I/O mode setup # 77.60 [+0.00] [ 0.381394] [ T0] x2apic enabled # 77.60 [+0.00] [ 0.386137] [ T0] APIC: Switched APIC routing to: physical x2apic # 77.60 [+0.00] [ 0.387382] [ T0] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() # 77.60 [+0.00] [ 0.388939] [ T0] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() # 77.61 [+0.00] [ 0.390870] [ T0] kvm-guest: setup PV IPIs # 77.61 [+0.00] [ 0.391869] [ T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x257a3c3232d, max_idle_ns: 440795236700 ns # 77.61 [+0.00] [ 0.394100] [ T0] Calibrating delay loop (skipped) preset value.. 5200.00 BogoMIPS (lpj=2600000) # 77.61 [+0.00] [ 0.395092] [ T0] RDSEED32 is broken. Disabling the corresponding CPUID bit. # 77.62 [+0.00] [ 0.395092] [ T0] x86/cpu: User Mode Instruction Prevention (UMIP) activated # 77.62 [+0.00] [ 0.395092] [ T0] numa_add_cpu cpu 0 node 0: mask now 0 # 77.62 [+0.00] [ 0.395092] [ T0] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 # 77.62 [+0.00] [ 0.395092] [ T0] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 # 77.63 [+0.00] [ 0.395092] [ T0] mitigations: Enabled attack vectors: SMT mitigations: off # 77.63 [+0.00] [ 0.395092] [ T0] Speculative Store Bypass: Vulnerable # 77.63 [+0.00] [ 0.395092] [ T0] Spectre V2 : Vulnerable # 77.63 [+0.00] [ 0.395092] [ T0] Speculative Return Stack Overflow: Vulnerable # 77.63 [+0.00] [ 0.395092] [ T0] Spectre V1 : Vulnerable: __user pointer sanitization and usercopy barriers only; no swapgs barriers # 77.64 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' # 77.64 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' # 77.64 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' # 77.65 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' # 77.65 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' # 77.65 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' # 77.65 [+0.00] [ 0.395092] [ T0] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' # 77.66 [+0.00] [ 0.395092] [ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 # 77.66 [+0.00] [ 0.395092] [ T0] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 # 77.66 [+0.00] [ 0.395092] [ T0] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 # 77.66 [+0.00] [ 0.395092] [ T0] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 # 77.67 [+0.00] [ 0.395092] [ T0] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8 # 77.67 [+0.00] [ 0.395092] [ T0] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format. # 77.67 [+0.00] [ 0.395092] [ T0] Freeing SMP alternatives memory: 36K # 77.67 [+0.00] [ 0.395092] [ T0] pid_max: default: 32768 minimum: 301 # 77.68 [+0.00] [ 0.395092] [ T0] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 77.68 [+0.00] [ 0.395092] [ T0] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) # 77.68 [+0.00] [ 0.395092] [ T0] Running RCU synchronous self tests # 77.68 [+0.00] [ 0.395092] [ T0] Running RCU synchronous self tests # 77.69 [+0.00] [ 0.395092] [ T1] smpboot: CPU0: AMD EPYC 9655P 96-Core Processor (family: 0x1a, model: 0x2, stepping: 0x1) # 77.69 [+0.00] [ 0.399478] [ T1] Performance Events: Fam17h+ core perfctr, AMD PMU driver. # 77.69 [+0.00] [ 0.400115] [ T1] ... version: 2 # 77.69 [+0.00] [ 0.401086] [ T1] ... bit width: 48 # 77.70 [+0.00] [ 0.401101] [ T1] ... generic counters: 6 # 77.70 [+0.00] [ 0.402075] [ T1] ... generic bitmap: 000000000000003f # 77.70 [+0.00] [ 0.402101] [ T1] ... fixed-purpose counters: 0 # 77.70 [+0.00] [ 0.403074] [ T1] ... fixed-purpose bitmap: 0000000000000000 # 77.70 [+0.00] [ 0.403101] [ T1] ... value mask: 0000ffffffffffff # 77.71 [+0.00] [ 0.404101] [ T1] ... max period: 00007fffffffffff # 77.71 [+0.00] [ 0.405101] [ T1] ... global_ctrl mask: 000000000000003f # 77.71 [+0.00] [ 0.406677] [ T1] signal: max sigframe size: 3376 # 77.71 [+0.00] [ 0.408185] [ T1] rcu: Hierarchical SRCU implementation. # 77.71 [+0.00] [ 0.409110] [ T1] rcu: Max phase no-delay instances is 400. # 77.72 [+0.00] [ 0.419110] [ T1] smp: Bringing up secondary CPUs ... # 77.72 [+0.00] [ 0.422607] [ T1] smpboot: x86: Booting SMP configuration: # 77.72 [+0.00] [ 0.423145] [ T1] .... node #0, CPUs: #1 #2 #3 # 77.72 [+0.00] [ 0.032200] [ T0] numa_add_cpu cpu 1 node 0: mask now 0-1 # 77.72 [+0.00] [ 0.032200] [ T0] numa_add_cpu cpu 2 node 0: mask now 0-2 # 77.73 [+0.00] [ 0.032200] [ T0] numa_add_cpu cpu 3 node 0: mask now 0-3 # 77.73 [+0.00] [ 0.428678] [ T1] smp: Brought up 1 node, 4 CPUs # 77.73 [+0.00] [ 0.433076] [ T1] smpboot: Total of 4 processors activated (20800.00 BogoMIPS) # 77.73 [+0.00] [ 0.436068] [ T1] Memory: 749404K/1048180K available (43629K kernel code, 12459K rwdata, 9068K rodata, 2428K init, 17064K bss, 288360K reserved, 0K cma-reserved) # 77.74 [+0.00] [ 0.437497] [ T1] devtmpfs: initialized # 77.74 [+0.00] [ 0.439300] [ T1] x86/mm: Memory block size: 128MB # 77.74 [+0.00] [ 0.451480] [ T1] Running RCU synchronous self tests # 77.74 [+0.00] [ 0.452208] [ T1] Running RCU synchronous self tests # 77.75 [+0.00] [ 0.453846] [ T1] Running RCU Tasks wait API self tests # 77.75 [+0.00] [ 0.454230] [ T1] Running RCU Tasks Rude wait API self tests # 77.75 [+0.00] [ 0.455104] [ T1] Running RCU Tasks Trace wait API self tests # 77.75 [+0.00] [ 0.469768] [ T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns # 77.76 [+0.00] [ 0.470179] [ T1] posixtimers hash table entries: 2048 (order: 6, 147456 bytes, linear) # 77.76 [+0.00] [ 0.471286] [ T1] futex hash table entries: 1024 (131072 bytes on 1 NUMA nodes, total 128 KiB, linear). # 77.76 [+0.00] [ 0.473685] [ T1] PM: RTC time: 15:11:54, date: 2025-12-09 # 77.76 [+0.00] [ 0.477660] [ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family # 77.77 [+0.00] [ 0.481184] [ T1] thermal_sys: Registered thermal governor 'step_wise' # 77.77 [+0.00] [ 0.481338] [ T1] cpuidle: using governor ladder # 77.77 [+0.00] [ 0.486526] [ T1] PCI: Fatal: No config space access function found # 77.77 [+0.00] [ 0.487668] [ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. # 77.78 [+0.00] [ 0.488099] [ T43] Callback from call_rcu_tasks_trace() invoked. # 77.78 [+0.00] [ 0.491845] [ T1] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages # 77.78 [+0.00] [ 0.493107] [ T1] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page # 77.78 [+0.00] [ 0.494107] [ T1] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages # 77.79 [+0.00] [ 0.496103] [ T1] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page # 77.79 [+0.00] [ 0.502116] [ T1] ACPI: Added _OSI(Module Device) # 77.79 [+0.00] [ 0.503062] [ T1] ACPI: Added _OSI(Processor Device) # 77.79 [+0.00] [ 0.504124] [ T1] ACPI: Added _OSI(Processor Aggregator Device) # 77.79 [+0.00] [ 0.554554] [ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded # 77.80 [+0.00] [ 0.576553] [ T1] ACPI: Interpreter enabled # 77.80 [+0.00] [ 0.577388] [ T1] ACPI: PM: (supports S0 S5) # 77.80 [+0.00] [ 0.578226] [ T1] ACPI: Using IOAPIC for interrupt routing # 77.80 [+0.00] [ 0.579433] [ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug # 77.81 [+0.00] [ 0.580101] [ T1] PCI: Using E820 reservations for host bridge windows # 77.81 [+0.00] [ 0.622842] [ T1] ACPI: PCI: Interrupt link L000 configured for IRQ 16 # 77.81 [+0.00] [ 0.623441] [ T1] ACPI: PCI: Interrupt link L001 configured for IRQ 17 # 77.81 [+0.00] [ 0.624947] [ T1] ACPI: PCI: Interrupt link L002 configured for IRQ 18 # 77.81 [+0.00] [ 0.625391] [ T1] ACPI: PCI: Interrupt link L003 configured for IRQ 19 # 77.82 [+0.00] [ 0.626426] [ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) # 77.82 [+0.00] [ 0.627535] [ T1] acpi PNP0A08:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] # 77.82 [+0.00] [ 0.628378] [ T1] acpi PNP0A08:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] # 77.83 [+0.00] [ 0.638908] [ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] reserved as ACPI motherboard resource # 77.83 [+0.00] [ 0.661004] [ T1] acpi PNP0A08:00: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) # 77.83 [+0.00] [ 0.663894] [ T1] PCI host bridge to bus 0000:00 # 77.83 [+0.00] [ 0.665714] [ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xdfffffff window] # 77.84 [+0.00] [ 0.666121] [ T1] pci_bus 0000:00: root bus resource [mem 0xc000000000000-0xfffffffffffff window] # 77.84 [+0.00] [ 0.667151] [ T41] Callback from call_rcu_tasks() invoked. # 77.84 [+0.00] [ 0.667178] [ T1] pci_bus 0000:00: root bus resource [bus 00-ff] # 77.84 [+0.00] [ 0.669342] [ T1] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint # 77.85 [+0.00] [ 0.674306] [ T1] iommu: Default domain type: Translated # 77.85 [+0.00] [ 0.675101] [ T1] iommu: DMA domain TLB invalidation policy: lazy mode # 77.85 [+0.00] [ 0.679959] [ T1] SCSI subsystem initialized # 77.85 [+0.00] [ 0.680897] [ T1] libata version 3.00 loaded. # 77.85 [+0.00] [ 0.682482] [ T1] pps_core: LinuxPPS API ver. 1 registered # 77.86 [+0.00] [ 0.683189] [ T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti # 77.86 [+0.00] [ 0.684268] [ T1] PTP clock support registered # 77.86 [+0.00] [ 0.687033] [ T1] Advanced Linux Sound Architecture Driver Initialized. # 77.86 [+0.00] [ 0.691587] [ T1] PCI: Using ACPI for IRQ routing # 77.87 [+0.00] [ 0.692104] [ T1] PCI: pci_cache_line_size set to 64 bytes # 77.87 [+0.00] [ 0.693127] [ T1] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] # 77.87 [+0.00] [ 0.694172] [ T1] e820: reserve RAM buffer [mem 0x3ffff000-0x3fffffff] # 77.87 [+0.00] [ 0.695811] [ T1] vgaarb: loaded # 77.87 [+0.00] [ 0.697106] [ T1] clocksource: Switched to clocksource kvm-clock # 77.88 [+0.00] [ 0.722001] [ T1] VFS: Disk quotas dquot_6.6.0 # 77.88 [+0.00] [ 0.723050] [ T1] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) # 77.88 [+0.00] [ 0.728941] [ T1] pnp: PnP ACPI init # 77.88 [+0.00] [ 0.733515] [ T1] system 00:02: [mem 0xe0000000-0xefffffff window] has been reserved # 77.88 [+0.00] [ 0.735305] [ T1] pnp: PnP ACPI: found 3 devices # 77.89 [+0.00] [ 0.771742] [ T1] NET: Registered PF_INET protocol family # 77.89 [+0.00] [ 0.773281] [ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) # 77.89 [+0.00] [ 0.778066] [ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 4, 36864 bytes, linear) # 77.89 [+0.00] [ 0.779919] [ T1] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) # 77.90 [+0.00] [ 0.782291] [ T1] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) # 77.90 [+0.00] [ 0.784156] [ T1] TCP bind hash table entries: 8192 (order: 9, 1179648 bytes, linear) # 77.90 [+0.00] [ 0.786012] [ T1] TCP: Hash tables configured (established 8192 bind 8192) # 77.91 [+0.00] [ 0.787789] [ T1] UDP hash table entries: 512 (order: 5, 131072 bytes, linear) # 77.91 [+0.00] [ 0.789283] [ T1] UDP-Lite hash table entries: 512 (order: 5, 131072 bytes, linear) # 77.91 [+0.00] [ 0.791641] [ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family # 77.91 [+0.00] [ 0.793042] [ T1] pci_bus 0000:00: resource 4 [mem 0xc0000000-0xdfffffff window] # 77.92 [+0.00] [ 0.794526] [ T1] pci_bus 0000:00: resource 5 [mem 0xc000000000000-0xfffffffffffff window] # 77.92 [+0.00] [ 0.796251] [ T1] PCI: CLS 0 bytes, default 64 # 77.92 [+0.00] [ 0.798533] [ T1] kvm_intel: VMX not supported by CPU 2 # 77.92 [+0.00] [ 0.799759] [ T1] kvm_amd: TSC scaling supported # 77.92 [+0.00] [ 0.800711] [ T1] kvm_amd: Nested Virtualization enabled # 77.93 [+0.00] [ 0.801806] [ T1] kvm_amd: Nested Paging enabled # 77.93 [+0.00] [ 0.802758] [ T1] kvm_amd: LBR virtualization supported # 77.93 [+0.00] [ 0.803846] [ T1] kvm_amd: Virtual VMLOAD VMSAVE supported # 77.93 [+0.00] [ 0.804948] [ T1] kvm_amd: Virtual GIF supported # 77.93 [+0.00] [ 0.805902] [ T1] kvm_amd: Virtual NMI enabled # 77.94 [+0.00] [ 0.814414] [ T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x257a3c3232d, max_idle_ns: 440795236700 ns # 77.94 [+0.00] [ 0.828410] [ T1] Initialise system trusted keyrings # 77.94 [+0.00] [ 0.829947] [ T1] workingset: timestamp_bits=56 max_order=18 bucket_order=0 # 77.94 [+0.00] [ 0.844017] [ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher # 77.95 [+0.00] [ 0.845458] [ T1] fuse: init (API version 7.45) # 77.95 [+0.00] [ 0.847152] [ T1] 9p: Installing v9fs 9p2000 file system support # 77.95 [+0.00] [ 0.856820] [ T1] Key type asymmetric registered # 77.95 [+0.00] [ 0.857801] [ T1] Asymmetric key parser 'x509' registered # 77.95 [+0.00] [ 0.859316] [ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) # 77.96 [+0.00] [ 0.861088] [ T1] io scheduler mq-deadline registered # 77.96 [+0.00] [ 0.862138] [ T1] io scheduler kyber registered # 77.96 [+0.00] [ 0.867965] [ T1] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 # 77.96 [+0.00] [ 0.870651] [ T1] ACPI: button: Power Button [PWRB] # 77.97 [+0.00] [ 0.874955] [ T1] virtiofs virtio0: discovered new tag: ROOTFS # 77.97 [+0.00] [ 0.877183] [ T1] virtiofs virtio0: virtio_fs_setup_dax: No cache capability # 77.97 [+0.00] [ 0.882665] [ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled # 77.97 [+0.00] [ 0.885907] [ T1] 00:00: ttyS0 at I/O 0x3f8 (irq = 51, base_baud = 115200) is a 16550A # 77.98 [+0.00] [ 0.971938] [ T1] ACPI: bus type drm_connector registered # 77.98 [+0.00] [ 1.013797] [ T1] loop: module loaded # 77.98 [+0.00] [ 1.027331] [ T1] i8042: PNP: No PS/2 controller found. # 77.98 [+0.00] [ 1.032625] [ T28] printk: legacy console [hvc0] enabled # 77.98 [+0.00] [ 1.033739] [ T28] printk: legacy bootconsole [earlyser0] disabled # 77.99 [+0.00] [ 1.035071] [ T1] rtc_cmos 00:01: registered as rtc0 # 77.99 [+0.00] [ 1.035247] [ T1] rtc_cmos 00:01: setting system clock to 2025-12-09T15:11:55 UTC (1765293115) # 77.99 [+0.00] [ 1.035811] [ T1] rtc_cmos 00:01: alarms up to one day, 242 bytes nvram # 77.99 [+0.00] [ 1.038284] [ T1] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev # 78.00 [+0.00] [ 1.045015] [ T1] NET: Registered PF_INET6 protocol family # 78.00 [+0.00] [ 1.049585] [ T1] Segment Routing with IPv6 # 78.00 [+0.00] [ 1.050057] [ T1] In-situ OAM (IOAM) with IPv6 # 78.00 [+0.00] [ 1.050396] [ T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver # 78.00 [+0.00] [ 1.053861] [ T1] NET: Registered PF_PACKET protocol family # 78.01 [+0.00] [ 1.054070] [ T1] 9pnet: Installing 9P2000 support # 78.01 [+0.00] [ 1.054468] [ T1] Key type dns_resolver registered # 78.01 [+0.00] [ 1.055045] [ T1] NET: Registered PF_VSOCK protocol family # 78.01 [+0.00] [ 1.059442] [ T1] IPI shorthand broadcast: enabled # 78.01 [+0.00] [ 1.167488] [ T1] sched_clock: Marking stable (1136001830, 31200560)->(1265573980, -98371590) # 78.02 [+0.00] [ 1.170419] [ T1] registered taskstats version 1 # 78.02 [+0.00] [ 1.173528] [ T1] Loading compiled-in X.509 certificates # 78.02 [+0.00] [ 1.255794] [ T1] Demotion targets for Node 0: null # 78.02 [+0.00] [ 1.256021] [ T1] kmemleak: Kernel memory leak detector initialized (mem pool available: 12102) # 78.03 [+0.00] [ 1.256242] [ T1] page_owner is disabled # 78.03 [+0.00] [ 1.257264] [ T1] PM: Magic number: 5:919:183 # 78.03 [+0.00] [ 1.257434] [ T1] netconsole: network logging started # 78.03 [+0.00] [ 1.258852] [ T1] ALSA device list: # 78.03 [+0.00] [ 1.259483] [ T1] No soundcards found. # 78.03 [+0.00] [ 1.260616] [ T1] check access for rdinit=/init failed: -2, ignoring # 78.04 [+0.00] [ 1.260767] [ T1] md: Skipping autodetection of RAID arrays. (raid=autodetect will force) # 78.04 [+0.00] [ 1.263159] [ T1] VFS: Mounted root (virtiofs filesystem) readonly on device 0:20. # 78.04 [+0.00] [ 1.263918] [ T1] devtmpfs: mounted # 78.04 [+0.00] [ 1.290569] [ T1] Freeing unused kernel image (initmem) memory: 2428K # 78.05 [+0.00] [ 1.290734] [ T1] Write protecting the kernel read-only data: 55296k # 78.05 [+0.00] [ 1.291530] [ T1] Freeing unused kernel image (text/rodata gap) memory: 1424K # 78.05 [+0.00] [ 1.292046] [ T1] Freeing unused kernel image (rodata/data gap) memory: 1172K # 78.05 [+0.00] [ 1.293522] [ T1] Run /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init as init process # 78.06 [+0.00] [ 1.293718] [ T1] with arguments: # 78.06 [+0.00] [ 1.293808] [ T1] /usr/lib/python3.14/site-packages/virtme/guest/bin/virtme-ng-init # 78.06 [+0.00] [ 1.293974] [ T1] with environment: # 78.06 [+0.00] [ 1.294055] [ T1] HOME=/ # 78.06 [+0.00] [ 1.294142] [ T1] TERM=dumb # 78.07 [+0.00] [ 1.294226] [ T1] virtme_hostname=vmksft-forwarding-dbg,debug-threads=on # 78.07 [+0.00] [ 1.294388] [ T1] nr_open=2147483584 # 78.07 [+0.00] [ 1.294468] [ T1] virtme_link_mods=/srv/vmksft/testing/wt-4/.virtme_mods/lib/modules/0.0.0 # 78.07 [+0.00] [ 1.294660] [ T1] virtme_rw_overlay0=/etc # 78.07 [+0.00] [ 1.294773] [ T1] virtme_rw_overlay1=/lib # 78.08 [+0.00] [ 1.294877] [ T1] virtme_rw_overlay2=/home # 78.08 [+0.00] [ 1.294981] [ T1] virtme_rw_overlay3=/opt # 78.08 [+0.00] [ 1.295084] [ T1] virtme_rw_overlay4=/srv # 78.08 [+0.00] [ 1.295194] [ T1] virtme_rw_overlay5=/usr # 78.08 [+0.00] [ 1.295305] [ T1] virtme_rw_overlay6=/var # 78.08 [+0.00] [ 1.295413] [ T1] virtme_rw_overlay7=/tmp # 78.09 [+0.00] [ 1.295517] [ T1] virtme_console=ttyS0 # 78.09 [+0.00] [ 1.295627] [ T1] virtme_chdir=srv/vmksft/testing/wt-4 # 78.09 [+0.00] [ 1.313147] [ T1] virtme-ng-init: mount devtmpfs -> /dev: EBUSY: Device or resource busy # 78.09 [+0.00] [ 1.322289] [ T1] overlayfs: failed to set xattr on upper # 78.10 [+0.00] [ 1.322480] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.10 [+0.00] [ 1.322655] [ T1] overlayfs: ...falling back to uuid=null. # 78.10 [+0.00] [ 1.324916] [ T1] overlayfs: failed to set xattr on upper # 78.10 [+0.00] [ 1.325055] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.10 [+0.00] [ 1.325501] [ T1] overlayfs: ...falling back to uuid=null. # 78.11 [+0.00] [ 1.327377] [ T1] overlayfs: failed to set xattr on upper # 78.11 [+0.00] [ 1.327514] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.11 [+0.00] [ 1.327670] [ T1] overlayfs: ...falling back to uuid=null. # 78.11 [+0.00] [ 1.329724] [ T1] overlayfs: failed to set xattr on upper # 78.11 [+0.00] [ 1.329862] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.12 [+0.00] [ 1.330021] [ T1] overlayfs: ...falling back to uuid=null. # 78.12 [+0.00] [ 1.331865] [ T1] overlayfs: failed to set xattr on upper # 78.12 [+0.00] [ 1.332002] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.12 [+0.00] [ 1.332155] [ T1] overlayfs: ...falling back to uuid=null. # 78.13 [+0.00] [ 1.334284] [ T1] overlayfs: failed to set xattr on upper # 78.13 [+0.00] [ 1.334421] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.13 [+0.00] [ 1.334587] [ T1] overlayfs: ...falling back to uuid=null. # 78.13 [+0.00] [ 1.336860] [ T1] overlayfs: failed to set xattr on upper # 78.13 [+0.00] [ 1.336993] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.14 [+0.00] [ 1.337155] [ T1] overlayfs: ...falling back to uuid=null. # 78.14 [+0.00] [ 1.339038] [ T1] overlayfs: failed to set xattr on upper # 78.14 [+0.00] [ 1.339172] [ T1] overlayfs: ...falling back to redirect_dir=nofollow. # 78.14 [+0.00] [ 1.339346] [ T1] overlayfs: ...falling back to uuid=null. # 78.14 [+0.00] [ 3.554210] [ T73] systemd-tmpfile (73) used greatest stack depth: 24560 bytes left # 78.15 [+0.00] [ 3.554506] [ T1] virtme-ng-init: Failed to read '/usr/lib/tmpfiles.d/audit.conf': Permission denied # 78.15 [+0.00] Failed to opendir() '/proc/self/fd/3': Permission denied # 78.15 [+0.00] [ 3.616680] [ T75] virtme-ng-init: Starting systemd-udevd version 258.2-1.fc43 # 78.16 [+0.00] [ 3.617006] [ T75] virtme-ng-init: triggering udev coldplug # 78.16 [+0.00] [ 6.230015] [ T75] virtme-ng-init: waiting for udev to settle # 78.16 [+0.00] [ 7.339145] [ T75] virtme-ng-init: udev is done # 78.16 [+0.00] [ 7.342122] [ T1] virtme-ng-init: initialization done # 78.16 [+0.00] [ 9.391307] [ T224] ip (224) used greatest stack depth: 24448 bytes left # 78.17 [+0.00] [ 10.538033] [ T278] 8021q: 802.1Q VLAN Support v1.8 # 78.17 [+0.00] [ 11.804952] [ T330] br1: port 1(vx10) entered blocking state # 78.17 [+0.00] [ 11.805259] [ T330] br1: port 1(vx10) entered disabled state # 78.17 [+0.00] [ 11.805510] [ T330] vx10: entered allmulticast mode # 78.17 [+0.00] [ 11.807073] [ T330] vx10: entered promiscuous mode # 78.17 [+0.00] [ 11.807508] [ T330] br1: port 1(vx10) entered blocking state # 78.18 [+0.00] [ 11.807755] [ T330] br1: port 1(vx10) entered forwarding state # 78.18 [+0.00] [ 11.924008] [ T335] br1: port 2(vx20) entered blocking state # 78.18 [+0.00] [ 11.924236] [ T335] br1: port 2(vx20) entered disabled state # 78.18 [+0.00] [ 11.924655] [ T335] vx20: entered allmulticast mode # 78.18 [+0.00] [ 11.926579] [ T335] vx20: entered promiscuous mode # 78.19 [+0.00] [ 11.927121] [ T335] br1: port 2(vx20) entered blocking state # 78.19 [+0.00] [ 11.927320] [ T335] br1: port 2(vx20) entered forwarding state # 78.19 [+0.00] [ 11.979583] [ T337] br1: port 3(veth1) entered blocking state # 78.19 [+0.00] [ 11.979810] [ T337] br1: port 3(veth1) entered disabled state # 78.19 [+0.00] [ 11.980023] [ T337] veth1: entered allmulticast mode # 78.20 [+0.00] [ 11.982374] [ T337] veth1: entered promiscuous mode # 78.20 [+0.00] [ 12.003618] [ T35] br1: port 3(veth1) entered blocking state # 78.20 [+0.00] [ 12.003921] [ T35] br1: port 3(veth1) entered forwarding state # 78.20 [+0.00] [ 12.107309] [ T342] br1: port 4(veth2) entered blocking state # 78.20 [+0.00] [ 12.107532] [ T342] br1: port 4(veth2) entered disabled state # 78.21 [+0.00] [ 12.107752] [ T342] veth2: entered allmulticast mode # 78.21 [+0.00] [ 12.109672] [ T342] veth2: entered promiscuous mode # 78.21 [+0.00] [ 12.135581] [ T37] br1: port 4(veth2) entered blocking state # 78.21 [+0.00] [ 12.135844] [ T37] br1: port 4(veth2) entered forwarding state # 78.21 [+0.00] [ 13.375249] [ T392] br2: port 1(w1) entered blocking state # 78.22 [+0.00] [ 13.375433] [ T392] br2: port 1(w1) entered disabled state # 78.22 [+0.00] [ 13.375628] [ T392] w1: entered allmulticast mode # 78.22 [+0.00] [ 13.377120] [ T392] w1: entered promiscuous mode # 78.22 [+0.00] [ 13.568405] [ T400] br2: port 2(vx10) entered blocking state # 78.22 [+0.00] [ 13.568632] [ T400] br2: port 2(vx10) entered disabled state # 78.23 [+0.00] [ 13.568852] [ T400] vx10: entered allmulticast mode # 78.23 [+0.00] [ 13.570396] [ T400] vx10: entered promiscuous mode # 78.23 [+0.00] [ 13.570812] [ T400] br2: port 2(vx10) entered blocking state # 78.23 [+0.00] [ 13.571003] [ T400] br2: port 2(vx10) entered forwarding state # 78.23 [+0.00] [ 13.739281] [ T407] br2: port 3(vx20) entered blocking state # 78.24 [+0.00] [ 13.739512] [ T407] br2: port 3(vx20) entered disabled state # 78.24 [+0.00] [ 13.739725] [ T407] vx20: entered allmulticast mode # 78.24 [+0.00] [ 13.741252] [ T407] vx20: entered promiscuous mode # 78.24 [+0.00] [ 13.741620] [ T407] br2: port 3(vx20) entered blocking state # 78.24 [+0.00] [ 13.741823] [ T407] br2: port 3(vx20) entered forwarding state # 78.25 [+0.00] [ 13.923411] [ T38] br2: port 1(w1) entered blocking state # 78.25 [+0.00] [ 13.923795] [ T38] br2: port 1(w1) entered forwarding state # 78.25 [+0.00] [ 14.726876] [ T448] br2: port 1(w1) entered blocking state # 78.25 [+0.00] [ 14.727065] [ T448] br2: port 1(w1) entered disabled state # 78.25 [+0.00] [ 14.727239] [ T448] w1: entered allmulticast mode # 78.26 [+0.00] [ 14.728745] [ T448] w1: entered promiscuous mode # 78.26 [+0.00] [ 14.912667] [ T456] br2: port 2(vx10) entered blocking state # 78.26 [+0.00] [ 14.912893] [ T456] br2: port 2(vx10) entered disabled state # 78.26 [+0.00] [ 14.913094] [ T456] vx10: entered allmulticast mode # 78.26 [+0.00] [ 14.920390] [ T456] vx10: entered promiscuous mode # 78.26 [+0.00] [ 14.920809] [ T456] br2: port 2(vx10) entered blocking state # 78.27 [+0.00] [ 14.921002] [ T456] br2: port 2(vx10) entered forwarding state # 78.27 [+0.00] [ 15.085554] [ T463] br2: port 3(vx20) entered blocking state # 78.27 [+0.00] [ 15.085771] [ T463] br2: port 3(vx20) entered disabled state # 78.27 [+0.00] [ 15.085979] [ T463] vx20: entered allmulticast mode # 78.27 [+0.00] [ 15.087670] [ T463] vx20: entered promiscuous mode # 78.28 [+0.00] [ 15.088043] [ T463] br2: port 3(vx20) entered blocking state # 78.28 [+0.00] [ 15.088245] [ T463] br2: port 3(vx20) entered forwarding state # 78.28 [+0.00] [ 15.265737] [ T38] br2: port 1(w1) entered blocking state # 78.28 [+0.00] [ 15.265937] [ T38] br2: port 1(w1) entered forwarding state # 78.28 [+0.00] [ 23.774398] [ T550] GACT probability NOT on # 78.29 [+0.00] [ 45.123229] [ T590] tc (590) used greatest stack depth: 24080 bytes left # 78.29 [+0.00] [ 126.352226] [ T1353] veth3: entered promiscuous mode # 78.29 [+0.00] [ 149.327838] [ T2280] veth3: left promiscuous mode # 78.29 [+0.00] [ 149.453227] [ T2286] veth3: entered promiscuous mode # 78.29 [+0.00] [ 172.496851] [ T3213] veth3: left promiscuous mode # 78.30 [+0.00] [ 172.752743] [ T3231] vx20: left allmulticast mode # 78.30 [+0.00] [ 172.752928] [ T3231] vx20: left promiscuous mode # 78.30 [+0.00] [ 172.753164] [ T3231] br1: port 2(vx20) entered disabled state # 78.30 [+0.00] [ 172.782251] [ T3232] vx10: left allmulticast mode # 78.30 [+0.00] [ 172.782457] [ T3232] vx10: left promiscuous mode # 78.30 [+0.00] [ 172.782756] [ T3232] br1: port 1(vx10) entered disabled state # 78.31 [+0.00] [ 177.888675] [ T3237] br1: port 1(vx10) entered blocking state # 78.31 [+0.00] [ 177.888907] [ T3237] br1: port 1(vx10) entered disabled state # 78.31 [+0.00] [ 177.889117] [ T3237] vx10: entered allmulticast mode # 78.31 [+0.00] [ 177.890676] [ T3237] vx10: entered promiscuous mode # 78.31 [+0.00] [ 177.891045] [ T3237] br1: port 1(vx10) entered blocking state # 78.32 [+0.00] [ 177.891254] [ T3237] br1: port 1(vx10) entered forwarding state # 78.32 [+0.00] [ 177.935726] [ T3239] br1: port 2(vx20) entered blocking state # 78.32 [+0.00] [ 177.935944] [ T3239] br1: port 2(vx20) entered disabled state # 78.32 [+0.00] [ 177.936141] [ T3239] vx20: entered allmulticast mode # 78.32 [+0.00] [ 177.937638] [ T3239] vx20: entered promiscuous mode # 78.33 [+0.00] [ 177.937994] [ T3239] br1: port 2(vx20) entered blocking state # 78.33 [+0.00] [ 177.938179] [ T3239] br1: port 2(vx20) entered forwarding state # 78.33 [+0.00] [ 288.087992] [ T4067] veth3: entered promiscuous mode # 78.33 [+0.00] [ 311.171611] [ T4994] veth3: left promiscuous mode # 78.33 [+0.00] [ 311.301710] [ T5000] veth3: entered promiscuous mode # 78.34 [+0.00] [ 334.867791] [ T5927] veth3: left promiscuous mode # 78.34 [+0.00] [ 537.456931] [ T12] vx20: left allmulticast mode # 78.34 [+0.00] [ 537.457148] [ T12] vx20: left promiscuous mode # 78.34 [+0.00] [ 537.457424] [ T12] br2: port 3(vx20) entered disabled state # 78.34 [+0.00] [ 537.459787] [ T12] vx10: left allmulticast mode # 78.34 [+0.00] [ 537.459931] [ T12] vx10: left promiscuous mode # 78.35 [+0.00] [ 537.460149] [ T12] br2: port 2(vx10) entered disabled state # 78.35 [+0.00] [ 537.462009] [ T12] w1: left allmulticast mode # 78.35 [+0.00] [ 537.462171] [ T12] w1: left promiscuous mode # 78.35 [+0.00] [ 537.463742] [ T12] br2: port 1(w1) entered disabled state # 78.35 [+0.00] [ 537.596297] [ T12] vx20: left allmulticast mode # 78.36 [+0.00] [ 537.596468] [ T12] vx20: left promiscuous mode # 78.36 [+0.00] [ 537.596707] [ T12] br2: port 3(vx20) entered disabled state # 78.36 [+0.00] [ 537.598040] [ T12] vx10: left allmulticast mode # 78.36 [+0.00] [ 537.598369] [ T12] vx10: left promiscuous mode # 78.36 [+0.00] [ 537.598618] [ T12] br2: port 2(vx10) entered disabled state # 78.36 [+0.00] [ 537.600217] [ T12] w1: left allmulticast mode # 78.37 [+0.00] [ 537.600492] [ T12] w1: left promiscuous mode # 78.37 [+0.00] [ 537.600900] [ T12] br2: port 1(w1) entered disabled state # 78.37 [+0.00] [ 538.369316] [T10491] br1: port 4(veth2) entered disabled state # 78.37 [+0.00] [ 538.413373] [T10492] veth2: left allmulticast mode # 78.37 [+0.00] [ 538.413676] [T10492] veth2: left promiscuous mode # 78.38 [+0.00] [ 538.414085] [T10492] br1: port 4(veth2) entered disabled state # 78.38 [+0.00] [ 538.549629] [T10496] br1: port 3(veth1) entered disabled state # 78.38 [+0.00] [ 538.573238] [T10497] veth1: left allmulticast mode # 78.38 [+0.00] [ 538.573425] [T10497] veth1: left promiscuous mode # 78.38 [+0.00] [ 538.573671] [T10497] br1: port 3(veth1) entered disabled state # 78.38 [+0.00] [ 538.626869] [T10500] vx20: left allmulticast mode # 78.39 [+0.00] [ 538.627049] [T10500] vx20: left promiscuous mode # 78.39 [+0.00] [ 538.627302] [T10500] br1: port 2(vx20) entered disabled state # 78.39 [+0.00] [ 538.752869] [T10504] vx10: left allmulticast mode # 78.39 [+0.00] [ 538.753156] [T10504] vx10: left promiscuous mode # 78.39 [+0.00] [ 538.753587] [T10504] br1: port 1(vx10) entered disabled state # 78.40 [+0.00] [ 548.343776] [T10651] lag2: Mode changed to "loadbalance" # 78.40 [+0.00] [ 548.399426] [T10654] lag2: Port device veth3 added # 78.40 [+0.00] [ 548.487118] [T10657] lag2: Port device veth5 added # 78.40 [+0.00] [ 548.571370] [T10664] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.40 [+0.00] [ 548.608007] [T10666] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.41 [+0.00] [ 548.783581] [T10671] gre: GRE over IPv4 demultiplexer driver # 78.41 [+0.00] [ 548.799559] [T10671] ip_gre: GRE over IPv4 tunneling driver # 78.41 [+0.00] [ 549.369860] [T10697] lag1: Mode changed to "loadbalance" # 78.41 [+0.00] [ 549.431926] [T10699] lag1: Port device veth2 added # 78.41 [+0.00] [ 549.602635] [T10703] lag1: Port device veth4 added # 78.41 [+0.00] [ 549.653197] [T10705] 8021q: adding VLAN 0 to HW filter on device lag1 # 78.42 [+0.00] [ 555.153446] [T10730] Mirror/redirect action on # 78.42 [+0.00] [ 555.222657] [T10732] lag2: Port device veth5 removed # 78.42 [+0.00] [ 558.962027] [T10743] lag2: Port device veth3 removed # 78.42 [+0.00] [ 593.763365] [T10775] lag2: Mode changed to "loadbalance" # 78.42 [+0.00] [ 593.822988] [T10777] lag2: Port device veth3 added # 78.43 [+0.00] [ 593.922312] [T10780] lag2: Port device veth5 added # 78.43 [+0.00] [ 593.966970] [T10782] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.43 [+0.00] [ 593.995402] [T10783] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.43 [+0.00] [ 599.613794] [T10828] lag2: Port device veth3 removed # 78.43 [+0.00] [ 603.300280] [T10838] lag2: Port device veth5 removed # 78.44 [+0.00] [ 637.702235] [T10870] lag2: Mode changed to "loadbalance" # 78.44 [+0.00] [ 637.759902] [T10872] lag2: Port device veth3 added # 78.44 [+0.00] [ 637.845058] [T10875] lag2: Port device veth5 added # 78.44 [+0.00] [ 637.897687] [T10877] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.44 [+0.00] [ 637.926653] [T10878] 8021q: adding VLAN 0 to HW filter on device lag2 # 78.45 [+0.00] [ 643.542607] [T10697] lag1: Port device veth4 removed # 78.45 [+0.00] [ 643.549961] [T10697] lag1: Port device veth2 removed # 78.45 [+0.00] [ 674.839211] [T10941] ip (10941) used greatest stack depth: 24064 bytes left # 78.45 [+0.00] [ 675.004187] [T10870] lag2: Port device veth5 removed # 78.45 [+0.00] [ 675.005867] [T10870] lag2: Port device veth3 removed # 78.46 [+0.00] [ 714.227701] [T11099] ip6_gre: GRE over IPv6 tunneling driver # 78.46 [+0.00] [ 714.288452] [ T60] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.46 [+0.00] [ 714.312474] [ T60] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.46 [+0.00] [ 714.508855] [T11112] br1: port 1(veth1) entered blocking state # 78.46 [+0.00] [ 714.509079] [T11112] br1: port 1(veth1) entered disabled state # 78.47 [+0.00] [ 714.509290] [T11112] veth1: entered allmulticast mode # 78.47 [+0.00] [ 714.510761] [T11112] veth1: entered promiscuous mode # 78.47 [+0.00] [ 714.530368] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.47 [+0.00] [ 714.543497] [ T47] br1: port 1(veth1) entered blocking state # 78.47 [+0.00] [ 714.543700] [ T47] br1: port 1(veth1) entered forwarding state # 78.48 [+0.00] [ 714.564722] [T11114] br1: port 2(veth2) entered blocking state # 78.48 [+0.00] [ 714.564923] [T11114] br1: port 2(veth2) entered disabled state # 78.48 [+0.00] [ 714.565124] [T11114] veth2: entered allmulticast mode # 78.48 [+0.00] [ 714.566835] [T11114] veth2: entered promiscuous mode # 78.48 [+0.00] [ 714.593076] [ T47] br1: port 2(veth2) entered blocking state # 78.49 [+0.00] [ 714.593285] [ T47] br1: port 2(veth2) entered forwarding state # 78.49 [+0.00] [ 714.609309] [ T60] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.49 [+0.00] [ 714.728478] [ T60] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.49 [+0.00] [ 715.033382] [ T12] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.50 [+0.00] [ 715.562432] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.50 [+0.00] [ 715.563297] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.50 [+0.00] [ 715.674304] [ T60] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.50 [+0.00] [ 715.690295] [ T60] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.51 [+0.00] [ 719.593381] [ C1] ip6_tnl_xmit_ctl: 2 callbacks suppressed # 78.51 [+0.00] [ 719.593391] [ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.51 [+0.00] [ 727.401434] [ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.51 [+0.00] [ 731.374644] [ C3] tc mirred to Houston: device gt4 is down # 78.52 [+0.00] [ 731.475498] [ C3] tc mirred to Houston: device gt4 is down # 78.52 [+0.00] [ 731.575917] [ C3] tc mirred to Houston: device gt4 is down # 78.52 [+0.00] [ 731.676346] [ C3] tc mirred to Houston: device gt4 is down # 78.52 [+0.00] [ 731.776753] [ C3] tc mirred to Houston: device gt4 is down # 78.52 [+0.00] [ 731.877159] [ C3] tc mirred to Houston: device gt4 is down # 78.53 [+0.00] [ 731.977609] [ C3] tc mirred to Houston: device gt4 is down # 78.53 [+0.00] [ 732.078035] [ C3] tc mirred to Houston: device gt4 is down # 78.53 [+0.00] [ 732.178505] [ C3] tc mirred to Houston: device gt4 is down # 78.53 [+0.00] [ 732.278958] [ C3] tc mirred to Houston: device gt4 is down # 78.53 [+0.00] [ 738.277640] [ C3] net_ratelimit: 10 callbacks suppressed # 78.54 [+0.00] [ 738.277650] [ C3] tc mirred to Houston: device gt6 is down # 78.54 [+0.00] [ 738.378734] [ C3] tc mirred to Houston: device gt6 is down # 78.54 [+0.00] [ 738.479296] [ C3] tc mirred to Houston: device gt6 is down # 78.54 [+0.00] [ 738.579807] [ C3] tc mirred to Houston: device gt6 is down # 78.54 [+0.00] [ 738.680256] [ C3] tc mirred to Houston: device gt6 is down # 78.55 [+0.00] [ 738.780692] [ C3] tc mirred to Houston: device gt6 is down # 78.55 [+0.00] [ 738.881136] [ C3] tc mirred to Houston: device gt6 is down # 78.55 [+0.00] [ 738.981600] [ C3] tc mirred to Houston: device gt6 is down # 78.55 [+0.00] [ 739.082043] [ C3] tc mirred to Houston: device gt6 is down # 78.55 [+0.00] [ 739.182502] [ C3] tc mirred to Houston: device gt6 is down # 78.56 [+0.00] [ 742.762307] [ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.56 [+0.00] [ 747.242325] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.56 [+0.00] [ 757.223687] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.56 [+0.00] [ 757.324832] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.57 [+0.00] [ 757.425484] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.57 [+0.00] [ 757.526083] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.57 [+0.00] [ 757.626714] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.57 [+0.00] [ 757.727301] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.58 [+0.00] [ 757.827909] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.58 [+0.00] [ 757.928589] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.58 [+0.00] [ 758.029258] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.58 [+0.00] [ 758.129882] [ C2] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.59 [+0.00] [ 773.994346] [ C1] ip6_tnl_xmit_ctl: 11 callbacks suppressed # 78.59 [+0.00] [ 773.994357] [ C1] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.59 [+0.00] [ 786.491629] [ C0] tc mirred: target device is gone # 78.59 [+0.00] [ 812.292305] [T11715] tc (11715) used greatest stack depth: 23824 bytes left # 78.60 [+0.00] [ 824.562555] [T11806] br1: port 1(veth1) entered disabled state # 78.60 [+0.00] [ 824.589393] [T11807] br1: port 2(veth2) entered disabled state # 78.60 [+0.00] [ 824.611009] [T11808] veth2: left allmulticast mode # 78.60 [+0.00] [ 824.611241] [T11808] veth2: left promiscuous mode # 78.60 [+0.00] [ 824.611490] [T11808] br1: port 2(veth2) entered disabled state # 78.60 [+0.00] [ 824.612488] [T11808] veth1: left allmulticast mode # 78.61 [+0.00] [ 824.612681] [T11808] veth1: left promiscuous mode # 78.61 [+0.00] [ 824.612952] [T11808] br1: port 1(veth1) entered disabled state # 78.61 [+0.00] [ 833.077098] [T11946] ip (11946) used greatest stack depth: 23600 bytes left # 78.61 [+0.00] [ 833.206349] [ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.62 [+0.00] [ 833.238688] [ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.62 [+0.00] [ 833.409297] [ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.62 [+0.00] [ 833.424125] [T11964] br1: port 1(veth1) entered blocking state # 78.62 [+0.00] [ 833.424342] [T11964] br1: port 1(veth1) entered disabled state # 78.62 [+0.00] [ 833.424536] [T11964] veth1: entered allmulticast mode # 78.63 [+0.00] [ 833.426031] [T11964] veth1: entered promiscuous mode # 78.63 [+0.00] [ 833.445808] [ T226] br1: port 1(veth1) entered blocking state # 78.63 [+0.00] [ 833.446051] [ T226] br1: port 1(veth1) entered forwarding state # 78.63 [+0.00] [ 833.476657] [T11966] br1: port 2(veth2) entered blocking state # 78.63 [+0.00] [ 833.476896] [T11966] br1: port 2(veth2) entered disabled state # 78.64 [+0.00] [ 833.477160] [T11966] veth2: entered allmulticast mode # 78.64 [+0.00] [ 833.479285] [T11966] veth2: entered promiscuous mode # 78.64 [+0.00] [ 833.508522] [ T226] br1: port 2(veth2) entered blocking state # 78.64 [+0.00] [ 833.508757] [ T226] br1: port 2(veth2) entered forwarding state # 78.64 [+0.00] [ 833.545321] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.65 [+0.00] [ 833.639331] [ T9] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.65 [+0.00] [ 833.837832] [T11984] br2: port 1(veth4.555) entered blocking state # 78.65 [+0.00] [ 833.838092] [T11984] br2: port 1(veth4.555) entered disabled state # 78.65 [+0.00] [ 833.838369] [T11984] veth4.555: entered allmulticast mode # 78.66 [+0.00] [ 833.838562] [T11984] veth4: entered allmulticast mode # 78.66 [+0.00] [ 833.840142] [T11984] veth4.555: entered promiscuous mode # 78.66 [+0.00] [ 833.840393] [T11984] veth4: entered promiscuous mode # 78.66 [+0.00] [ 833.841029] [T11984] br2: port 1(veth4.555) entered blocking state # 78.66 [+0.00] [ 833.841281] [T11984] br2: port 1(veth4.555) entered forwarding state # 78.67 [+0.00] [ 833.889311] [ T9] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.67 [+0.00] [ 834.345343] [ T12] ip6_tunnel: gt6 xmit: Local address not yet configured! # 78.67 [+0.00] [ 834.602297] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.67 [+0.00] [ 834.602666] [ T12] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.67 [+0.00] [ 834.969292] [ T9] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.68 [+0.00] [ 839.017406] [ C0] ip6_tnl_xmit_ctl: 3 callbacks suppressed # 78.68 [+0.00] [ 839.017416] [ C0] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.68 [+0.00] [ 847.209341] [ C0] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.68 [+0.00] [ 863.593339] [ C0] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.69 [+0.00] [ 877.260043] [T12272] br2: port 1(veth4.555) entered disabled state # 78.69 [+0.00] [ 881.707460] [T12294] br2: port 1(veth4.555) entered forwarding state # 78.69 [+0.00] [ 889.765461] [T12354] br2: port 1(veth4.555) entered disabled state # 78.69 [+0.00] [ 894.196762] [T12376] br2: port 1(veth4.555) entered forwarding state # 78.70 [+0.00] [ 898.409543] [ C0] ip6_tunnel: h3-gt6 xmit: Local address not yet configured! # 78.70 [+0.00] [ 898.749658] [T12407] veth4.555: left allmulticast mode # 78.70 [+0.00] [ 898.749834] [T12407] veth4: left allmulticast mode # 78.70 [+0.00] [ 898.749992] [T12407] veth4.555: left promiscuous mode # 78.70 [+0.00] [ 898.750132] [T12407] veth4: left promiscuous mode # 78.71 [+0.00] [ 898.750502] [T12407] br2: port 1(veth4.555) entered disabled state # 78.71 [+0.00] [ 898.974074] [T12412] br1: port 1(veth1) entered disabled state # 78.71 [+0.00] [ 899.006069] [T12413] br1: port 2(veth2) entered disabled state # 78.71 [+0.00] [ 899.027805] [T12414] veth2: left allmulticast mode # 78.71 [+0.00] [ 899.027969] [T12414] veth2: left promiscuous mode # 78.71 [+0.00] [ 899.028194] [T12414] br1: port 2(veth2) entered disabled state # 78.72 [+0.00] [ 899.029101] [T12414] veth1: left allmulticast mode # 78.72 [+0.00] [ 899.029254] [T12414] veth1: left promiscuous mode # 78.72 [+0.00] [ 899.029473] [T12414] br1: port 1(veth1) entered disabled state # 78.72 [+0.00] [ 907.488842] [T12550] br1: port 1(veth1) entered blocking state # 78.72 [+0.00] [ 907.489115] [T12550] br1: port 1(veth1) entered disabled state # 78.73 [+0.00] [ 907.489396] [T12550] veth1: entered allmulticast mode # 78.73 [+0.00] [ 907.491000] [T12550] veth1: entered promiscuous mode # 78.73 [+0.00] [ 907.517592] [T10939] br1: port 1(veth1) entered blocking state # 78.73 [+0.00] [ 907.517844] [T10939] br1: port 1(veth1) entered forwarding state # 78.73 [+0.00] [ 915.163530] [T12603] veth1: left allmulticast mode # 78.74 [+0.00] [ 915.163730] [T12603] veth1: left promiscuous mode # 78.74 [+0.00] [ 915.163970] [T12603] br1: port 1(veth1) entered disabled state # 78.74 [+0.00] [ 917.216284] [T12605] br1: port 1(veth1) entered blocking state # 78.74 [+0.00] [ 917.216507] [T12605] br1: port 1(veth1) entered disabled state # 78.74 [+0.00] [ 917.216719] [T12605] veth1: entered allmulticast mode # 78.75 [+0.00] [ 917.218218] [T12605] veth1: entered promiscuous mode # 78.75 [+0.00] [ 917.218621] [T12605] br1: port 1(veth1) entered blocking state # 78.75 [+0.00] [ 917.218813] [T12605] br1: port 1(veth1) entered forwarding state # 78.75 [+0.00] [ 936.026134] [T12712] veth1: left allmulticast mode # 78.75 [+0.00] [ 936.026696] [T12712] veth1: left promiscuous mode # 78.75 [+0.00] [ 936.026996] [T12712] br1: port 1(veth1) entered disabled state # 78.76 [+0.00] [ 938.101749] [T12715] br1: port 1(veth1) entered blocking state # 78.76 [+0.00] [ 938.101980] [T12715] br1: port 1(veth1) entered disabled state # 78.76 [+0.00] [ 938.102190] [T12715] veth1: entered allmulticast mode # 78.76 [+0.00] [ 938.103728] [T12715] veth1: entered promiscuous mode # 78.76 [+0.00] [ 938.104023] [T12715] br1: port 1(veth1) entered blocking state # 78.77 [+0.00] [ 938.104218] [T12715] br1: port 1(veth1) entered forwarding state # 78.77 [+0.00] [ 940.504701] [T12756] br1: port 1(veth1) entered disabled state # 78.77 [+0.00] [ 940.524535] [T12757] veth1: left allmulticast mode # 78.77 [+0.00] [ 940.524707] [T12757] veth1: left promiscuous mode # 78.77 [+0.00] [ 940.524949] [T12757] br1: port 1(veth1) entered disabled state # 78.78 [+0.00] [ 980.804998] [T13213] br1: port 1(veth1.100) entered blocking state # 78.78 [+0.00] [ 980.805904] [T13213] br1: port 1(veth1.100) entered disabled state # 78.78 [+0.00] [ 980.806105] [T13213] veth1.100: entered allmulticast mode # 78.78 [+0.00] [ 980.806247] [T13213] veth1: entered allmulticast mode # 78.78 [+0.00] [ 980.807754] [T13213] veth1.100: entered promiscuous mode # 78.79 [+0.00] [ 980.807900] [T13213] veth1: entered promiscuous mode # 78.79 [+0.00] [ 980.883208] [T13216] br1: port 1(veth1.100) entered blocking state # 78.79 [+0.00] [ 980.883492] [T13216] br1: port 1(veth1.100) entered forwarding state # 78.79 [+0.00] [ 981.061260] [T13226] br2: port 1(veth1.200) entered blocking state # 78.80 [+0.00] [ 981.061472] [T13226] br2: port 1(veth1.200) entered disabled state # 78.80 [+0.00] [ 981.061665] [T13226] veth1.200: entered allmulticast mode # 78.80 [+0.00] [ 981.063411] [T13226] veth1.200: entered promiscuous mode # 78.80 [+0.00] [ 981.140792] [T13229] br2: port 1(veth1.200) entered blocking state # 78.80 [+0.00] [ 981.141009] [T13229] br2: port 1(veth1.200) entered forwarding state # 78.81 [+0.00] [ 990.885880] [T13290] veth1.100: left allmulticast mode # 78.81 [+0.00] [ 990.886122] [T13290] veth1.100: left promiscuous mode # 78.81 [+0.00] [ 990.887139] [T13290] br1: port 1(veth1.100) entered disabled state # 78.81 [+0.00] [ 990.914152] [T13291] veth1.200: left allmulticast mode # 78.81 [+0.00] [ 990.914323] [T13291] veth1: left allmulticast mode # 78.81 [+0.00] [ 990.914486] [T13291] veth1.200: left promiscuous mode # 78.82 [+0.00] [ 990.914626] [T13291] veth1: left promiscuous mode # 78.82 [+0.00] [ 990.914964] [T13291] br2: port 1(veth1.200) entered disabled state # 78.82 [+0.00] [ 992.969161] [T13293] br2: port 1(veth1.200) entered blocking state # 78.82 [+0.00] [ 992.969452] [T13293] br2: port 1(veth1.200) entered disabled state # 78.82 [+0.00] [ 992.969727] [T13293] veth1.200: entered allmulticast mode # 78.83 [+0.00] [ 992.969915] [T13293] veth1: entered allmulticast mode # 78.83 [+0.00] [ 992.971690] [T13293] veth1.200: entered promiscuous mode # 78.83 [+0.00] [ 992.971890] [T13293] veth1: entered promiscuous mode # 78.83 [+0.00] [ 992.972525] [T13293] br2: port 1(veth1.200) entered blocking state # 78.83 [+0.00] [ 992.972752] [T13293] br2: port 1(veth1.200) entered forwarding state # 78.84 [+0.00] [ 992.991396] [T13294] br1: port 1(veth1.100) entered blocking state # 78.84 [+0.00] [ 992.991600] [T13294] br1: port 1(veth1.100) entered disabled state # 78.84 [+0.00] [ 992.991801] [T13294] veth1.100: entered allmulticast mode # 78.84 [+0.00] [ 993.001079] [T13294] veth1.100: entered promiscuous mode # 78.85 [+0.00] [ 993.001612] [T13294] br1: port 1(veth1.100) entered blocking state # 78.85 [+0.00] [ 993.001798] [T13294] br1: port 1(veth1.100) entered forwarding state # 78.85 [+0.00] [ 997.498464] [T13346] veth1.200: left allmulticast mode # 78.85 [+0.00] [ 997.498667] [T13346] veth1.200: left promiscuous mode # 78.85 [+0.00] [ 997.499038] [T13346] br2: port 1(veth1.200) entered disabled state # 78.86 [+0.00] [ 997.675974] [T13351] veth1.100: left allmulticast mode # 78.86 [+0.00] [ 997.676160] [T13351] veth1: left allmulticast mode # 78.86 [+0.00] [ 997.676332] [T13351] veth1.100: left promiscuous mode # 78.86 [+0.00] [ 997.676480] [T13351] veth1: left promiscuous mode # 78.86 [+0.00] [ 997.676839] [T13351] br1: port 1(veth1.100) entered disabled state # 78.86 [+0.00] [ 1006.884302] [T13526] br1: port 1(vx100) entered blocking state # 78.87 [+0.00] [ 1006.884580] [T13526] br1: port 1(vx100) entered disabled state # 78.87 [+0.00] [ 1006.884835] [T13526] vx100: entered allmulticast mode # 78.87 [+0.00] [ 1006.887037] [T13526] vx100: entered promiscuous mode # 78.87 [+0.00] [ 1006.887477] [T13526] br1: port 1(vx100) entered blocking state # 78.87 [+0.00] [ 1006.887719] [T13526] br1: port 1(vx100) entered forwarding state # 78.88 [+0.00] [ 1006.948776] [T13528] br1: port 2(veth1) entered blocking state # 78.88 [+0.00] [ 1006.948990] [T13528] br1: port 2(veth1) entered disabled state # 78.88 [+0.00] [ 1006.949194] [T13528] veth1: entered allmulticast mode # 78.88 [+0.00] [ 1006.950674] [T13528] veth1: entered promiscuous mode # 78.88 [+0.00] [ 1006.972690] [ T93] br1: port 2(veth1) entered blocking state # 78.89 [+0.00] [ 1006.972896] [ T93] br1: port 2(veth1) entered forwarding state # 78.89 [+0.00] [ 1007.016378] [T13531] br1: port 3(veth2) entered blocking state # 78.89 [+0.00] [ 1007.016592] [T13531] br1: port 3(veth2) entered disabled state # 78.89 [+0.00] [ 1007.016797] [T13531] veth2: entered allmulticast mode # 78.89 [+0.00] [ 1007.019551] [T13531] veth2: entered promiscuous mode # 78.90 [+0.00] [ 1007.051579] [ T93] br1: port 3(veth2) entered blocking state # 78.90 [+0.00] [ 1007.051778] [ T93] br1: port 3(veth2) entered forwarding state # 78.90 [+0.00] [ 1008.174847] [T13586] br2: port 1(w1) entered blocking state # 78.90 [+0.00] [ 1008.175036] [T13586] br2: port 1(w1) entered disabled state # 78.90 [+0.00] [ 1008.175235] [T13586] w1: entered allmulticast mode # 78.91 [+0.00] [ 1008.177012] [T13586] w1: entered promiscuous mode # 78.91 [+0.00] [ 1008.341617] [T13593] br2: port 2(vx100) entered blocking state # 78.91 [+0.00] [ 1008.341881] [T13593] br2: port 2(vx100) entered disabled state # 78.91 [+0.00] [ 1008.342136] [T13593] vx100: entered allmulticast mode # 78.91 [+0.00] [ 1008.344345] [T13593] vx100: entered promiscuous mode # 78.92 [+0.00] [ 1008.344779] [T13593] br2: port 2(vx100) entered blocking state # 78.92 [+0.00] [ 1008.345013] [T13593] br2: port 2(vx100) entered forwarding state # 78.92 [+0.00] [ 1008.536710] [T10939] br2: port 1(w1) entered blocking state # 78.92 [+0.00] [ 1008.536946] [T10939] br2: port 1(w1) entered forwarding state # 78.92 [+0.00] [ 1009.337996] [T13633] br2: port 1(w1) entered blocking state # 78.93 [+0.00] [ 1009.338183] [T13633] br2: port 1(w1) entered disabled state # 78.93 [+0.00] [ 1009.338374] [T13633] w1: entered allmulticast mode # 78.93 [+0.00] [ 1009.339839] [T13633] w1: entered promiscuous mode # 78.93 [+0.00] [ 1009.499626] [T13640] br2: port 2(vx100) entered blocking state # 78.93 [+0.00] [ 1009.499847] [T13640] br2: port 2(vx100) entered disabled state # 78.94 [+0.00] [ 1009.500042] [T13640] vx100: entered allmulticast mode # 78.94 [+0.00] [ 1009.501535] [T13640] vx100: entered promiscuous mode # 78.94 [+0.00] [ 1009.501899] [T13640] br2: port 2(vx100) entered blocking state # 78.94 [+0.00] [ 1009.502083] [T13640] br2: port 2(vx100) entered forwarding state # 78.94 [+0.00] [ 1009.688805] [T10939] br2: port 1(w1) entered blocking state # 78.95 [+0.00] [ 1009.689034] [T10939] br2: port 1(w1) entered forwarding state # 78.95 [+0.00] [ 1019.118629] [ T12] vx100: left allmulticast mode # 78.95 [+0.00] [ 1019.118816] [ T12] vx100: left promiscuous mode # 78.95 [+0.00] [ 1019.119054] [ T12] br2: port 2(vx100) entered disabled state # 78.95 [+0.00] [ 1019.126259] [ T12] w1: left allmulticast mode # 78.96 [+0.00] [ 1019.126421] [ T12] w1: left promiscuous mode # 78.96 [+0.00] [ 1019.126653] [ T12] br2: port 1(w1) entered disabled state # 78.96 [+0.00] [ 1019.273996] [ T12] vx100: left allmulticast mode # 78.96 [+0.00] [ 1019.274171] [ T12] vx100: left promiscuous mode # 78.96 [+0.00] [ 1019.274408] [ T12] br2: port 2(vx100) entered disabled state # 78.96 [+0.00] [ 1019.276183] [ T12] w1: left allmulticast mode # 78.97 [+0.00] [ 1019.276388] [ T12] w1: left promiscuous mode # 78.97 [+0.00] [ 1019.276614] [ T12] br2: port 1(w1) entered disabled state # 78.97 [+0.00] [ 1019.831822] [T13762] br1: port 3(veth2) entered disabled state # 78.97 [+0.00] [ 1019.859849] [T13763] veth2: left allmulticast mode # 78.97 [+0.00] [ 1019.860026] [T13763] veth2: left promiscuous mode # 78.98 [+0.00] [ 1019.860273] [T13763] br1: port 3(veth2) entered disabled state # 78.98 [+0.00] [ 1019.901725] [T13765] br1: port 2(veth1) entered disabled state # 78.98 [+0.00] [ 1019.926490] [T13766] veth1: left allmulticast mode # 78.98 [+0.00] [ 1019.926658] [T13766] veth1: left promiscuous mode # 78.98 [+0.00] [ 1019.926890] [T13766] br1: port 2(veth1) entered disabled state # 78.99 [+0.00] [ 1019.955031] [T13767] vx100: left allmulticast mode # 78.99 [+0.00] [ 1019.955194] [T13767] vx100: left promiscuous mode # 78.99 [+0.00] [ 1019.955432] [T13767] br1: port 1(vx100) entered disabled state # 78.99 [+0.00] [ 1071.951033] [ C0] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 1548822617 wd_nsec: 1548822560 # 78.99 [+0.00] [ 1096.417129] [ C0] watchdog: BUG: soft lockup - CPU#0 stuck for 21s! [kworker/0:1:10] # 79.00 [+0.00] [ 1096.417139] [ C0] Modules linked in: act_skbedit act_ct nf_flow_table nf_tables nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 dummy ip6_gre ip6_tunnel tunnel6 cls_matchall act_mirred ip_gre gre act_gact cls_flower vxlan ip6_udp_tunnel udp_tunnel bridge stp llc 8021q sch_ingress vrf veth # 79.01 [+0.01] [ 1096.417161] [ C0] irq event stamp: 464675 # 79.01 [+0.00] [ 1096.417163] [ C0] hardirqs last enabled at (464674): [] irqentry_exit+0xf9/0x4d0 # 79.01 [+0.00] [ 1096.417171] [ C0] hardirqs last disabled at (464675): [] sysvec_apic_timer_interrupt+0x12/0xf0 # 79.01 [+0.00] [ 1096.417173] [ C0] softirqs last enabled at (0): [] copy_process+0x1714/0x5710 # 79.02 [+0.00] [ 1096.417178] [ C0] softirqs last disabled at (369): [] irq_exit_rcu+0xa2/0xf0 # 79.02 [+0.00] [ 1096.417184] [ C0] CPU: 0 UID: 0 PID: 10 Comm: kworker/0:1 Not tainted 6.18.0-virtme #1 PREEMPT(full) # 79.02 [+0.00] [ 1096.417187] [ C0] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011 # 79.03 [+0.00] [ 1096.417190] [ C0] Workqueue: 0x0 (events) # 79.03 [+0.00] [ 1096.417197] [ C0] RIP: 0010:unwind_next_frame+0x4/0x1cc0 # 79.03 [+0.00] [ 1096.417201] [ C0] Code: 0c 24 e9 14 ff ff ff 48 89 04 24 e8 a6 05 96 00 48 8b 04 24 eb 88 e8 9b 05 96 00 e9 5f ff ff ff 66 0f 1f 44 00 00 f3 0f 1e fa <0f> 1f 44 00 00 48 ba 00 00 00 00 00 fc ff df 41 57 41 56 41 55 49 # 79.04 [+0.01] [ 1096.417203] [ C0] RSP: 0018:ffa0000000007998 EFLAGS: 00000206 # 79.04 [+0.00] [ 1096.417205] [ C0] RAX: 1ff4000000000f47 RBX: ffa0000000007a90 RCX: ffa0000000007a98 # 79.04 [+0.00] [ 1096.417206] [ C0] RDX: ffa0000000008000 RSI: ffffffff8e992dd1 RDI: ffa00000000079f0 # 79.04 [+0.00] [ 1096.417207] [ C0] RBP: dffffc0000000000 R08: 0000000000000001 R09: ffffffff8f8c025c # 79.05 [+0.00] [ 1096.417207] [ C0] R10: 0000000000000000 R11: 0000000000000010 R12: fff3fc0000000f40 # 79.05 [+0.00] [ 1096.417208] [ C0] R13: fff3fc0000000f3f R14: ffa0000000007a38 R15: ffa00000000079f0 # 79.05 [+0.00] [ 1096.417211] [ C0] FS: 0000000000000000(0000) GS:ff110000a50ed000(0000) knlGS:0000000000000000 # 79.06 [+0.00] [ 1096.417214] [ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 # 79.06 [+0.00] [ 1096.417216] [ C0] CR2: 000055585e8d2120 CR3: 000000000fd3a003 CR4: 0000000000771ef0 # 79.06 [+0.00] [ 1096.417217] [ C0] PKRU: 55555554 # 79.06 [+0.00] [ 1096.417217] [ C0] Call Trace: # 79.06 [+0.00] [ 1096.417219] [ C0] # 79.06 [+0.00] [ 1096.417221] [ C0] __unwind_start+0x3f6/0x8c0 # 79.07 [+0.00] [ 1096.417226] [ C0] ? write_profile+0xf0/0xf0 # 79.07 [+0.00] [ 1096.417230] [ C0] arch_stack_walk+0x76/0x100 # 79.07 [+0.00] [ 1096.417235] [ C0] ? arch_stack_walk+0x76/0x100 # 79.07 [+0.00] [ 1096.417239] [ C0] stack_trace_save+0x93/0xc0 # 79.07 [+0.00] [ 1096.417241] [ C0] ? stack_trace_snprint+0xd0/0xd0 # 79.07 [+0.00] [ 1096.417244] [ C0] ? __lock_acquire+0x577/0xc10 # 79.08 [+0.00] [ 1096.417248] [ C0] kasan_save_stack+0x30/0x50 # 79.08 [+0.00] [ 1096.417267] [ C0] kasan_save_track+0x14/0x30 # 79.08 [+0.00] [ 1096.417269] [ C0] __kasan_save_free_info+0x3b/0x60 # 79.08 [+0.00] [ 1096.417270] [ C0] __kasan_slab_free+0x43/0x70 # 79.08 [+0.00] [ 1096.417273] [ C0] kmem_cache_free+0xfe/0x5e0 # 79.08 [+0.00] [ 1096.417277] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.09 [+0.00] [ 1096.417279] [ C0] ? rcu_do_batch+0x28b/0xfe0 # 79.09 [+0.00] [ 1096.417281] [ C0] ? rcu_do_batch+0x35a/0xfe0 # 79.09 [+0.00] [ 1096.417282] [ C0] ? rcu_do_batch+0x289/0xfe0 # 79.09 [+0.00] [ 1096.417284] [ C0] ? rcu_do_batch+0x28b/0xfe0 # 79.09 [+0.00] [ 1096.417286] [ C0] rcu_do_batch+0x28b/0xfe0 # 79.09 [+0.00] [ 1096.417291] [ C0] ? trace_rcu_batch_end+0x270/0x270 # 79.10 [+0.00] [ 1096.417293] [ C0] ? __lock_release.isra.0+0x59/0x170 # 79.10 [+0.00] [ 1096.417295] [ C0] ? mark_held_locks+0x40/0x70 # 79.10 [+0.00] [ 1096.417299] [ C0] rcu_core+0x2b4/0x5f0 # 79.10 [+0.00] [ 1096.417302] [ C0] handle_softirqs+0x1d7/0x840 # 79.10 [+0.00] [ 1096.417307] [ C0] ? tasklet_unlock_wait+0x60/0x60 # 79.11 [+0.00] [ 1096.417309] [ C0] ? do_raw_spin_unlock+0x59/0x250 # 79.11 [+0.00] [ 1096.417313] [ C0] irq_exit_rcu+0xa2/0xf0 # 79.11 [+0.00] [ 1096.417315] [ C0] common_interrupt+0xc9/0x100 # 79.11 [+0.00] [ 1096.417317] [ C0] # 79.11 [+0.00] [ 1096.417318] [ C0] # 79.11 [+0.00] [ 1096.417320] [ C0] asm_common_interrupt+0x26/0x40 # 79.12 [+0.00] [ 1096.417323] [ C0] RIP: 0010:_raw_spin_unlock_irqrestore+0x36/0x80 # 79.12 [+0.00] [ 1096.417325] [ C0] Code: f5 53 48 8b 74 24 10 48 89 fb 48 83 c7 18 e8 21 82 e3 fd 48 89 df e8 c9 cd e3 fd f7 c5 00 02 00 00 75 1f 9c 58 f6 c4 02 75 2f 01 00 00 00 e8 30 5b d7 fd 65 8b 05 d9 c1 09 02 85 c0 74 12 5b # 79.12 [+0.01] [ 1096.417327] [ C0] RSP: 0018:ffa00000000a7b70 EFLAGS: 00000246 # 79.13 [+0.00] [ 1096.417328] [ C0] RAX: 0000000000000082 RBX: ff110000010327c0 RCX: ffffffff8e096e63 # 79.13 [+0.00] [ 1096.417329] [ C0] RDX: ff11000001a50040 RSI: ffffffff8e9a9aaa RDI: ffffffff8e467200 # 79.13 [+0.00] [ 1096.417329] [ C0] RBP: 0000000000000286 R08: 0000000000000000 R09: 0000000000000001 # 79.13 [+0.00] [ 1096.417330] [ C0] R10: 0000000000000000 R11: ff110000118e56e0 R12: ff110000100851c0 # 79.14 [+0.00] [ 1096.417331] [ C0] R13: 0000000000000000 R14: ffa00000000a7bb8 R15: ff1100000954f6c0 # 79.14 [+0.00] [ 1096.417334] [ C0] ? _raw_spin_unlock_irqrestore+0x53/0x80 # 79.14 [+0.00] [ 1096.417339] [ C0] qlist_free_all+0x47/0xe0 # 79.14 [+0.00] [ 1096.417342] [ C0] kasan_quarantine_reduce+0x196/0x240 # 79.14 [+0.00] [ 1096.417345] [ C0] __kasan_slab_alloc+0x4b/0x70 # 79.15 [+0.00] [ 1096.417348] [ C0] __kmalloc_cache_node_noprof+0x230/0x720 # 79.15 [+0.00] [ 1096.417351] [ C0] ? lockdep_hardirqs_on+0x84/0x130 # 79.15 [+0.00] [ 1096.417354] [ C0] ? create_worker+0xfe/0x6f0 # 79.15 [+0.00] [ 1096.417356] [ C0] create_worker+0xfe/0x6f0 # 79.15 [+0.00] [ 1096.417359] [ C0] ? worker_enter_idle+0x6a0/0x6a0 # 79.16 [+0.00] [ 1096.417361] [ C0] ? add_timer_on+0x4d0/0x4d0 # 79.16 [+0.00] [ 1096.417365] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.16 [+0.00] [ 1096.417368] [ C0] worker_thread+0x741/0xd40 # 79.16 [+0.00] [ 1096.417375] [ C0] ? process_one_work+0x1390/0x1390 # 79.16 [+0.00] [ 1096.417376] [ C0] kthread+0x355/0x5b0 # 79.16 [+0.00] [ 1096.417379] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.17 [+0.00] [ 1096.417380] [ C0] ? __lock_release.isra.0+0x59/0x170 # 79.17 [+0.00] [ 1096.417383] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.17 [+0.00] [ 1096.417384] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.17 [+0.00] [ 1096.417386] [ C0] ret_from_fork+0x3fb/0x510 # 79.17 [+0.00] [ 1096.417389] [ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 # 79.18 [+0.00] [ 1096.417393] [ C0] ? __switch_to+0x602/0xd00 # 79.18 [+0.00] [ 1096.417396] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.18 [+0.00] [ 1096.417398] [ C0] ret_from_fork_asm+0x11/0x20 # 79.18 [+0.00] [ 1096.417406] [ C0] # 79.18 [+0.00] [ 1099.936253] [ C0] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: # 79.18 [+0.00] [ 1099.936541] [ C0] rcu: Tasks blocked on level-0 rcu_node (CPUs 0-3): P9/1:b..l # 79.19 [+0.00] [ 1099.936924] [ C0] rcu: (detected by 0, t=26002 jiffies, g=300221, q=1179 ncpus=4) # 79.19 [+0.00] [ 1099.937165] [ C0] task:kworker/0:0 state:R running task stack:24400 pid:9 tgid:9 ppid:2 task_flags:0x4208060 flags:0x00080000 # 79.19 [+0.00] [ 1099.937785] [ C0] Workqueue: events free_obj_work # 79.20 [+0.00] [ 1099.937957] [ C0] Call Trace: # 79.20 [+0.00] [ 1099.938092] [ C0] # 79.20 [+0.00] [ 1099.938178] [ C0] __schedule+0xae2/0x1720 # 79.20 [+0.00] [ 1099.938350] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.20 [+0.00] [ 1099.938513] [ C0] ? io_schedule_timeout+0x130/0x130 # 79.20 [+0.00] [ 1099.938675] [ C0] ? mark_held_locks+0x40/0x70 # 79.21 [+0.00] [ 1099.938838] [ C0] preempt_schedule_irq+0x51/0xa0 # 79.21 [+0.00] [ 1099.939005] [ C0] irqentry_exit+0xf4/0x4d0 # 79.21 [+0.00] [ 1099.939172] [ C0] ? common_interrupt+0xd6/0x100 # 79.21 [+0.00] [ 1099.939333] [ C0] asm_common_interrupt+0x26/0x40 # 79.21 [+0.00] [ 1099.939494] [ C0] RIP: 0010:unwind_next_frame+0x132c/0x1cc0 # 79.21 [+0.00] [ 1099.939708] [ C0] Code: fc ff df 49 8d 78 02 48 89 f8 48 c1 e8 03 0f b6 0c 10 49 8d 40 03 48 89 c6 48 c1 ee 03 0f b6 14 16 48 89 fe 83 e6 07 40 38 f1 <40> 0f 9e c6 84 c9 0f 95 c1 40 84 ce 0f 85 a5 06 00 00 83 e0 07 38 # 79.22 [+0.01] [ 1099.940518] [ C0] RSP: 0018:ffa0000000097600 EFLAGS: 00000246 # 79.22 [+0.00] [ 1099.940725] [ C0] RAX: ffffffff8fb499e9 RBX: 1ff4000000012ec9 RCX: 0000000000000000 # 79.23 [+0.00] [ 1099.940970] [ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff8fb499e8 # 79.23 [+0.00] [ 1099.941222] [ C0] RBP: 0000000000000001 R08: ffffffff8fb499e6 R09: ffffffff8f8cf378 # 79.23 [+0.00] [ 1099.941466] [ C0] R10: ffffffff8fb499ea R11: 0000000000000000 R12: ffffffff8fb499eb # 79.23 [+0.00] [ 1099.941711] [ C0] R13: ffa0000000097700 R14: ffa0000000097eb0 R15: ff11000001a4c540 # 79.24 [+0.00] [ 1099.941962] [ C0] ? kthread+0x355/0x5b0 # 79.24 [+0.00] [ 1099.942090] [ C0] ? stack_access_ok+0x1d0/0x1d0 # 79.24 [+0.00] [ 1099.942253] [ C0] ? __unwind_start+0x3f6/0x8c0 # 79.24 [+0.00] [ 1099.942415] [ C0] ? write_profile+0xf0/0xf0 # 79.24 [+0.00] [ 1099.942576] [ C0] arch_stack_walk+0x9b/0x100 # 79.24 [+0.00] [ 1099.942744] [ C0] ? ret_from_fork+0x3fb/0x510 # 79.25 [+0.00] [ 1099.942905] [ C0] stack_trace_save+0x93/0xc0 # 79.25 [+0.00] [ 1099.943069] [ C0] ? stack_trace_snprint+0xd0/0xd0 # 79.25 [+0.00] [ 1099.943229] [ C0] ? rcu_read_lock_any_held+0x66/0x90 # 79.25 [+0.00] [ 1099.943395] [ C0] kasan_save_stack+0x30/0x50 # 79.25 [+0.00] [ 1099.943556] [ C0] ? kasan_save_stack+0x30/0x50 # 79.26 [+0.00] [ 1099.943714] [ C0] ? kasan_save_track+0x14/0x30 # 79.26 [+0.00] [ 1099.943876] [ C0] ? __kasan_save_free_info+0x3b/0x60 # 79.26 [+0.00] [ 1099.944041] [ C0] ? __kasan_slab_free+0x43/0x70 # 79.26 [+0.00] [ 1099.944205] [ C0] ? kmem_cache_free+0xfe/0x5e0 # 79.26 [+0.00] [ 1099.944365] [ C0] ? free_object_list.isra.0+0xf7/0x2e0 # 79.26 [+0.00] [ 1099.944525] [ C0] ? free_obj_work+0x1a6/0x410 # 79.27 [+0.00] [ 1099.944685] [ C0] ? process_one_work+0xd57/0x1390 # 79.27 [+0.00] [ 1099.944844] [ C0] ? worker_thread+0x4d6/0xd40 # 79.27 [+0.00] [ 1099.945004] [ C0] ? kthread+0x355/0x5b0 # 79.27 [+0.00] [ 1099.945145] [ C0] kasan_save_track+0x14/0x30 # 79.27 [+0.00] [ 1099.945304] [ C0] __kasan_save_free_info+0x3b/0x60 # 79.28 [+0.00] [ 1099.945464] [ C0] __kasan_slab_free+0x43/0x70 # 79.28 [+0.00] [ 1099.945623] [ C0] kmem_cache_free+0xfe/0x5e0 # 79.28 [+0.00] [ 1099.945785] [ C0] ? free_object_list.isra.0+0xf7/0x2e0 # 79.28 [+0.00] [ 1099.945945] [ C0] ? find_held_lock+0x2b/0x80 # 79.28 [+0.00] [ 1099.946111] [ C0] ? free_object_list.isra.0+0xf7/0x2e0 # 79.28 [+0.00] [ 1099.946275] [ C0] free_object_list.isra.0+0xf7/0x2e0 # 79.29 [+0.00] [ 1099.946436] [ C0] free_obj_work+0x1a6/0x410 # 79.29 [+0.00] [ 1099.946596] [ C0] ? process_one_work+0xd16/0x1390 # 79.29 [+0.00] [ 1099.946753] [ C0] ? object_cpu_offline+0x350/0x350 # 79.29 [+0.00] [ 1099.946914] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.29 [+0.00] [ 1099.947079] [ C0] ? process_one_work+0xd16/0x1390 # 79.30 [+0.00] [ 1099.947237] [ C0] ? lock_acquire+0x10a/0x150 # 79.30 [+0.00] [ 1099.947402] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.30 [+0.00] [ 1099.947562] [ C0] process_one_work+0xd57/0x1390 # 79.30 [+0.00] [ 1099.947726] [ C0] ? pwq_dec_nr_in_flight+0x700/0x700 # 79.30 [+0.00] [ 1099.947884] [ C0] ? lock_acquire.part.0+0xbc/0x260 # 79.30 [+0.00] [ 1099.948045] [ C0] ? assign_work+0x152/0x380 # 79.31 [+0.00] [ 1099.948210] [ C0] worker_thread+0x4d6/0xd40 # 79.31 [+0.00] [ 1099.948373] [ C0] ? process_one_work+0x1390/0x1390 # 79.31 [+0.00] [ 1099.948534] [ C0] kthread+0x355/0x5b0 # 79.31 [+0.00] [ 1099.948660] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.31 [+0.00] [ 1099.948820] [ C0] ? __lock_release.isra.0+0x59/0x170 # 79.31 [+0.00] [ 1099.948980] [ C0] ? rcu_is_watching+0x15/0xd0 # 79.32 [+0.00] [ 1099.949142] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.32 [+0.00] [ 1099.949302] [ C0] ret_from_fork+0x3fb/0x510 # 79.32 [+0.00] [ 1099.949462] [ C0] ? arch_exit_to_user_mode_prepare.isra.0+0x140/0x140 # 79.32 [+0.00] [ 1099.949660] [ C0] ? __switch_to+0x602/0xd00 # 79.32 [+0.00] [ 1099.949827] [ C0] ? kthread_is_per_cpu+0xe0/0xe0 # 79.33 [+0.00] [ 1099.949989] [ C0] ret_from_fork_asm+0x11/0x20 # 79.33 [+0.00] [ 1099.950160] [ C0] # 79.33 [+0.00] [ 1109.800293] [ C0] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 23870081867 wd_nsec: 23870083203 ok 1 selftests: net/forwarding: tc_actions.sh make: Leaving directory '/srv/vmksft/testing/wt-4/tools/testing/selftests' xx__-> echo $? 0 xx__ DETECTED CRASH, lowering timeout ->