Nov 6 05:22:08.424220 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT_DYNAMIC Thu Nov 6 03:32:51 -00 2025 Nov 6 05:22:08.424241 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=42c7eeb79a8ee89597bba4204806137326be9acdbca65a8fd923766f65b62f69 Nov 6 05:22:08.424250 kernel: BIOS-provided physical RAM map: Nov 6 05:22:08.424260 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Nov 6 05:22:08.424266 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Nov 6 05:22:08.424273 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Nov 6 05:22:08.424280 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Nov 6 05:22:08.424287 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Nov 6 05:22:08.424294 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable Nov 6 05:22:08.424300 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Nov 6 05:22:08.424307 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable Nov 6 05:22:08.424313 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Nov 6 05:22:08.424322 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable Nov 6 05:22:08.424329 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Nov 6 05:22:08.424337 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Nov 6 05:22:08.424344 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Nov 6 05:22:08.424351 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable Nov 6 05:22:08.424360 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Nov 6 05:22:08.424367 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Nov 6 05:22:08.424374 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable Nov 6 05:22:08.424381 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Nov 6 05:22:08.424389 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Nov 6 05:22:08.424396 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Nov 6 05:22:08.424403 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 6 05:22:08.424410 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Nov 6 05:22:08.424417 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 6 05:22:08.424424 kernel: NX (Execute Disable) protection: active Nov 6 05:22:08.424431 kernel: APIC: Static calls initialized Nov 6 05:22:08.424438 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable Nov 6 05:22:08.424447 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable Nov 6 05:22:08.424454 kernel: extended physical RAM map: Nov 6 05:22:08.424461 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable Nov 6 05:22:08.424469 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable Nov 6 05:22:08.424476 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Nov 6 05:22:08.424483 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable Nov 6 05:22:08.424490 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Nov 6 05:22:08.424497 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable Nov 6 05:22:08.424504 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Nov 6 05:22:08.424511 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable Nov 6 05:22:08.424519 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable Nov 6 05:22:08.424531 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable Nov 6 05:22:08.424538 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable Nov 6 05:22:08.424545 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable Nov 6 05:22:08.424553 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Nov 6 05:22:08.424562 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable Nov 6 05:22:08.424569 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Nov 6 05:22:08.424577 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Nov 6 05:22:08.424584 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Nov 6 05:22:08.424591 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable Nov 6 05:22:08.424599 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Nov 6 05:22:08.424606 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Nov 6 05:22:08.424613 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable Nov 6 05:22:08.424621 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Nov 6 05:22:08.424628 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Nov 6 05:22:08.424635 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Nov 6 05:22:08.424645 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 6 05:22:08.424652 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Nov 6 05:22:08.424660 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 6 05:22:08.424667 kernel: efi: EFI v2.7 by EDK II Nov 6 05:22:08.424675 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 Nov 6 05:22:08.424682 kernel: random: crng init done Nov 6 05:22:08.424689 kernel: efi: Remove mem151: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Nov 6 05:22:08.424697 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Nov 6 05:22:08.424704 kernel: secureboot: Secure boot disabled Nov 6 05:22:08.424712 kernel: SMBIOS 2.8 present. Nov 6 05:22:08.424719 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Nov 6 05:22:08.424726 kernel: DMI: Memory slots populated: 1/1 Nov 6 05:22:08.424736 kernel: Hypervisor detected: KVM Nov 6 05:22:08.424743 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Nov 6 05:22:08.424750 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 6 05:22:08.424758 kernel: kvm-clock: using sched offset of 5286852564 cycles Nov 6 05:22:08.424765 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 6 05:22:08.424773 kernel: tsc: Detected 2794.748 MHz processor Nov 6 05:22:08.424781 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 6 05:22:08.424789 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 6 05:22:08.424796 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Nov 6 05:22:08.424804 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Nov 6 05:22:08.424814 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 6 05:22:08.424821 kernel: Using GB pages for direct mapping Nov 6 05:22:08.424829 kernel: ACPI: Early table checksum verification disabled Nov 6 05:22:08.424836 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Nov 6 05:22:08.424844 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Nov 6 05:22:08.424852 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424859 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424867 kernel: ACPI: FACS 0x000000009CBDD000 000040 Nov 6 05:22:08.424874 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424884 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424892 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424899 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 6 05:22:08.424907 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Nov 6 05:22:08.424915 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Nov 6 05:22:08.424922 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Nov 6 05:22:08.424930 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Nov 6 05:22:08.424937 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Nov 6 05:22:08.424945 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Nov 6 05:22:08.424954 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Nov 6 05:22:08.424962 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Nov 6 05:22:08.424969 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Nov 6 05:22:08.424976 kernel: No NUMA configuration found Nov 6 05:22:08.424984 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff] Nov 6 05:22:08.424991 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff] Nov 6 05:22:08.424999 kernel: Zone ranges: Nov 6 05:22:08.425006 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 6 05:22:08.425014 kernel: DMA32 [mem 0x0000000001000000-0x000000009cedbfff] Nov 6 05:22:08.425023 kernel: Normal empty Nov 6 05:22:08.425031 kernel: Device empty Nov 6 05:22:08.425038 kernel: Movable zone start for each node Nov 6 05:22:08.425045 kernel: Early memory node ranges Nov 6 05:22:08.425053 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Nov 6 05:22:08.425060 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Nov 6 05:22:08.425068 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Nov 6 05:22:08.425075 kernel: node 0: [mem 0x000000000080c000-0x0000000000810fff] Nov 6 05:22:08.425083 kernel: node 0: [mem 0x0000000000900000-0x000000009bd3efff] Nov 6 05:22:08.425090 kernel: node 0: [mem 0x000000009be00000-0x000000009c8ecfff] Nov 6 05:22:08.425108 kernel: node 0: [mem 0x000000009cbff000-0x000000009ce90fff] Nov 6 05:22:08.425132 kernel: node 0: [mem 0x000000009ce97000-0x000000009cedbfff] Nov 6 05:22:08.425140 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff] Nov 6 05:22:08.425148 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 6 05:22:08.425162 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Nov 6 05:22:08.425172 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Nov 6 05:22:08.425179 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 6 05:22:08.425187 kernel: On node 0, zone DMA: 239 pages in unavailable ranges Nov 6 05:22:08.425195 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges Nov 6 05:22:08.425202 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Nov 6 05:22:08.425210 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Nov 6 05:22:08.425218 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges Nov 6 05:22:08.425228 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 6 05:22:08.425235 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 6 05:22:08.425243 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 6 05:22:08.425251 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 6 05:22:08.425259 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 6 05:22:08.425269 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 6 05:22:08.425276 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 6 05:22:08.425284 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 6 05:22:08.425292 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 6 05:22:08.425299 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 6 05:22:08.425307 kernel: TSC deadline timer available Nov 6 05:22:08.425314 kernel: CPU topo: Max. logical packages: 1 Nov 6 05:22:08.425322 kernel: CPU topo: Max. logical dies: 1 Nov 6 05:22:08.425330 kernel: CPU topo: Max. dies per package: 1 Nov 6 05:22:08.425339 kernel: CPU topo: Max. threads per core: 1 Nov 6 05:22:08.425347 kernel: CPU topo: Num. cores per package: 4 Nov 6 05:22:08.425354 kernel: CPU topo: Num. threads per package: 4 Nov 6 05:22:08.425362 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Nov 6 05:22:08.425370 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 6 05:22:08.425377 kernel: kvm-guest: KVM setup pv remote TLB flush Nov 6 05:22:08.425385 kernel: kvm-guest: setup PV sched yield Nov 6 05:22:08.425393 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Nov 6 05:22:08.425400 kernel: Booting paravirtualized kernel on KVM Nov 6 05:22:08.425408 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 6 05:22:08.425418 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Nov 6 05:22:08.425426 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Nov 6 05:22:08.425434 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Nov 6 05:22:08.425442 kernel: pcpu-alloc: [0] 0 1 2 3 Nov 6 05:22:08.425449 kernel: kvm-guest: PV spinlocks enabled Nov 6 05:22:08.425457 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 6 05:22:08.425466 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=42c7eeb79a8ee89597bba4204806137326be9acdbca65a8fd923766f65b62f69 Nov 6 05:22:08.425474 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 6 05:22:08.425484 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 6 05:22:08.425491 kernel: Fallback order for Node 0: 0 Nov 6 05:22:08.425499 kernel: Built 1 zonelists, mobility grouping on. Total pages: 641450 Nov 6 05:22:08.425507 kernel: Policy zone: DMA32 Nov 6 05:22:08.425514 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 6 05:22:08.425522 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 6 05:22:08.425530 kernel: ftrace: allocating 40092 entries in 157 pages Nov 6 05:22:08.425537 kernel: ftrace: allocated 157 pages with 5 groups Nov 6 05:22:08.425545 kernel: Dynamic Preempt: voluntary Nov 6 05:22:08.425555 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 6 05:22:08.425563 kernel: rcu: RCU event tracing is enabled. Nov 6 05:22:08.425571 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 6 05:22:08.425579 kernel: Trampoline variant of Tasks RCU enabled. Nov 6 05:22:08.425587 kernel: Rude variant of Tasks RCU enabled. Nov 6 05:22:08.425594 kernel: Tracing variant of Tasks RCU enabled. Nov 6 05:22:08.425602 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 6 05:22:08.425610 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 6 05:22:08.425617 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 6 05:22:08.425627 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 6 05:22:08.425635 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 6 05:22:08.425643 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Nov 6 05:22:08.425651 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 6 05:22:08.425659 kernel: Console: colour dummy device 80x25 Nov 6 05:22:08.425671 kernel: printk: legacy console [ttyS0] enabled Nov 6 05:22:08.425679 kernel: ACPI: Core revision 20240827 Nov 6 05:22:08.425687 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Nov 6 05:22:08.425695 kernel: APIC: Switch to symmetric I/O mode setup Nov 6 05:22:08.425704 kernel: x2apic enabled Nov 6 05:22:08.425712 kernel: APIC: Switched APIC routing to: physical x2apic Nov 6 05:22:08.425720 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Nov 6 05:22:08.425728 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Nov 6 05:22:08.425735 kernel: kvm-guest: setup PV IPIs Nov 6 05:22:08.425743 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Nov 6 05:22:08.425751 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Nov 6 05:22:08.425759 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Nov 6 05:22:08.425766 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 6 05:22:08.425776 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Nov 6 05:22:08.425784 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Nov 6 05:22:08.425792 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 6 05:22:08.425799 kernel: Spectre V2 : Mitigation: Retpolines Nov 6 05:22:08.425807 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 6 05:22:08.425815 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Nov 6 05:22:08.425822 kernel: active return thunk: retbleed_return_thunk Nov 6 05:22:08.425830 kernel: RETBleed: Mitigation: untrained return thunk Nov 6 05:22:08.425838 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 6 05:22:08.425848 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 6 05:22:08.425856 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Nov 6 05:22:08.425864 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Nov 6 05:22:08.425872 kernel: active return thunk: srso_return_thunk Nov 6 05:22:08.425879 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Nov 6 05:22:08.425887 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 6 05:22:08.425895 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 6 05:22:08.425902 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 6 05:22:08.425912 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 6 05:22:08.425920 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Nov 6 05:22:08.425928 kernel: Freeing SMP alternatives memory: 32K Nov 6 05:22:08.425935 kernel: pid_max: default: 32768 minimum: 301 Nov 6 05:22:08.425943 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 6 05:22:08.425951 kernel: landlock: Up and running. Nov 6 05:22:08.425958 kernel: SELinux: Initializing. Nov 6 05:22:08.425966 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 05:22:08.425974 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 6 05:22:08.425983 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Nov 6 05:22:08.425991 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Nov 6 05:22:08.425999 kernel: ... version: 0 Nov 6 05:22:08.426006 kernel: ... bit width: 48 Nov 6 05:22:08.426014 kernel: ... generic registers: 6 Nov 6 05:22:08.426022 kernel: ... value mask: 0000ffffffffffff Nov 6 05:22:08.426029 kernel: ... max period: 00007fffffffffff Nov 6 05:22:08.426037 kernel: ... fixed-purpose events: 0 Nov 6 05:22:08.426044 kernel: ... event mask: 000000000000003f Nov 6 05:22:08.426054 kernel: signal: max sigframe size: 1776 Nov 6 05:22:08.426062 kernel: rcu: Hierarchical SRCU implementation. Nov 6 05:22:08.426069 kernel: rcu: Max phase no-delay instances is 400. Nov 6 05:22:08.426077 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 6 05:22:08.426085 kernel: smp: Bringing up secondary CPUs ... Nov 6 05:22:08.426093 kernel: smpboot: x86: Booting SMP configuration: Nov 6 05:22:08.426108 kernel: .... node #0, CPUs: #1 #2 #3 Nov 6 05:22:08.426129 kernel: smp: Brought up 1 node, 4 CPUs Nov 6 05:22:08.426137 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Nov 6 05:22:08.426148 kernel: Memory: 2441096K/2565800K available (14336K kernel code, 2443K rwdata, 29892K rodata, 15356K init, 2688K bss, 118764K reserved, 0K cma-reserved) Nov 6 05:22:08.426156 kernel: devtmpfs: initialized Nov 6 05:22:08.426163 kernel: x86/mm: Memory block size: 128MB Nov 6 05:22:08.426171 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Nov 6 05:22:08.426179 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Nov 6 05:22:08.426187 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes) Nov 6 05:22:08.426194 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Nov 6 05:22:08.426202 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes) Nov 6 05:22:08.426210 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Nov 6 05:22:08.426220 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 6 05:22:08.426228 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 6 05:22:08.426236 kernel: pinctrl core: initialized pinctrl subsystem Nov 6 05:22:08.426243 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 6 05:22:08.426251 kernel: audit: initializing netlink subsys (disabled) Nov 6 05:22:08.426259 kernel: audit: type=2000 audit(1762406524.838:1): state=initialized audit_enabled=0 res=1 Nov 6 05:22:08.426266 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 6 05:22:08.426274 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 6 05:22:08.426281 kernel: cpuidle: using governor menu Nov 6 05:22:08.426291 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 6 05:22:08.426299 kernel: dca service started, version 1.12.1 Nov 6 05:22:08.426307 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Nov 6 05:22:08.426314 kernel: PCI: Using configuration type 1 for base access Nov 6 05:22:08.426322 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 6 05:22:08.426330 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 6 05:22:08.426337 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 6 05:22:08.426345 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 6 05:22:08.426353 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 6 05:22:08.426363 kernel: ACPI: Added _OSI(Module Device) Nov 6 05:22:08.426370 kernel: ACPI: Added _OSI(Processor Device) Nov 6 05:22:08.426378 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 6 05:22:08.426386 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 6 05:22:08.426393 kernel: ACPI: Interpreter enabled Nov 6 05:22:08.426401 kernel: ACPI: PM: (supports S0 S3 S5) Nov 6 05:22:08.426408 kernel: ACPI: Using IOAPIC for interrupt routing Nov 6 05:22:08.426416 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 6 05:22:08.426424 kernel: PCI: Using E820 reservations for host bridge windows Nov 6 05:22:08.426434 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 6 05:22:08.426441 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 6 05:22:08.426646 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 6 05:22:08.426790 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Nov 6 05:22:08.426917 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Nov 6 05:22:08.426972 kernel: PCI host bridge to bus 0000:00 Nov 6 05:22:08.427129 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 6 05:22:08.427255 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 6 05:22:08.427378 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 6 05:22:08.427493 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Nov 6 05:22:08.427606 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Nov 6 05:22:08.427718 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Nov 6 05:22:08.427830 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 6 05:22:08.427972 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 6 05:22:08.428138 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Nov 6 05:22:08.428269 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Nov 6 05:22:08.428392 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Nov 6 05:22:08.428515 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Nov 6 05:22:08.428637 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 6 05:22:08.428808 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Nov 6 05:22:08.428940 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Nov 6 05:22:08.429064 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Nov 6 05:22:08.429229 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Nov 6 05:22:08.429364 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Nov 6 05:22:08.429504 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Nov 6 05:22:08.429631 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Nov 6 05:22:08.429763 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Nov 6 05:22:08.429904 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 6 05:22:08.430028 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Nov 6 05:22:08.430182 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Nov 6 05:22:08.430308 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Nov 6 05:22:08.430431 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Nov 6 05:22:08.430562 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 6 05:22:08.430687 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 6 05:22:08.430832 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 6 05:22:08.430957 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Nov 6 05:22:08.431081 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Nov 6 05:22:08.431255 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 6 05:22:08.431380 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Nov 6 05:22:08.431391 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 6 05:22:08.431403 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 6 05:22:08.431411 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 6 05:22:08.431419 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 6 05:22:08.431427 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 6 05:22:08.431434 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 6 05:22:08.431442 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 6 05:22:08.431450 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 6 05:22:08.431457 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 6 05:22:08.431465 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 6 05:22:08.431475 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 6 05:22:08.431483 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 6 05:22:08.431490 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 6 05:22:08.431498 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 6 05:22:08.431506 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 6 05:22:08.431513 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 6 05:22:08.431521 kernel: iommu: Default domain type: Translated Nov 6 05:22:08.431529 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 6 05:22:08.431536 kernel: efivars: Registered efivars operations Nov 6 05:22:08.431546 kernel: PCI: Using ACPI for IRQ routing Nov 6 05:22:08.431554 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 6 05:22:08.431562 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Nov 6 05:22:08.431569 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff] Nov 6 05:22:08.431577 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff] Nov 6 05:22:08.431585 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff] Nov 6 05:22:08.431592 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff] Nov 6 05:22:08.431600 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff] Nov 6 05:22:08.431607 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff] Nov 6 05:22:08.431617 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff] Nov 6 05:22:08.431752 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 6 05:22:08.431934 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 6 05:22:08.432058 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 6 05:22:08.432069 kernel: vgaarb: loaded Nov 6 05:22:08.432077 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Nov 6 05:22:08.432085 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Nov 6 05:22:08.432092 kernel: clocksource: Switched to clocksource kvm-clock Nov 6 05:22:08.432128 kernel: VFS: Disk quotas dquot_6.6.0 Nov 6 05:22:08.432137 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 6 05:22:08.432145 kernel: pnp: PnP ACPI init Nov 6 05:22:08.432297 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Nov 6 05:22:08.432312 kernel: pnp: PnP ACPI: found 6 devices Nov 6 05:22:08.432320 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 6 05:22:08.432328 kernel: NET: Registered PF_INET protocol family Nov 6 05:22:08.432337 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 6 05:22:08.432345 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 6 05:22:08.432357 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 6 05:22:08.432365 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 6 05:22:08.432373 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 6 05:22:08.432381 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 6 05:22:08.432389 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 05:22:08.432397 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 6 05:22:08.432405 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 6 05:22:08.432413 kernel: NET: Registered PF_XDP protocol family Nov 6 05:22:08.432540 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Nov 6 05:22:08.432665 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Nov 6 05:22:08.432780 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 6 05:22:08.432897 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 6 05:22:08.433009 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 6 05:22:08.433148 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Nov 6 05:22:08.433264 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Nov 6 05:22:08.433377 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Nov 6 05:22:08.433392 kernel: PCI: CLS 0 bytes, default 64 Nov 6 05:22:08.433400 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Nov 6 05:22:08.433411 kernel: Initialise system trusted keyrings Nov 6 05:22:08.433419 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 6 05:22:08.433427 kernel: Key type asymmetric registered Nov 6 05:22:08.433437 kernel: Asymmetric key parser 'x509' registered Nov 6 05:22:08.433445 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 6 05:22:08.433453 kernel: io scheduler mq-deadline registered Nov 6 05:22:08.433461 kernel: io scheduler kyber registered Nov 6 05:22:08.433469 kernel: io scheduler bfq registered Nov 6 05:22:08.433477 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 6 05:22:08.433486 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 6 05:22:08.433494 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 6 05:22:08.433502 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Nov 6 05:22:08.433512 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 6 05:22:08.433521 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 6 05:22:08.433529 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 6 05:22:08.433537 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 6 05:22:08.433545 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 6 05:22:08.433673 kernel: rtc_cmos 00:04: RTC can wake from S4 Nov 6 05:22:08.433685 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 6 05:22:08.433801 kernel: rtc_cmos 00:04: registered as rtc0 Nov 6 05:22:08.433918 kernel: rtc_cmos 00:04: setting system clock to 2025-11-06T05:22:06 UTC (1762406526) Nov 6 05:22:08.434039 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Nov 6 05:22:08.434050 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Nov 6 05:22:08.434058 kernel: efifb: probing for efifb Nov 6 05:22:08.434066 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Nov 6 05:22:08.434074 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Nov 6 05:22:08.434082 kernel: efifb: scrolling: redraw Nov 6 05:22:08.434090 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Nov 6 05:22:08.434108 kernel: Console: switching to colour frame buffer device 160x50 Nov 6 05:22:08.434141 kernel: fb0: EFI VGA frame buffer device Nov 6 05:22:08.434149 kernel: pstore: Using crash dump compression: deflate Nov 6 05:22:08.434157 kernel: pstore: Registered efi_pstore as persistent store backend Nov 6 05:22:08.434166 kernel: NET: Registered PF_INET6 protocol family Nov 6 05:22:08.434173 kernel: Segment Routing with IPv6 Nov 6 05:22:08.434182 kernel: In-situ OAM (IOAM) with IPv6 Nov 6 05:22:08.434190 kernel: NET: Registered PF_PACKET protocol family Nov 6 05:22:08.434198 kernel: Key type dns_resolver registered Nov 6 05:22:08.434205 kernel: IPI shorthand broadcast: enabled Nov 6 05:22:08.434214 kernel: sched_clock: Marking stable (2026061711, 286872421)->(2383436524, -70502392) Nov 6 05:22:08.434224 kernel: registered taskstats version 1 Nov 6 05:22:08.434232 kernel: Loading compiled-in X.509 certificates Nov 6 05:22:08.434240 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: edee08bd79f57120bcf336d97df00a0ad5e85412' Nov 6 05:22:08.434248 kernel: Demotion targets for Node 0: null Nov 6 05:22:08.434256 kernel: Key type .fscrypt registered Nov 6 05:22:08.434264 kernel: Key type fscrypt-provisioning registered Nov 6 05:22:08.434272 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 6 05:22:08.434280 kernel: ima: Allocated hash algorithm: sha1 Nov 6 05:22:08.434288 kernel: ima: No architecture policies found Nov 6 05:22:08.434298 kernel: clk: Disabling unused clocks Nov 6 05:22:08.434308 kernel: Freeing unused kernel image (initmem) memory: 15356K Nov 6 05:22:08.434316 kernel: Write protecting the kernel read-only data: 45056k Nov 6 05:22:08.434324 kernel: Freeing unused kernel image (rodata/data gap) memory: 828K Nov 6 05:22:08.434332 kernel: Run /init as init process Nov 6 05:22:08.434340 kernel: with arguments: Nov 6 05:22:08.434348 kernel: /init Nov 6 05:22:08.434356 kernel: with environment: Nov 6 05:22:08.434364 kernel: HOME=/ Nov 6 05:22:08.434383 kernel: TERM=linux Nov 6 05:22:08.434391 kernel: SCSI subsystem initialized Nov 6 05:22:08.434399 kernel: libata version 3.00 loaded. Nov 6 05:22:08.434531 kernel: ahci 0000:00:1f.2: version 3.0 Nov 6 05:22:08.434542 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 6 05:22:08.434664 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 6 05:22:08.434844 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 6 05:22:08.434969 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 6 05:22:08.435152 kernel: scsi host0: ahci Nov 6 05:22:08.435297 kernel: scsi host1: ahci Nov 6 05:22:08.435439 kernel: scsi host2: ahci Nov 6 05:22:08.435580 kernel: scsi host3: ahci Nov 6 05:22:08.435730 kernel: scsi host4: ahci Nov 6 05:22:08.435874 kernel: scsi host5: ahci Nov 6 05:22:08.435891 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 26 lpm-pol 1 Nov 6 05:22:08.435899 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 26 lpm-pol 1 Nov 6 05:22:08.435918 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 26 lpm-pol 1 Nov 6 05:22:08.435937 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 26 lpm-pol 1 Nov 6 05:22:08.435946 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 26 lpm-pol 1 Nov 6 05:22:08.435954 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 26 lpm-pol 1 Nov 6 05:22:08.435962 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 6 05:22:08.435980 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 6 05:22:08.435997 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Nov 6 05:22:08.436019 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 6 05:22:08.436027 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 6 05:22:08.436035 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 6 05:22:08.436044 kernel: ata3.00: LPM support broken, forcing max_power Nov 6 05:22:08.436051 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Nov 6 05:22:08.436059 kernel: ata3.00: applying bridge limits Nov 6 05:22:08.436067 kernel: ata3.00: LPM support broken, forcing max_power Nov 6 05:22:08.436075 kernel: ata3.00: configured for UDMA/100 Nov 6 05:22:08.436267 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Nov 6 05:22:08.436414 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Nov 6 05:22:08.436544 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Nov 6 05:22:08.436559 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 6 05:22:08.436570 kernel: GPT:16515071 != 27000831 Nov 6 05:22:08.436580 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 6 05:22:08.436590 kernel: GPT:16515071 != 27000831 Nov 6 05:22:08.436601 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 6 05:22:08.436616 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 6 05:22:08.436772 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Nov 6 05:22:08.436784 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 6 05:22:08.436926 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Nov 6 05:22:08.436937 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 6 05:22:08.436946 kernel: device-mapper: uevent: version 1.0.3 Nov 6 05:22:08.436954 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 6 05:22:08.436962 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Nov 6 05:22:08.436970 kernel: raid6: avx2x4 gen() 26159 MB/s Nov 6 05:22:08.436982 kernel: raid6: avx2x2 gen() 29964 MB/s Nov 6 05:22:08.436990 kernel: raid6: avx2x1 gen() 25845 MB/s Nov 6 05:22:08.436998 kernel: raid6: using algorithm avx2x2 gen() 29964 MB/s Nov 6 05:22:08.437006 kernel: raid6: .... xor() 19389 MB/s, rmw enabled Nov 6 05:22:08.437015 kernel: raid6: using avx2x2 recovery algorithm Nov 6 05:22:08.437023 kernel: xor: automatically using best checksumming function avx Nov 6 05:22:08.437031 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 6 05:22:08.437040 kernel: BTRFS: device fsid b5cf1d69-dae6-4f65-bb6f-44a747495a60 devid 1 transid 35 /dev/mapper/usr (253:0) scanned by mount (181) Nov 6 05:22:08.437048 kernel: BTRFS info (device dm-0): first mount of filesystem b5cf1d69-dae6-4f65-bb6f-44a747495a60 Nov 6 05:22:08.437059 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 6 05:22:08.437067 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 6 05:22:08.437077 kernel: BTRFS info (device dm-0): enabling free space tree Nov 6 05:22:08.437085 kernel: loop: module loaded Nov 6 05:22:08.437093 kernel: loop0: detected capacity change from 0 to 101000 Nov 6 05:22:08.437111 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 6 05:22:08.437133 systemd[1]: Successfully made /usr/ read-only. Nov 6 05:22:08.437144 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 6 05:22:08.437157 systemd[1]: Detected virtualization kvm. Nov 6 05:22:08.437165 systemd[1]: Detected architecture x86-64. Nov 6 05:22:08.437173 systemd[1]: Running in initrd. Nov 6 05:22:08.437181 systemd[1]: No hostname configured, using default hostname. Nov 6 05:22:08.437190 systemd[1]: Hostname set to . Nov 6 05:22:08.437198 systemd[1]: Initializing machine ID from VM UUID. Nov 6 05:22:08.437207 systemd[1]: Queued start job for default target initrd.target. Nov 6 05:22:08.437217 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 6 05:22:08.437226 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 6 05:22:08.437234 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 6 05:22:08.437244 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 6 05:22:08.437252 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 6 05:22:08.437262 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 6 05:22:08.437271 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 6 05:22:08.437282 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 6 05:22:08.437290 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 6 05:22:08.437299 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 6 05:22:08.437307 systemd[1]: Reached target paths.target - Path Units. Nov 6 05:22:08.437316 systemd[1]: Reached target slices.target - Slice Units. Nov 6 05:22:08.437324 systemd[1]: Reached target swap.target - Swaps. Nov 6 05:22:08.437333 systemd[1]: Reached target timers.target - Timer Units. Nov 6 05:22:08.437341 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 6 05:22:08.437350 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 6 05:22:08.437360 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 6 05:22:08.437369 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 6 05:22:08.437378 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 6 05:22:08.437386 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 6 05:22:08.437395 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 6 05:22:08.437403 systemd[1]: Reached target sockets.target - Socket Units. Nov 6 05:22:08.437412 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 6 05:22:08.437420 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 6 05:22:08.437431 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 6 05:22:08.437440 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 6 05:22:08.437449 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 6 05:22:08.437458 systemd[1]: Starting systemd-fsck-usr.service... Nov 6 05:22:08.437466 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 6 05:22:08.437475 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 6 05:22:08.437484 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 6 05:22:08.437495 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 6 05:22:08.437504 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 6 05:22:08.437512 systemd[1]: Finished systemd-fsck-usr.service. Nov 6 05:22:08.437521 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 6 05:22:08.437573 systemd-journald[317]: Collecting audit messages is disabled. Nov 6 05:22:08.437604 systemd-journald[317]: Journal started Nov 6 05:22:08.437635 systemd-journald[317]: Runtime Journal (/run/log/journal/c820db5e9e99454ab6d4f86a96b20aa4) is 6M, max 48.1M, 42M free. Nov 6 05:22:08.439385 systemd[1]: Started systemd-journald.service - Journal Service. Nov 6 05:22:08.441822 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 6 05:22:08.445319 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 6 05:22:08.449935 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 6 05:22:08.455156 kernel: Bridge firewalling registered Nov 6 05:22:08.455233 systemd-modules-load[319]: Inserted module 'br_netfilter' Nov 6 05:22:08.456272 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 6 05:22:08.458412 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 6 05:22:08.476281 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 6 05:22:08.480537 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 6 05:22:08.485872 systemd-tmpfiles[330]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 6 05:22:08.487430 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 6 05:22:08.490620 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 6 05:22:08.494735 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 6 05:22:08.509250 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 6 05:22:08.512956 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 6 05:22:08.532742 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 6 05:22:08.538006 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 6 05:22:08.563965 systemd-resolved[348]: Positive Trust Anchors: Nov 6 05:22:08.563979 systemd-resolved[348]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 6 05:22:08.564009 systemd-resolved[348]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 6 05:22:08.586792 dracut-cmdline[359]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=42c7eeb79a8ee89597bba4204806137326be9acdbca65a8fd923766f65b62f69 Nov 6 05:22:08.587148 systemd-resolved[348]: Defaulting to hostname 'linux'. Nov 6 05:22:08.595105 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 6 05:22:08.598402 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 6 05:22:08.721175 kernel: Loading iSCSI transport class v2.0-870. Nov 6 05:22:08.736159 kernel: iscsi: registered transport (tcp) Nov 6 05:22:08.763396 kernel: iscsi: registered transport (qla4xxx) Nov 6 05:22:08.763463 kernel: QLogic iSCSI HBA Driver Nov 6 05:22:08.804055 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 6 05:22:08.832446 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 6 05:22:08.835652 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 6 05:22:08.948315 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 6 05:22:08.951963 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 6 05:22:08.954515 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 6 05:22:08.997000 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 6 05:22:08.999811 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 6 05:22:09.031938 systemd-udevd[595]: Using default interface naming scheme 'v255'. Nov 6 05:22:09.056926 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 6 05:22:09.074297 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 6 05:22:09.095160 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 6 05:22:09.101142 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 6 05:22:09.110888 dracut-pre-trigger[678]: rd.md=0: removing MD RAID activation Nov 6 05:22:09.144910 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 6 05:22:09.148352 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 6 05:22:09.163167 systemd-networkd[700]: lo: Link UP Nov 6 05:22:09.163176 systemd-networkd[700]: lo: Gained carrier Nov 6 05:22:09.163641 systemd-networkd[700]: Enumeration completed Nov 6 05:22:09.163800 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 6 05:22:09.166207 systemd[1]: Reached target network.target - Network. Nov 6 05:22:09.243618 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 6 05:22:09.256233 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 6 05:22:09.315046 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 6 05:22:09.328442 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 6 05:22:09.343724 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 6 05:22:09.365147 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Nov 6 05:22:09.377149 kernel: cryptd: max_cpu_qlen set to 1000 Nov 6 05:22:09.379700 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 6 05:22:09.386839 systemd-networkd[700]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 6 05:22:09.386850 systemd-networkd[700]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 6 05:22:09.388268 systemd-networkd[700]: eth0: Link UP Nov 6 05:22:09.388488 systemd-networkd[700]: eth0: Gained carrier Nov 6 05:22:09.388497 systemd-networkd[700]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 6 05:22:09.395460 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 6 05:22:09.433279 kernel: AES CTR mode by8 optimization enabled Nov 6 05:22:09.402487 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 6 05:22:09.417730 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 6 05:22:09.419706 systemd-networkd[700]: eth0: DHCPv4 address 10.0.0.35/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 6 05:22:09.420002 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 6 05:22:09.425418 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 6 05:22:09.430092 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 6 05:22:09.432332 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 6 05:22:09.433548 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 6 05:22:09.442922 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 6 05:22:09.445818 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 6 05:22:09.450761 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Nov 6 05:22:09.464988 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 6 05:22:09.469162 disk-uuid[842]: Primary Header is updated. Nov 6 05:22:09.469162 disk-uuid[842]: Secondary Entries is updated. Nov 6 05:22:09.469162 disk-uuid[842]: Secondary Header is updated. Nov 6 05:22:09.478437 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 6 05:22:09.519263 systemd-resolved[348]: Detected conflict on linux IN A 10.0.0.35 Nov 6 05:22:09.519282 systemd-resolved[348]: Hostname conflict, changing published hostname from 'linux' to 'linux8'. Nov 6 05:22:10.540552 disk-uuid[848]: Warning: The kernel is still using the old partition table. Nov 6 05:22:10.540552 disk-uuid[848]: The new table will be used at the next reboot or after you Nov 6 05:22:10.540552 disk-uuid[848]: run partprobe(8) or kpartx(8) Nov 6 05:22:10.540552 disk-uuid[848]: The operation has completed successfully. Nov 6 05:22:10.555222 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 6 05:22:10.555401 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 6 05:22:10.561021 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 6 05:22:10.585305 systemd-networkd[700]: eth0: Gained IPv6LL Nov 6 05:22:10.599145 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (860) Nov 6 05:22:10.601147 kernel: BTRFS info (device vda6): first mount of filesystem 8a1691a9-0f9b-492f-9a94-8ffa2a579e5c Nov 6 05:22:10.601184 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 6 05:22:10.606494 kernel: BTRFS info (device vda6): turning on async discard Nov 6 05:22:10.606518 kernel: BTRFS info (device vda6): enabling free space tree Nov 6 05:22:10.616160 kernel: BTRFS info (device vda6): last unmount of filesystem 8a1691a9-0f9b-492f-9a94-8ffa2a579e5c Nov 6 05:22:10.617019 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 6 05:22:10.619258 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 6 05:22:10.929699 ignition[879]: Ignition 2.22.0 Nov 6 05:22:10.929796 ignition[879]: Stage: fetch-offline Nov 6 05:22:10.929990 ignition[879]: no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:10.930010 ignition[879]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:10.930316 ignition[879]: parsed url from cmdline: "" Nov 6 05:22:10.930321 ignition[879]: no config URL provided Nov 6 05:22:10.930330 ignition[879]: reading system config file "/usr/lib/ignition/user.ign" Nov 6 05:22:10.930344 ignition[879]: no config at "/usr/lib/ignition/user.ign" Nov 6 05:22:10.930449 ignition[879]: op(1): [started] loading QEMU firmware config module Nov 6 05:22:10.930458 ignition[879]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 6 05:22:10.943231 ignition[879]: op(1): [finished] loading QEMU firmware config module Nov 6 05:22:10.943257 ignition[879]: QEMU firmware config was not found. Ignoring... Nov 6 05:22:10.944923 ignition[879]: parsing config with SHA512: 941370cd7b5706f80580cbd662cf8cbfbc543c486c87e910815e4e30970d6f4d0d9569d8930bc285def44098e5e5e98a4f56830154c038c8a76d99c70089597b Nov 6 05:22:10.949402 unknown[879]: fetched base config from "system" Nov 6 05:22:10.949416 unknown[879]: fetched user config from "qemu" Nov 6 05:22:10.949825 ignition[879]: fetch-offline: fetch-offline passed Nov 6 05:22:10.949947 ignition[879]: Ignition finished successfully Nov 6 05:22:10.953593 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 6 05:22:10.954963 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 6 05:22:10.956055 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 6 05:22:11.025756 ignition[889]: Ignition 2.22.0 Nov 6 05:22:11.025770 ignition[889]: Stage: kargs Nov 6 05:22:11.025973 ignition[889]: no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:11.025984 ignition[889]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:11.026616 ignition[889]: kargs: kargs passed Nov 6 05:22:11.026674 ignition[889]: Ignition finished successfully Nov 6 05:22:11.035297 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 6 05:22:11.037260 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 6 05:22:11.112489 ignition[897]: Ignition 2.22.0 Nov 6 05:22:11.112503 ignition[897]: Stage: disks Nov 6 05:22:11.112674 ignition[897]: no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:11.112685 ignition[897]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:11.113228 ignition[897]: disks: disks passed Nov 6 05:22:11.113276 ignition[897]: Ignition finished successfully Nov 6 05:22:11.122591 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 6 05:22:11.125848 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 6 05:22:11.126529 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 6 05:22:11.129883 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 6 05:22:11.133632 systemd[1]: Reached target sysinit.target - System Initialization. Nov 6 05:22:11.134459 systemd[1]: Reached target basic.target - Basic System. Nov 6 05:22:11.140584 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 6 05:22:11.195209 systemd-fsck[907]: ROOT: clean, 15/456736 files, 38230/456704 blocks Nov 6 05:22:11.203399 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 6 05:22:11.205996 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 6 05:22:11.316142 kernel: EXT4-fs (vda9): mounted filesystem 05065f18-b1e1-4b9e-83f5-1a1189e0d083 r/w with ordered data mode. Quota mode: none. Nov 6 05:22:11.316630 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 6 05:22:11.318188 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 6 05:22:11.321968 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 6 05:22:11.324945 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 6 05:22:11.327156 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 6 05:22:11.327198 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 6 05:22:11.327222 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 6 05:22:11.341406 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 6 05:22:11.344139 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 6 05:22:11.355365 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (916) Nov 6 05:22:11.355386 kernel: BTRFS info (device vda6): first mount of filesystem 8a1691a9-0f9b-492f-9a94-8ffa2a579e5c Nov 6 05:22:11.355398 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 6 05:22:11.355410 kernel: BTRFS info (device vda6): turning on async discard Nov 6 05:22:11.355420 kernel: BTRFS info (device vda6): enabling free space tree Nov 6 05:22:11.356608 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 6 05:22:11.888070 initrd-setup-root[940]: cut: /sysroot/etc/passwd: No such file or directory Nov 6 05:22:11.893517 initrd-setup-root[947]: cut: /sysroot/etc/group: No such file or directory Nov 6 05:22:11.897529 initrd-setup-root[954]: cut: /sysroot/etc/shadow: No such file or directory Nov 6 05:22:11.902811 initrd-setup-root[961]: cut: /sysroot/etc/gshadow: No such file or directory Nov 6 05:22:11.996692 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 6 05:22:12.001458 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 6 05:22:12.028368 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 6 05:22:12.036644 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 6 05:22:12.045058 kernel: BTRFS info (device vda6): last unmount of filesystem 8a1691a9-0f9b-492f-9a94-8ffa2a579e5c Nov 6 05:22:12.061645 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 6 05:22:12.272903 ignition[1030]: INFO : Ignition 2.22.0 Nov 6 05:22:12.272903 ignition[1030]: INFO : Stage: mount Nov 6 05:22:12.275490 ignition[1030]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:12.275490 ignition[1030]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:12.275490 ignition[1030]: INFO : mount: mount passed Nov 6 05:22:12.275490 ignition[1030]: INFO : Ignition finished successfully Nov 6 05:22:12.283897 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 6 05:22:12.287257 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 6 05:22:12.309036 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 6 05:22:12.327140 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1042) Nov 6 05:22:12.330320 kernel: BTRFS info (device vda6): first mount of filesystem 8a1691a9-0f9b-492f-9a94-8ffa2a579e5c Nov 6 05:22:12.330343 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 6 05:22:12.333757 kernel: BTRFS info (device vda6): turning on async discard Nov 6 05:22:12.333775 kernel: BTRFS info (device vda6): enabling free space tree Nov 6 05:22:12.335464 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 6 05:22:12.406108 ignition[1059]: INFO : Ignition 2.22.0 Nov 6 05:22:12.406108 ignition[1059]: INFO : Stage: files Nov 6 05:22:12.408674 ignition[1059]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:12.408674 ignition[1059]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:12.412389 ignition[1059]: DEBUG : files: compiled without relabeling support, skipping Nov 6 05:22:12.414453 ignition[1059]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 6 05:22:12.414453 ignition[1059]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 6 05:22:12.422028 ignition[1059]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 6 05:22:12.424401 ignition[1059]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 6 05:22:12.426845 unknown[1059]: wrote ssh authorized keys file for user: core Nov 6 05:22:12.428588 ignition[1059]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 6 05:22:12.428588 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Nov 6 05:22:12.428588 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 6 05:22:12.436717 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.1-x86-64.raw: attempt #1 Nov 6 05:22:12.776627 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Nov 6 05:22:13.449284 ignition[1059]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 6 05:22:13.449284 ignition[1059]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Nov 6 05:22:13.455643 ignition[1059]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 6 05:22:13.455643 ignition[1059]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 6 05:22:13.455643 ignition[1059]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Nov 6 05:22:13.455643 ignition[1059]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Nov 6 05:22:13.476294 ignition[1059]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 6 05:22:13.482106 ignition[1059]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 6 05:22:13.484567 ignition[1059]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Nov 6 05:22:13.484567 ignition[1059]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 6 05:22:13.484567 ignition[1059]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 6 05:22:13.484567 ignition[1059]: INFO : files: files passed Nov 6 05:22:13.484567 ignition[1059]: INFO : Ignition finished successfully Nov 6 05:22:13.493593 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 6 05:22:13.495713 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 6 05:22:13.499239 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 6 05:22:13.518197 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 6 05:22:13.518323 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 6 05:22:13.527036 initrd-setup-root-after-ignition[1091]: grep: /sysroot/oem/oem-release: No such file or directory Nov 6 05:22:13.532187 initrd-setup-root-after-ignition[1093]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 6 05:22:13.534684 initrd-setup-root-after-ignition[1093]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 6 05:22:13.537136 initrd-setup-root-after-ignition[1097]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 6 05:22:13.541210 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 6 05:22:13.545221 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 6 05:22:13.546608 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 6 05:22:13.612462 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 6 05:22:13.612613 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 6 05:22:13.614318 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 6 05:22:13.620915 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 6 05:22:13.622106 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 6 05:22:13.623293 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 6 05:22:13.661835 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 6 05:22:13.664298 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 6 05:22:13.685836 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 6 05:22:13.686088 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 6 05:22:13.686928 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 6 05:22:13.692195 systemd[1]: Stopped target timers.target - Timer Units. Nov 6 05:22:13.695870 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 6 05:22:13.695994 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 6 05:22:13.701625 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 6 05:22:13.705002 systemd[1]: Stopped target basic.target - Basic System. Nov 6 05:22:13.707943 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 6 05:22:13.708866 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 6 05:22:13.713664 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 6 05:22:13.717036 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 6 05:22:13.720572 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 6 05:22:13.724097 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 6 05:22:13.727634 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 6 05:22:13.731604 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 6 05:22:13.737010 systemd[1]: Stopped target swap.target - Swaps. Nov 6 05:22:13.737765 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 6 05:22:13.737959 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 6 05:22:13.742810 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 6 05:22:13.745990 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 6 05:22:13.746800 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 6 05:22:13.752487 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 6 05:22:13.753193 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 6 05:22:13.753316 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 6 05:22:13.760156 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 6 05:22:13.760317 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 6 05:22:13.761044 systemd[1]: Stopped target paths.target - Path Units. Nov 6 05:22:13.765519 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 6 05:22:13.771280 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 6 05:22:13.775708 systemd[1]: Stopped target slices.target - Slice Units. Nov 6 05:22:13.776789 systemd[1]: Stopped target sockets.target - Socket Units. Nov 6 05:22:13.779552 systemd[1]: iscsid.socket: Deactivated successfully. Nov 6 05:22:13.779698 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 6 05:22:13.782108 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 6 05:22:13.782244 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 6 05:22:13.784915 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 6 05:22:13.785098 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 6 05:22:13.787966 systemd[1]: ignition-files.service: Deactivated successfully. Nov 6 05:22:13.788146 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 6 05:22:13.795386 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 6 05:22:13.796069 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 6 05:22:13.796243 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 6 05:22:13.801561 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 6 05:22:13.810823 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 6 05:22:13.811069 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 6 05:22:13.814734 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 6 05:22:13.814926 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 6 05:22:13.824609 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 6 05:22:13.898314 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 6 05:22:13.924951 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 6 05:22:13.932079 ignition[1117]: INFO : Ignition 2.22.0 Nov 6 05:22:13.932079 ignition[1117]: INFO : Stage: umount Nov 6 05:22:13.935112 ignition[1117]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 6 05:22:13.935112 ignition[1117]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 6 05:22:13.939429 ignition[1117]: INFO : umount: umount passed Nov 6 05:22:13.939429 ignition[1117]: INFO : Ignition finished successfully Nov 6 05:22:13.939776 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 6 05:22:13.939924 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 6 05:22:13.941749 systemd[1]: Stopped target network.target - Network. Nov 6 05:22:13.944639 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 6 05:22:13.944714 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 6 05:22:13.945513 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 6 05:22:13.945570 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 6 05:22:13.946089 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 6 05:22:13.946171 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 6 05:22:13.953607 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 6 05:22:13.953658 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 6 05:22:13.954590 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 6 05:22:13.960586 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 6 05:22:13.979649 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 6 05:22:13.979797 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 6 05:22:13.981993 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 6 05:22:13.984363 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 6 05:22:13.989446 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Nov 6 05:22:13.989769 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 6 05:22:13.989904 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 6 05:22:13.998313 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Nov 6 05:22:14.000242 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 6 05:22:14.001137 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 6 05:22:14.001292 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 6 05:22:14.004524 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 6 05:22:14.004596 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 6 05:22:14.006211 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 6 05:22:14.011000 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 6 05:22:14.011064 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 6 05:22:14.011603 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 6 05:22:14.011651 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 6 05:22:14.021628 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 6 05:22:14.021686 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 6 05:22:14.022690 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 6 05:22:14.022747 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 6 05:22:14.030533 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 6 05:22:14.045623 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 6 05:22:14.047805 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Nov 6 05:22:14.076512 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 6 05:22:14.076774 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 6 05:22:14.080479 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 6 05:22:14.080532 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 6 05:22:14.081090 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 6 05:22:14.081151 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 6 05:22:14.085887 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 6 05:22:14.085948 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 6 05:22:14.091765 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 6 05:22:14.091849 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 6 05:22:14.096432 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 6 05:22:14.096518 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 6 05:22:14.103089 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 6 05:22:14.103830 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 6 05:22:14.103904 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 6 05:22:14.111898 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 6 05:22:14.111971 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 6 05:22:14.117818 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 6 05:22:14.117887 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 6 05:22:14.125943 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Nov 6 05:22:14.126044 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Nov 6 05:22:14.126137 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Nov 6 05:22:14.126670 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 6 05:22:14.126869 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 6 05:22:14.137479 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 6 05:22:14.137623 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 6 05:22:14.142162 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 6 05:22:14.144160 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 6 05:22:14.180812 systemd[1]: Switching root. Nov 6 05:22:14.221022 systemd-journald[317]: Journal stopped Nov 6 05:22:15.485435 systemd-journald[317]: Received SIGTERM from PID 1 (systemd). Nov 6 05:22:15.485509 kernel: SELinux: policy capability network_peer_controls=1 Nov 6 05:22:15.485539 kernel: SELinux: policy capability open_perms=1 Nov 6 05:22:15.485551 kernel: SELinux: policy capability extended_socket_class=1 Nov 6 05:22:15.485570 kernel: SELinux: policy capability always_check_network=0 Nov 6 05:22:15.485585 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 6 05:22:15.485599 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 6 05:22:15.485617 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 6 05:22:15.485629 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 6 05:22:15.485640 kernel: SELinux: policy capability userspace_initial_context=0 Nov 6 05:22:15.485666 kernel: audit: type=1403 audit(1762406534.582:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 6 05:22:15.485684 systemd[1]: Successfully loaded SELinux policy in 134.490ms. Nov 6 05:22:15.485703 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.852ms. Nov 6 05:22:15.485726 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 6 05:22:15.485739 systemd[1]: Detected virtualization kvm. Nov 6 05:22:15.485754 systemd[1]: Detected architecture x86-64. Nov 6 05:22:15.485773 systemd[1]: Detected first boot. Nov 6 05:22:15.485786 systemd[1]: Initializing machine ID from VM UUID. Nov 6 05:22:15.485798 zram_generator::config[1163]: No configuration found. Nov 6 05:22:15.485811 kernel: Guest personality initialized and is inactive Nov 6 05:22:15.485822 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Nov 6 05:22:15.485834 kernel: Initialized host personality Nov 6 05:22:15.485845 kernel: NET: Registered PF_VSOCK protocol family Nov 6 05:22:15.485872 systemd[1]: Populated /etc with preset unit settings. Nov 6 05:22:15.485892 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Nov 6 05:22:15.485905 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 6 05:22:15.485917 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 6 05:22:15.485937 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 6 05:22:15.485949 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 6 05:22:15.485963 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 6 05:22:15.485975 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 6 05:22:15.485991 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 6 05:22:15.486003 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 6 05:22:15.486026 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 6 05:22:15.486038 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 6 05:22:15.486050 systemd[1]: Created slice user.slice - User and Session Slice. Nov 6 05:22:15.486063 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 6 05:22:15.486075 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 6 05:22:15.486087 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 6 05:22:15.486100 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 6 05:22:15.486130 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 6 05:22:15.486152 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 6 05:22:15.486165 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 6 05:22:15.486177 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 6 05:22:15.486196 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 6 05:22:15.486208 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 6 05:22:15.486220 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 6 05:22:15.486232 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 6 05:22:15.486244 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 6 05:22:15.486264 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 6 05:22:15.486280 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 6 05:22:15.486292 systemd[1]: Reached target slices.target - Slice Units. Nov 6 05:22:15.486307 systemd[1]: Reached target swap.target - Swaps. Nov 6 05:22:15.486319 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 6 05:22:15.486332 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 6 05:22:15.486344 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 6 05:22:15.486356 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 6 05:22:15.486368 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 6 05:22:15.486381 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 6 05:22:15.486402 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 6 05:22:15.486414 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 6 05:22:15.486437 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 6 05:22:15.486451 systemd[1]: Mounting media.mount - External Media Directory... Nov 6 05:22:15.486463 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:15.486476 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 6 05:22:15.486494 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 6 05:22:15.486506 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 6 05:22:15.486530 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 6 05:22:15.486543 systemd[1]: Reached target machines.target - Containers. Nov 6 05:22:15.486555 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 6 05:22:15.486568 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 6 05:22:15.486580 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 6 05:22:15.486592 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 6 05:22:15.486605 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 6 05:22:15.486620 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 6 05:22:15.486632 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 6 05:22:15.486652 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 6 05:22:15.486664 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 6 05:22:15.486677 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 6 05:22:15.486689 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 6 05:22:15.486711 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 6 05:22:15.486725 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 6 05:22:15.486737 systemd[1]: Stopped systemd-fsck-usr.service. Nov 6 05:22:15.486750 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 6 05:22:15.486784 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 6 05:22:15.486803 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 6 05:22:15.486825 kernel: ACPI: bus type drm_connector registered Nov 6 05:22:15.486836 kernel: fuse: init (API version 7.41) Nov 6 05:22:15.486848 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 6 05:22:15.486861 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 6 05:22:15.486873 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 6 05:22:15.486886 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 6 05:22:15.486941 systemd-journald[1248]: Collecting audit messages is disabled. Nov 6 05:22:15.486966 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:15.486979 systemd-journald[1248]: Journal started Nov 6 05:22:15.487010 systemd-journald[1248]: Runtime Journal (/run/log/journal/c820db5e9e99454ab6d4f86a96b20aa4) is 6M, max 48.1M, 42M free. Nov 6 05:22:15.166783 systemd[1]: Queued start job for default target multi-user.target. Nov 6 05:22:15.193695 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 6 05:22:15.194258 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 6 05:22:15.492145 systemd[1]: Started systemd-journald.service - Journal Service. Nov 6 05:22:15.494163 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 6 05:22:15.496172 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 6 05:22:15.498110 systemd[1]: Mounted media.mount - External Media Directory. Nov 6 05:22:15.499903 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 6 05:22:15.501866 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 6 05:22:15.503805 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 6 05:22:15.505801 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 6 05:22:15.508041 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 6 05:22:15.510628 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 6 05:22:15.510914 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 6 05:22:15.513391 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 6 05:22:15.513679 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 6 05:22:15.516001 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 6 05:22:15.516265 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 6 05:22:15.518394 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 6 05:22:15.518642 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 6 05:22:15.520921 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 6 05:22:15.521162 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 6 05:22:15.523380 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 6 05:22:15.523733 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 6 05:22:15.525992 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 6 05:22:15.528176 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 6 05:22:15.530909 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 6 05:22:15.533710 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 6 05:22:15.552654 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 6 05:22:15.557308 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 6 05:22:15.560641 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 6 05:22:15.562542 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 6 05:22:15.562651 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 6 05:22:15.565495 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 6 05:22:15.574244 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 6 05:22:15.576339 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 6 05:22:15.579630 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 6 05:22:15.584281 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 6 05:22:15.586347 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 6 05:22:15.587412 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 6 05:22:15.589333 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 6 05:22:15.592055 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 6 05:22:15.596021 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 6 05:22:15.599863 systemd-journald[1248]: Time spent on flushing to /var/log/journal/c820db5e9e99454ab6d4f86a96b20aa4 is 36.846ms for 1044 entries. Nov 6 05:22:15.599863 systemd-journald[1248]: System Journal (/var/log/journal/c820db5e9e99454ab6d4f86a96b20aa4) is 8M, max 163.5M, 155.5M free. Nov 6 05:22:15.654360 systemd-journald[1248]: Received client request to flush runtime journal. Nov 6 05:22:15.654445 kernel: loop1: detected capacity change from 0 to 111544 Nov 6 05:22:15.600262 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 6 05:22:15.605789 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 6 05:22:15.608551 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 6 05:22:15.611211 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 6 05:22:15.613732 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 6 05:22:15.619495 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 6 05:22:15.625255 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 6 05:22:15.728950 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 6 05:22:15.731705 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 6 05:22:15.737397 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 6 05:22:15.741170 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 6 05:22:15.744242 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 6 05:22:15.747005 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 6 05:22:15.764467 kernel: loop2: detected capacity change from 0 to 119080 Nov 6 05:22:15.778770 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Nov 6 05:22:15.779169 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Nov 6 05:22:15.785610 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 6 05:22:15.912142 kernel: loop3: detected capacity change from 0 to 219144 Nov 6 05:22:15.933344 kernel: loop4: detected capacity change from 0 to 111544 Nov 6 05:22:15.945146 kernel: loop5: detected capacity change from 0 to 119080 Nov 6 05:22:15.956138 kernel: loop6: detected capacity change from 0 to 219144 Nov 6 05:22:15.968091 (sd-merge)[1303]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Nov 6 05:22:15.968698 (sd-merge)[1303]: Merged extensions into '/usr'. Nov 6 05:22:15.990899 systemd[1]: Reload requested from client PID 1282 ('systemd-sysext') (unit systemd-sysext.service)... Nov 6 05:22:15.991205 systemd[1]: Reloading... Nov 6 05:22:16.078150 zram_generator::config[1329]: No configuration found. Nov 6 05:22:16.284734 systemd[1]: Reloading finished in 292 ms. Nov 6 05:22:16.306465 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 6 05:22:16.318535 systemd[1]: Starting ensure-sysext.service... Nov 6 05:22:16.322233 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 6 05:22:16.353968 systemd[1]: Reload requested from client PID 1365 ('systemctl') (unit ensure-sysext.service)... Nov 6 05:22:16.354159 systemd[1]: Reloading... Nov 6 05:22:16.364202 ldconfig[1277]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 6 05:22:16.536150 zram_generator::config[1392]: No configuration found. Nov 6 05:22:16.559079 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 6 05:22:16.559142 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 6 05:22:16.559458 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 6 05:22:16.559714 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 6 05:22:16.560656 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 6 05:22:16.560944 systemd-tmpfiles[1366]: ACLs are not supported, ignoring. Nov 6 05:22:16.561018 systemd-tmpfiles[1366]: ACLs are not supported, ignoring. Nov 6 05:22:16.565980 systemd-tmpfiles[1366]: Detected autofs mount point /boot during canonicalization of boot. Nov 6 05:22:16.565996 systemd-tmpfiles[1366]: Skipping /boot Nov 6 05:22:16.576710 systemd-tmpfiles[1366]: Detected autofs mount point /boot during canonicalization of boot. Nov 6 05:22:16.576725 systemd-tmpfiles[1366]: Skipping /boot Nov 6 05:22:16.737614 systemd[1]: Reloading finished in 383 ms. Nov 6 05:22:16.762546 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 6 05:22:16.764911 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 6 05:22:16.794155 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 6 05:22:16.804966 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 6 05:22:16.808366 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 6 05:22:16.811581 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 6 05:22:16.830351 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 6 05:22:16.834882 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 6 05:22:16.839847 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 6 05:22:16.844799 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.844999 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 6 05:22:16.854675 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 6 05:22:16.860338 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 6 05:22:16.865386 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 6 05:22:16.867409 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 6 05:22:16.867529 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 6 05:22:16.867622 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.869494 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 6 05:22:16.873780 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 6 05:22:16.874200 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 6 05:22:16.876967 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 6 05:22:16.877364 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 6 05:22:16.880042 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 6 05:22:16.880474 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 6 05:22:16.888592 systemd-udevd[1438]: Using default interface naming scheme 'v255'. Nov 6 05:22:16.892804 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.893040 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 6 05:22:16.895349 augenrules[1466]: No rules Nov 6 05:22:16.896098 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 6 05:22:16.899642 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 6 05:22:16.906497 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 6 05:22:16.908261 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 6 05:22:16.908373 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 6 05:22:16.910013 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 6 05:22:16.913804 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 6 05:22:16.916283 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.918021 systemd[1]: audit-rules.service: Deactivated successfully. Nov 6 05:22:16.918313 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 6 05:22:16.920601 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 6 05:22:16.923421 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 6 05:22:16.923645 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 6 05:22:16.925807 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 6 05:22:16.928603 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 6 05:22:16.928872 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 6 05:22:16.931581 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 6 05:22:16.934326 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 6 05:22:16.934647 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 6 05:22:16.937412 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 6 05:22:16.953866 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.955994 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 6 05:22:16.957714 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 6 05:22:16.961310 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 6 05:22:16.967329 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 6 05:22:16.971818 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 6 05:22:16.977971 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 6 05:22:16.979712 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 6 05:22:16.979917 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 6 05:22:16.983393 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 6 05:22:16.985603 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 6 05:22:16.985718 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 6 05:22:16.987276 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 6 05:22:16.990167 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 6 05:22:16.998337 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 6 05:22:16.998577 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 6 05:22:17.000743 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 6 05:22:17.003465 systemd[1]: Finished ensure-sysext.service. Nov 6 05:22:17.005438 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 6 05:22:17.005856 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 6 05:22:17.007928 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 6 05:22:17.008324 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 6 05:22:17.011668 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 6 05:22:17.017597 augenrules[1502]: /sbin/augenrules: No change Nov 6 05:22:17.025833 augenrules[1534]: No rules Nov 6 05:22:17.053749 systemd[1]: audit-rules.service: Deactivated successfully. Nov 6 05:22:17.054737 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 6 05:22:17.067111 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 6 05:22:17.067229 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 6 05:22:17.069877 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 6 05:22:17.096223 kernel: mousedev: PS/2 mouse device common for all mice Nov 6 05:22:17.110154 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Nov 6 05:22:17.120145 kernel: ACPI: button: Power Button [PWRF] Nov 6 05:22:17.139405 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 6 05:22:17.140661 systemd-networkd[1508]: lo: Link UP Nov 6 05:22:17.140674 systemd-networkd[1508]: lo: Gained carrier Nov 6 05:22:17.150720 systemd-networkd[1508]: Enumeration completed Nov 6 05:22:17.151174 systemd-networkd[1508]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 6 05:22:17.151186 systemd-networkd[1508]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 6 05:22:17.151318 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 6 05:22:17.153230 systemd-networkd[1508]: eth0: Link UP Nov 6 05:22:17.153396 systemd-networkd[1508]: eth0: Gained carrier Nov 6 05:22:17.153418 systemd-networkd[1508]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 6 05:22:17.153734 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 6 05:22:17.159286 systemd-resolved[1437]: Positive Trust Anchors: Nov 6 05:22:17.159307 systemd-resolved[1437]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 6 05:22:17.159341 systemd-resolved[1437]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 6 05:22:17.166309 systemd-networkd[1508]: eth0: DHCPv4 address 10.0.0.35/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 6 05:22:17.166491 systemd-resolved[1437]: Defaulting to hostname 'linux'. Nov 6 05:22:17.167296 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 6 05:22:17.171768 systemd-timesyncd[1546]: Network configuration changed, trying to establish connection. Nov 6 05:22:17.720955 systemd-timesyncd[1546]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 6 05:22:17.721015 systemd-timesyncd[1546]: Initial clock synchronization to Thu 2025-11-06 05:22:17.720871 UTC. Nov 6 05:22:17.737186 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 6 05:22:17.739349 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 6 05:22:17.741602 systemd[1]: Reached target time-set.target - System Time Set. Nov 6 05:22:17.759365 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 6 05:22:17.761717 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 6 05:22:17.762719 systemd-resolved[1437]: Clock change detected. Flushing caches. Nov 6 05:22:17.764375 systemd[1]: Reached target network.target - Network. Nov 6 05:22:17.766179 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 6 05:22:17.769179 systemd[1]: Reached target sysinit.target - System Initialization. Nov 6 05:22:17.771067 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 6 05:22:17.773133 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 6 05:22:17.775162 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 6 05:22:17.778366 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 6 05:22:17.780311 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 6 05:22:17.782977 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 6 05:22:17.785109 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 6 05:22:17.785147 systemd[1]: Reached target paths.target - Path Units. Nov 6 05:22:17.787166 systemd[1]: Reached target timers.target - Timer Units. Nov 6 05:22:17.789625 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 6 05:22:17.793767 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 6 05:22:17.798336 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 6 05:22:17.801325 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 6 05:22:17.803312 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 6 05:22:17.826887 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Nov 6 05:22:17.827184 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 6 05:22:17.827349 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 6 05:22:17.840184 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 6 05:22:17.844216 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 6 05:22:17.847104 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 6 05:22:17.849372 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 6 05:22:17.852527 systemd[1]: Reached target sockets.target - Socket Units. Nov 6 05:22:17.855834 systemd[1]: Reached target basic.target - Basic System. Nov 6 05:22:17.857401 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 6 05:22:17.857436 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 6 05:22:17.860295 systemd[1]: Starting containerd.service - containerd container runtime... Nov 6 05:22:17.865358 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 6 05:22:17.871892 kernel: kvm_amd: TSC scaling supported Nov 6 05:22:17.871941 kernel: kvm_amd: Nested Virtualization enabled Nov 6 05:22:17.871955 kernel: kvm_amd: Nested Paging enabled Nov 6 05:22:17.871968 kernel: kvm_amd: LBR virtualization supported Nov 6 05:22:17.871980 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Nov 6 05:22:17.875260 kernel: kvm_amd: Virtual GIF supported Nov 6 05:22:17.876745 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 6 05:22:17.880355 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 6 05:22:17.885256 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 6 05:22:17.887001 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Nov 6 05:22:17.891320 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 6 05:22:17.894056 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 6 05:22:17.908307 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 6 05:22:17.914298 jq[1580]: false Nov 6 05:22:17.916328 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 6 05:22:17.924513 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Refreshing passwd entry cache Nov 6 05:22:17.924515 oslogin_cache_refresh[1582]: Refreshing passwd entry cache Nov 6 05:22:17.926303 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 6 05:22:17.928876 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 6 05:22:17.930469 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 6 05:22:17.934875 systemd[1]: Starting update-engine.service - Update Engine... Nov 6 05:22:17.938977 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 6 05:22:17.945250 extend-filesystems[1581]: Found /dev/vda6 Nov 6 05:22:17.948508 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Failure getting users, quitting Nov 6 05:22:17.948500 oslogin_cache_refresh[1582]: Failure getting users, quitting Nov 6 05:22:17.948577 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 6 05:22:17.948530 oslogin_cache_refresh[1582]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 6 05:22:17.948613 oslogin_cache_refresh[1582]: Refreshing group entry cache Nov 6 05:22:17.948658 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Refreshing group entry cache Nov 6 05:22:17.949865 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 6 05:22:17.952524 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 6 05:22:17.952786 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 6 05:22:17.953180 systemd[1]: motdgen.service: Deactivated successfully. Nov 6 05:22:17.953430 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 6 05:22:17.954945 jq[1595]: true Nov 6 05:22:17.955477 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 6 05:22:17.955930 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 6 05:22:17.958696 extend-filesystems[1581]: Found /dev/vda9 Nov 6 05:22:17.960013 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Failure getting groups, quitting Nov 6 05:22:17.960013 google_oslogin_nss_cache[1582]: oslogin_cache_refresh[1582]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 6 05:22:17.958738 oslogin_cache_refresh[1582]: Failure getting groups, quitting Nov 6 05:22:17.959815 oslogin_cache_refresh[1582]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 6 05:22:17.963312 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 6 05:22:17.965726 update_engine[1593]: I20251106 05:22:17.965648 1593 main.cc:92] Flatcar Update Engine starting Nov 6 05:22:17.967064 extend-filesystems[1581]: Checking size of /dev/vda9 Nov 6 05:22:17.966381 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 6 05:22:17.975111 kernel: EDAC MC: Ver: 3.0.0 Nov 6 05:22:17.989180 jq[1602]: true Nov 6 05:22:18.005108 extend-filesystems[1581]: Resized partition /dev/vda9 Nov 6 05:22:18.006457 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 6 05:22:18.014533 extend-filesystems[1620]: resize2fs 1.47.3 (8-Jul-2025) Nov 6 05:22:18.021126 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Nov 6 05:22:18.028438 dbus-daemon[1576]: [system] SELinux support is enabled Nov 6 05:22:18.040910 update_engine[1593]: I20251106 05:22:18.036285 1593 update_check_scheduler.cc:74] Next update check in 5m51s Nov 6 05:22:18.040201 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 6 05:22:18.043917 systemd-logind[1591]: Watching system buttons on /dev/input/event2 (Power Button) Nov 6 05:22:18.046142 systemd-logind[1591]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 6 05:22:18.046375 systemd-logind[1591]: New seat seat0. Nov 6 05:22:18.051142 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Nov 6 05:22:18.060267 systemd[1]: Started systemd-logind.service - User Login Management. Nov 6 05:22:18.061227 systemd[1]: Started update-engine.service - Update Engine. Nov 6 05:22:18.061721 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Nov 6 05:22:18.061738 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 6 05:22:18.063561 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 6 05:22:18.063575 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 6 05:22:18.067289 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 6 05:22:18.082516 extend-filesystems[1620]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 6 05:22:18.082516 extend-filesystems[1620]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 6 05:22:18.082516 extend-filesystems[1620]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Nov 6 05:22:18.084065 extend-filesystems[1581]: Resized filesystem in /dev/vda9 Nov 6 05:22:18.085883 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 6 05:22:18.093694 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 6 05:22:18.106823 bash[1640]: Updated "/home/core/.ssh/authorized_keys" Nov 6 05:22:18.143153 locksmithd[1632]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 6 05:22:18.157841 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 6 05:22:18.162137 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 6 05:22:18.171163 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 6 05:22:18.239017 containerd[1605]: time="2025-11-06T05:22:18Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 6 05:22:18.240010 containerd[1605]: time="2025-11-06T05:22:18.239946557Z" level=info msg="starting containerd" revision=75cb2b7193e4e490e9fbdc236c0e811ccaba3376 version=v2.1.4 Nov 6 05:22:18.250332 containerd[1605]: time="2025-11-06T05:22:18.250248386Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.993µs" Nov 6 05:22:18.250332 containerd[1605]: time="2025-11-06T05:22:18.250304932Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 6 05:22:18.250417 containerd[1605]: time="2025-11-06T05:22:18.250372369Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 6 05:22:18.250417 containerd[1605]: time="2025-11-06T05:22:18.250390553Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 6 05:22:18.250711 containerd[1605]: time="2025-11-06T05:22:18.250683883Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 6 05:22:18.250711 containerd[1605]: time="2025-11-06T05:22:18.250708569Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 6 05:22:18.250822 containerd[1605]: time="2025-11-06T05:22:18.250794430Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 6 05:22:18.250822 containerd[1605]: time="2025-11-06T05:22:18.250814518Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251292 containerd[1605]: time="2025-11-06T05:22:18.251245566Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251292 containerd[1605]: time="2025-11-06T05:22:18.251272407Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251292 containerd[1605]: time="2025-11-06T05:22:18.251287335Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251377 containerd[1605]: time="2025-11-06T05:22:18.251298165Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251526 containerd[1605]: time="2025-11-06T05:22:18.251493541Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251526 containerd[1605]: time="2025-11-06T05:22:18.251516895Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251642 containerd[1605]: time="2025-11-06T05:22:18.251614779Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251870 containerd[1605]: time="2025-11-06T05:22:18.251834220Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251897 containerd[1605]: time="2025-11-06T05:22:18.251878684Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 6 05:22:18.251897 containerd[1605]: time="2025-11-06T05:22:18.251890877Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 6 05:22:18.251960 containerd[1605]: time="2025-11-06T05:22:18.251938266Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 6 05:22:18.253823 containerd[1605]: time="2025-11-06T05:22:18.253575837Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 6 05:22:18.253823 containerd[1605]: time="2025-11-06T05:22:18.253692085Z" level=info msg="metadata content store policy set" policy=shared Nov 6 05:22:18.259183 containerd[1605]: time="2025-11-06T05:22:18.259145702Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 6 05:22:18.259227 containerd[1605]: time="2025-11-06T05:22:18.259198952Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 6 05:22:18.259336 containerd[1605]: time="2025-11-06T05:22:18.259306283Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 6 05:22:18.259336 containerd[1605]: time="2025-11-06T05:22:18.259324547Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 6 05:22:18.259379 containerd[1605]: time="2025-11-06T05:22:18.259339816Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 6 05:22:18.259379 containerd[1605]: time="2025-11-06T05:22:18.259354674Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 6 05:22:18.259379 containerd[1605]: time="2025-11-06T05:22:18.259368840Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 6 05:22:18.259448 containerd[1605]: time="2025-11-06T05:22:18.259380733Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 6 05:22:18.259448 containerd[1605]: time="2025-11-06T05:22:18.259405820Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 6 05:22:18.259448 containerd[1605]: time="2025-11-06T05:22:18.259420567Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 6 05:22:18.259448 containerd[1605]: time="2025-11-06T05:22:18.259434333Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 6 05:22:18.259448 containerd[1605]: time="2025-11-06T05:22:18.259446406Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 6 05:22:18.259543 containerd[1605]: time="2025-11-06T05:22:18.259457757Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 6 05:22:18.259543 containerd[1605]: time="2025-11-06T05:22:18.259471543Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 6 05:22:18.259599 containerd[1605]: time="2025-11-06T05:22:18.259582802Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 6 05:22:18.259622 containerd[1605]: time="2025-11-06T05:22:18.259611145Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 6 05:22:18.259649 containerd[1605]: time="2025-11-06T05:22:18.259632194Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 6 05:22:18.259675 containerd[1605]: time="2025-11-06T05:22:18.259649747Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 6 05:22:18.259675 containerd[1605]: time="2025-11-06T05:22:18.259661700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 6 05:22:18.259675 containerd[1605]: time="2025-11-06T05:22:18.259671939Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 6 05:22:18.259733 containerd[1605]: time="2025-11-06T05:22:18.259683420Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 6 05:22:18.259733 containerd[1605]: time="2025-11-06T05:22:18.259694732Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 6 05:22:18.259733 containerd[1605]: time="2025-11-06T05:22:18.259706153Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 6 05:22:18.259733 containerd[1605]: time="2025-11-06T05:22:18.259717144Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 6 05:22:18.259733 containerd[1605]: time="2025-11-06T05:22:18.259727203Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 6 05:22:18.259825 containerd[1605]: time="2025-11-06T05:22:18.259750546Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 6 05:22:18.259825 containerd[1605]: time="2025-11-06T05:22:18.259789159Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 6 05:22:18.259825 containerd[1605]: time="2025-11-06T05:22:18.259800801Z" level=info msg="Start snapshots syncer" Nov 6 05:22:18.259914 containerd[1605]: time="2025-11-06T05:22:18.259832821Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 6 05:22:18.260145 containerd[1605]: time="2025-11-06T05:22:18.260111183Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 6 05:22:18.260279 containerd[1605]: time="2025-11-06T05:22:18.260161427Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 6 05:22:18.260279 containerd[1605]: time="2025-11-06T05:22:18.260242309Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 6 05:22:18.260363 containerd[1605]: time="2025-11-06T05:22:18.260341645Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 6 05:22:18.260389 containerd[1605]: time="2025-11-06T05:22:18.260366351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 6 05:22:18.260410 containerd[1605]: time="2025-11-06T05:22:18.260387080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 6 05:22:18.260410 containerd[1605]: time="2025-11-06T05:22:18.260399754Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 6 05:22:18.260447 containerd[1605]: time="2025-11-06T05:22:18.260410955Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 6 05:22:18.260447 containerd[1605]: time="2025-11-06T05:22:18.260421495Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 6 05:22:18.260447 containerd[1605]: time="2025-11-06T05:22:18.260431373Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 6 05:22:18.260447 containerd[1605]: time="2025-11-06T05:22:18.260441482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260451801Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260482659Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260494562Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260502657Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260512445Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 6 05:22:18.260523 containerd[1605]: time="2025-11-06T05:22:18.260520841Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260530369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260540758Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260553242Z" level=info msg="runtime interface created" Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260558732Z" level=info msg="created NRI interface" Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260580883Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260593026Z" level=info msg="Connect containerd service" Nov 6 05:22:18.260634 containerd[1605]: time="2025-11-06T05:22:18.260610810Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 6 05:22:18.261394 containerd[1605]: time="2025-11-06T05:22:18.261359754Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356391853Z" level=info msg="Start subscribing containerd event" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356464269Z" level=info msg="Start recovering state" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356599463Z" level=info msg="Start event monitor" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356615232Z" level=info msg="Start cni network conf syncer for default" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356630952Z" level=info msg="Start streaming server" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356643405Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356656139Z" level=info msg="runtime interface starting up..." Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356663342Z" level=info msg="starting plugins..." Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356680134Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356815858Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.356937777Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 6 05:22:18.358065 containerd[1605]: time="2025-11-06T05:22:18.357025902Z" level=info msg="containerd successfully booted in 0.118563s" Nov 6 05:22:18.357234 systemd[1]: Started containerd.service - containerd container runtime. Nov 6 05:22:18.517233 sshd_keygen[1603]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 6 05:22:18.544238 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 6 05:22:18.547889 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 6 05:22:18.567526 systemd[1]: issuegen.service: Deactivated successfully. Nov 6 05:22:18.567784 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 6 05:22:18.570979 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 6 05:22:18.593981 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 6 05:22:18.597337 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 6 05:22:18.600051 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 6 05:22:18.601973 systemd[1]: Reached target getty.target - Login Prompts. Nov 6 05:22:18.813363 systemd-networkd[1508]: eth0: Gained IPv6LL Nov 6 05:22:18.816717 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 6 05:22:18.819301 systemd[1]: Reached target network-online.target - Network is Online. Nov 6 05:22:18.822770 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 6 05:22:18.825806 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 6 05:22:18.828666 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 6 05:22:18.860362 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 6 05:22:18.863003 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 6 05:22:18.863277 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 6 05:22:18.866364 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 6 05:22:20.707649 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 6 05:22:20.711215 systemd[1]: Started sshd@0-10.0.0.35:22-10.0.0.1:44260.service - OpenSSH per-connection server daemon (10.0.0.1:44260). Nov 6 05:22:20.856035 sshd[1710]: Accepted publickey for core from 10.0.0.1 port 44260 ssh2: RSA SHA256:hvL/1SQKBl4/SY5LMsAsBLqCMXNmHfCcuNAV0hHCw5c Nov 6 05:22:20.860057 sshd-session[1710]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 6 05:22:20.870768 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 6 05:22:20.874936 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 6 05:22:20.889628 systemd-logind[1591]: New session 1 of user core. Nov 6 05:22:20.910369 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 6 05:22:20.916569 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 6 05:22:20.933958 (systemd)[1715]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 6 05:22:20.937337 systemd-logind[1591]: New session c1 of user core. Nov 6 05:22:21.094856 systemd[1715]: Queued start job for default target default.target. Nov 6 05:22:21.104509 systemd[1715]: Created slice app.slice - User Application Slice. Nov 6 05:22:21.104537 systemd[1715]: Reached target paths.target - Paths. Nov 6 05:22:21.104682 systemd[1715]: Reached target timers.target - Timers. Nov 6 05:22:21.106382 systemd[1715]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 6 05:22:21.119316 systemd[1715]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 6 05:22:21.119454 systemd[1715]: Reached target sockets.target - Sockets. Nov 6 05:22:21.119493 systemd[1715]: Reached target basic.target - Basic System. Nov 6 05:22:21.119535 systemd[1715]: Reached target default.target - Main User Target. Nov 6 05:22:21.119575 systemd[1715]: Startup finished in 174ms. Nov 6 05:22:21.120237 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 6 05:22:21.130322 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 6 05:22:21.134225 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 6 05:22:21.137622 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 6 05:22:21.141156 systemd[1]: Startup finished in 3.323s (kernel) + 6.621s (initrd) + 6.142s (userspace) = 16.087s. Nov 6 05:22:21.143068 (kubelet)[1727]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 6 05:22:21.159311 systemd[1]: Started sshd@1-10.0.0.35:22-10.0.0.1:44274.service - OpenSSH per-connection server daemon (10.0.0.1:44274). Nov 6 05:22:21.213390 sshd[1734]: Accepted publickey for core from 10.0.0.1 port 44274 ssh2: RSA SHA256:hvL/1SQKBl4/SY5LMsAsBLqCMXNmHfCcuNAV0hHCw5c Nov 6 05:22:21.216031 sshd-session[1734]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 6 05:22:21.222784 systemd-logind[1591]: New session 2 of user core. Nov 6 05:22:21.415485 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 6 05:22:21.430565 sshd[1739]: Connection closed by 10.0.0.1 port 44274 Nov 6 05:22:21.430925 sshd-session[1734]: pam_unix(sshd:session): session closed for user core Nov 6 05:22:21.443561 systemd[1]: sshd@1-10.0.0.35:22-10.0.0.1:44274.service: Deactivated successfully. Nov 6 05:22:21.446148 systemd[1]: session-2.scope: Deactivated successfully. Nov 6 05:22:21.447022 systemd-logind[1591]: Session 2 logged out. Waiting for processes to exit. Nov 6 05:22:21.449977 systemd[1]: Started sshd@2-10.0.0.35:22-10.0.0.1:44282.service - OpenSSH per-connection server daemon (10.0.0.1:44282). Nov 6 05:22:21.450753 systemd-logind[1591]: Removed session 2. Nov 6 05:22:21.556162 sshd[1746]: Accepted publickey for core from 10.0.0.1 port 44282 ssh2: RSA SHA256:hvL/1SQKBl4/SY5LMsAsBLqCMXNmHfCcuNAV0hHCw5c Nov 6 05:22:21.557500 sshd-session[1746]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 6 05:22:21.562113 systemd-logind[1591]: New session 3 of user core. Nov 6 05:22:21.571216 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 6 05:22:21.582017 sshd[1753]: Connection closed by 10.0.0.1 port 44282 Nov 6 05:22:21.582346 sshd-session[1746]: pam_unix(sshd:session): session closed for user core Nov 6 05:22:21.590606 systemd[1]: sshd@2-10.0.0.35:22-10.0.0.1:44282.service: Deactivated successfully. Nov 6 05:22:21.592711 systemd[1]: session-3.scope: Deactivated successfully. Nov 6 05:22:21.593426 systemd-logind[1591]: Session 3 logged out. Waiting for processes to exit. Nov 6 05:22:21.596373 systemd[1]: Started sshd@3-10.0.0.35:22-10.0.0.1:44284.service - OpenSSH per-connection server daemon (10.0.0.1:44284). Nov 6 05:22:21.597073 systemd-logind[1591]: Removed session 3. Nov 6 05:22:21.646961 sshd[1759]: Accepted publickey for core from 10.0.0.1 port 44284 ssh2: RSA SHA256:hvL/1SQKBl4/SY5LMsAsBLqCMXNmHfCcuNAV0hHCw5c Nov 6 05:22:21.648321 sshd-session[1759]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 6 05:22:21.653755 systemd-logind[1591]: New session 4 of user core. Nov 6 05:22:21.670418 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 6 05:22:21.688226 sshd[1762]: Connection closed by 10.0.0.1 port 44284 Nov 6 05:22:21.691299 sshd-session[1759]: pam_unix(sshd:session): session closed for user core Nov 6 05:22:21.699941 systemd[1]: sshd@3-10.0.0.35:22-10.0.0.1:44284.service: Deactivated successfully. Nov 6 05:22:21.701946 systemd[1]: session-4.scope: Deactivated successfully. Nov 6 05:22:21.702783 systemd-logind[1591]: Session 4 logged out. Waiting for processes to exit. Nov 6 05:22:21.705531 systemd[1]: Started sshd@4-10.0.0.35:22-10.0.0.1:44298.service - OpenSSH per-connection server daemon (10.0.0.1:44298). Nov 6 05:22:21.706463 systemd-logind[1591]: Removed session 4. Nov 6 05:22:21.775592 sshd[1769]: Accepted publickey for core from 10.0.0.1 port 44298 ssh2: RSA SHA256:hvL/1SQKBl4/SY5LMsAsBLqCMXNmHfCcuNAV0hHCw5c Nov 6 05:22:21.777726 sshd-session[1769]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 6 05:22:21.782738 systemd-logind[1591]: New session 5 of user core. Nov 6 05:22:21.789227 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 6 05:22:21.815181 sudo[1773]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 6 05:22:21.815505 sudo[1773]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 6 05:22:21.833489 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 6 05:22:21.880242 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 6 05:22:21.880569 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 6 05:22:21.900194 kubelet[1727]: E1106 05:22:21.900116 1727 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Nov 6 05:22:21.905335 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 6 05:22:21.905577 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 6 05:22:21.906077 systemd[1]: kubelet.service: Consumed 2.887s CPU time, 257.6M memory peak. Nov 6 05:22:22.457238 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 6 05:22:22.457467 systemd[1]: kubelet.service: Consumed 2.887s CPU time, 257.6M memory peak. Nov 6 05:22:22.459858 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 6 05:22:22.489704 systemd[1]: Reload requested from client PID 1817 ('systemctl') (unit session-5.scope)... Nov 6 05:22:22.489726 systemd[1]: Reloading... Nov 6 05:22:22.589145 zram_generator::config[1865]: No configuration found. Nov 6 05:22:22.856158 systemd[1]: Reloading finished in 365 ms. Nov 6 05:22:22.951866 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Nov 6 05:22:22.951969 systemd[1]: kubelet.service: Failed with result 'signal'. Nov 6 05:22:22.952371 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 6 05:22:22.952430 systemd[1]: kubelet.service: Consumed 227ms CPU time, 98.2M memory peak. Nov 6 05:22:22.954303 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 6 05:22:23.139246 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 6 05:22:23.148445 (kubelet)[1907]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Nov 6 05:22:23.279062 kubelet[1907]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 6 05:22:23.279062 kubelet[1907]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Nov 6 05:22:23.279960 kubelet[1907]: I1106 05:22:23.279161 1907 server.go:213] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Nov 6 05:22:23.872656 kubelet[1907]: I1106 05:22:23.872598 1907 server.go:529] "Kubelet version" kubeletVersion="v1.34.1" Nov 6 05:22:23.872656 kubelet[1907]: I1106 05:22:23.872629 1907 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 6 05:22:23.872656 kubelet[1907]: I1106 05:22:23.872667 1907 watchdog_linux.go:95] "Systemd watchdog is not enabled" Nov 6 05:22:23.872862 kubelet[1907]: I1106 05:22:23.872681 1907 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 6 05:22:23.872982 kubelet[1907]: I1106 05:22:23.872949 1907 server.go:956] "Client rotation is on, will bootstrap in background" Nov 6 05:22:23.878141 kubelet[1907]: I1106 05:22:23.878022 1907 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 6 05:22:23.882282 kubelet[1907]: I1106 05:22:23.882232 1907 server.go:1423] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Nov 6 05:22:23.888233 kubelet[1907]: I1106 05:22:23.888182 1907 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Nov 6 05:22:23.888519 kubelet[1907]: I1106 05:22:23.888477 1907 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 6 05:22:23.888848 kubelet[1907]: I1106 05:22:23.888511 1907 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.35","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Nov 6 05:22:23.889124 kubelet[1907]: I1106 05:22:23.888856 1907 topology_manager.go:138] "Creating topology manager with none policy" Nov 6 05:22:23.889124 kubelet[1907]: I1106 05:22:23.888868 1907 container_manager_linux.go:306] "Creating device plugin manager" Nov 6 05:22:23.889124 kubelet[1907]: I1106 05:22:23.889033 1907 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Nov 6 05:22:23.892809 kubelet[1907]: I1106 05:22:23.892767 1907 state_mem.go:36] "Initialized new in-memory state store" Nov 6 05:22:23.893042 kubelet[1907]: I1106 05:22:23.893009 1907 kubelet.go:475] "Attempting to sync node with API server" Nov 6 05:22:23.893042 kubelet[1907]: I1106 05:22:23.893027 1907 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 6 05:22:23.893131 kubelet[1907]: I1106 05:22:23.893067 1907 kubelet.go:387] "Adding apiserver pod source" Nov 6 05:22:23.893131 kubelet[1907]: I1106 05:22:23.893116 1907 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 6 05:22:23.893187 kubelet[1907]: E1106 05:22:23.893171 1907 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:23.893264 kubelet[1907]: E1106 05:22:23.893239 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:23.896029 kubelet[1907]: I1106 05:22:23.895996 1907 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v2.1.4" apiVersion="v1" Nov 6 05:22:23.896620 kubelet[1907]: I1106 05:22:23.896587 1907 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Nov 6 05:22:23.896620 kubelet[1907]: I1106 05:22:23.896616 1907 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Nov 6 05:22:23.896748 kubelet[1907]: W1106 05:22:23.896728 1907 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 6 05:22:23.897953 kubelet[1907]: E1106 05:22:23.897916 1907 reflector.go:205] "Failed to watch" err="failed to list *v1.Node: nodes \"10.0.0.35\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Node" Nov 6 05:22:23.898155 kubelet[1907]: E1106 05:22:23.898128 1907 reflector.go:205] "Failed to watch" err="failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" Nov 6 05:22:23.901228 kubelet[1907]: I1106 05:22:23.901200 1907 server.go:1262] "Started kubelet" Nov 6 05:22:23.901702 kubelet[1907]: I1106 05:22:23.901637 1907 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Nov 6 05:22:23.905105 kubelet[1907]: I1106 05:22:23.905050 1907 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 6 05:22:23.905283 kubelet[1907]: I1106 05:22:23.905261 1907 server_v1.go:49] "podresources" method="list" useActivePods=true Nov 6 05:22:23.905761 kubelet[1907]: I1106 05:22:23.905718 1907 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 6 05:22:23.905863 kubelet[1907]: I1106 05:22:23.905323 1907 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 6 05:22:23.907543 kubelet[1907]: I1106 05:22:23.907038 1907 volume_manager.go:313] "Starting Kubelet Volume Manager" Nov 6 05:22:23.907606 kubelet[1907]: I1106 05:22:23.907595 1907 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Nov 6 05:22:23.907774 kubelet[1907]: I1106 05:22:23.907752 1907 reconciler.go:29] "Reconciler: start to sync state" Nov 6 05:22:23.909790 kubelet[1907]: I1106 05:22:23.909439 1907 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 6 05:22:23.909790 kubelet[1907]: E1106 05:22:23.909457 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:23.933168 kubelet[1907]: I1106 05:22:23.933053 1907 factory.go:223] Registration of the systemd container factory successfully Nov 6 05:22:23.933361 kubelet[1907]: I1106 05:22:23.933223 1907 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Nov 6 05:22:23.934451 kubelet[1907]: E1106 05:22:23.934412 1907 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 6 05:22:23.934507 kubelet[1907]: I1106 05:22:23.934497 1907 factory.go:223] Registration of the containerd container factory successfully Nov 6 05:22:23.941532 kubelet[1907]: I1106 05:22:23.940644 1907 server.go:310] "Adding debug handlers to kubelet server" Nov 6 05:22:23.943487 kubelet[1907]: E1106 05:22:23.943423 1907 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.35\" not found" node="10.0.0.35" Nov 6 05:22:23.950491 kubelet[1907]: I1106 05:22:23.950459 1907 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 6 05:22:23.950491 kubelet[1907]: I1106 05:22:23.950480 1907 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 6 05:22:23.950491 kubelet[1907]: I1106 05:22:23.950500 1907 state_mem.go:36] "Initialized new in-memory state store" Nov 6 05:22:23.953201 kubelet[1907]: I1106 05:22:23.953182 1907 policy_none.go:49] "None policy: Start" Nov 6 05:22:23.953201 kubelet[1907]: I1106 05:22:23.953206 1907 memory_manager.go:187] "Starting memorymanager" policy="None" Nov 6 05:22:23.953273 kubelet[1907]: I1106 05:22:23.953219 1907 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Nov 6 05:22:23.955908 kubelet[1907]: I1106 05:22:23.955872 1907 policy_none.go:47] "Start" Nov 6 05:22:23.964210 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Nov 6 05:22:23.974898 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Nov 6 05:22:23.979584 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Nov 6 05:22:23.989643 kubelet[1907]: E1106 05:22:23.989617 1907 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Nov 6 05:22:23.989981 kubelet[1907]: I1106 05:22:23.989960 1907 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 6 05:22:23.990111 kubelet[1907]: I1106 05:22:23.990059 1907 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 6 05:22:23.990454 kubelet[1907]: I1106 05:22:23.990430 1907 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 6 05:22:23.993033 kubelet[1907]: E1106 05:22:23.992917 1907 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 6 05:22:23.993033 kubelet[1907]: E1106 05:22:23.992982 1907 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.35\" not found" Nov 6 05:22:24.011776 kubelet[1907]: I1106 05:22:24.011708 1907 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Nov 6 05:22:24.013558 kubelet[1907]: I1106 05:22:24.013526 1907 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Nov 6 05:22:24.013558 kubelet[1907]: I1106 05:22:24.013567 1907 status_manager.go:244] "Starting to sync pod status with apiserver" Nov 6 05:22:24.013731 kubelet[1907]: I1106 05:22:24.013604 1907 kubelet.go:2427] "Starting kubelet main sync loop" Nov 6 05:22:24.013731 kubelet[1907]: E1106 05:22:24.013663 1907 kubelet.go:2451] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Nov 6 05:22:24.093592 kubelet[1907]: I1106 05:22:24.093532 1907 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.35" Nov 6 05:22:24.097781 kubelet[1907]: I1106 05:22:24.097720 1907 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.35" Nov 6 05:22:24.097781 kubelet[1907]: E1106 05:22:24.097747 1907 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"10.0.0.35\": node \"10.0.0.35\" not found" Nov 6 05:22:24.110464 kubelet[1907]: E1106 05:22:24.110413 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.155879 sudo[1773]: pam_unix(sudo:session): session closed for user root Nov 6 05:22:24.157602 sshd[1772]: Connection closed by 10.0.0.1 port 44298 Nov 6 05:22:24.158134 sshd-session[1769]: pam_unix(sshd:session): session closed for user core Nov 6 05:22:24.162307 systemd[1]: sshd@4-10.0.0.35:22-10.0.0.1:44298.service: Deactivated successfully. Nov 6 05:22:24.164862 systemd[1]: session-5.scope: Deactivated successfully. Nov 6 05:22:24.165078 systemd[1]: session-5.scope: Consumed 625ms CPU time, 76.7M memory peak. Nov 6 05:22:24.167394 systemd-logind[1591]: Session 5 logged out. Waiting for processes to exit. Nov 6 05:22:24.168796 systemd-logind[1591]: Removed session 5. Nov 6 05:22:24.210672 kubelet[1907]: E1106 05:22:24.210561 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.311366 kubelet[1907]: E1106 05:22:24.311244 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.412242 kubelet[1907]: E1106 05:22:24.411990 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.513134 kubelet[1907]: E1106 05:22:24.513019 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.613942 kubelet[1907]: E1106 05:22:24.613842 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.714737 kubelet[1907]: E1106 05:22:24.714511 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.815275 kubelet[1907]: E1106 05:22:24.815165 1907 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.35\" not found" Nov 6 05:22:24.876651 kubelet[1907]: I1106 05:22:24.876592 1907 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 6 05:22:24.876809 kubelet[1907]: I1106 05:22:24.876766 1907 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Nov 6 05:22:24.876809 kubelet[1907]: I1106 05:22:24.876773 1907 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Nov 6 05:22:24.876809 kubelet[1907]: I1106 05:22:24.876788 1907 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Nov 6 05:22:24.893550 kubelet[1907]: I1106 05:22:24.893516 1907 apiserver.go:52] "Watching apiserver" Nov 6 05:22:24.893653 kubelet[1907]: E1106 05:22:24.893525 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:24.914367 kubelet[1907]: I1106 05:22:24.914312 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/b3f756e9-0928-483a-9b1a-60dcfa09a77b-cni\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.914472 kubelet[1907]: I1106 05:22:24.914382 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/b3f756e9-0928-483a-9b1a-60dcfa09a77b-flannel-cfg\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.920298 kubelet[1907]: I1106 05:22:24.919432 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/b3f756e9-0928-483a-9b1a-60dcfa09a77b-xtables-lock\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.920298 kubelet[1907]: I1106 05:22:24.919488 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-nkc6z\" (UniqueName: \"kubernetes.io/projected/b3f756e9-0928-483a-9b1a-60dcfa09a77b-kube-api-access-nkc6z\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.920298 kubelet[1907]: I1106 05:22:24.919574 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/b3f756e9-0928-483a-9b1a-60dcfa09a77b-run\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.920298 kubelet[1907]: I1106 05:22:24.919594 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/b3f756e9-0928-483a-9b1a-60dcfa09a77b-cni-plugin\") pod \"kube-flannel-ds-hxdzw\" (UID: \"b3f756e9-0928-483a-9b1a-60dcfa09a77b\") " pod="kube-flannel/kube-flannel-ds-hxdzw" Nov 6 05:22:24.982492 kubelet[1907]: I1106 05:22:24.981954 1907 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 6 05:22:24.983336 containerd[1605]: time="2025-11-06T05:22:24.983278501Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 6 05:22:24.984332 kubelet[1907]: I1106 05:22:24.983702 1907 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 6 05:22:24.987367 systemd[1]: Created slice kubepods-burstable-podb3f756e9_0928_483a_9b1a_60dcfa09a77b.slice - libcontainer container kubepods-burstable-podb3f756e9_0928_483a_9b1a_60dcfa09a77b.slice. Nov 6 05:22:25.006017 systemd[1]: Created slice kubepods-besteffort-pod3428d832_b09c_428a_86ef_ffe550d3ad0f.slice - libcontainer container kubepods-besteffort-pod3428d832_b09c_428a_86ef_ffe550d3ad0f.slice. Nov 6 05:22:25.008290 kubelet[1907]: I1106 05:22:25.008264 1907 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Nov 6 05:22:25.019923 kubelet[1907]: I1106 05:22:25.019873 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/3428d832-b09c-428a-86ef-ffe550d3ad0f-xtables-lock\") pod \"kube-proxy-hpkqd\" (UID: \"3428d832-b09c-428a-86ef-ffe550d3ad0f\") " pod="kube-system/kube-proxy-hpkqd" Nov 6 05:22:25.019923 kubelet[1907]: I1106 05:22:25.019906 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/3428d832-b09c-428a-86ef-ffe550d3ad0f-lib-modules\") pod \"kube-proxy-hpkqd\" (UID: \"3428d832-b09c-428a-86ef-ffe550d3ad0f\") " pod="kube-system/kube-proxy-hpkqd" Nov 6 05:22:25.020143 kubelet[1907]: I1106 05:22:25.019944 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/3428d832-b09c-428a-86ef-ffe550d3ad0f-kube-proxy\") pod \"kube-proxy-hpkqd\" (UID: \"3428d832-b09c-428a-86ef-ffe550d3ad0f\") " pod="kube-system/kube-proxy-hpkqd" Nov 6 05:22:25.020143 kubelet[1907]: I1106 05:22:25.019962 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-wrgpv\" (UniqueName: \"kubernetes.io/projected/3428d832-b09c-428a-86ef-ffe550d3ad0f-kube-api-access-wrgpv\") pod \"kube-proxy-hpkqd\" (UID: \"3428d832-b09c-428a-86ef-ffe550d3ad0f\") " pod="kube-system/kube-proxy-hpkqd" Nov 6 05:22:25.308251 kubelet[1907]: E1106 05:22:25.308130 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:25.309060 containerd[1605]: time="2025-11-06T05:22:25.309003522Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-hxdzw,Uid:b3f756e9-0928-483a-9b1a-60dcfa09a77b,Namespace:kube-flannel,Attempt:0,}" Nov 6 05:22:25.320204 kubelet[1907]: E1106 05:22:25.320155 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:25.320699 containerd[1605]: time="2025-11-06T05:22:25.320621850Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-hpkqd,Uid:3428d832-b09c-428a-86ef-ffe550d3ad0f,Namespace:kube-system,Attempt:0,}" Nov 6 05:22:25.884955 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount51226438.mount: Deactivated successfully. Nov 6 05:22:25.893006 containerd[1605]: time="2025-11-06T05:22:25.892943017Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 6 05:22:25.894263 kubelet[1907]: E1106 05:22:25.894230 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:25.895477 containerd[1605]: time="2025-11-06T05:22:25.895431213Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 6 05:22:25.897834 containerd[1605]: time="2025-11-06T05:22:25.897786210Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 6 05:22:25.898673 containerd[1605]: time="2025-11-06T05:22:25.898620404Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 6 05:22:25.899578 containerd[1605]: time="2025-11-06T05:22:25.899521203Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 6 05:22:25.901337 containerd[1605]: time="2025-11-06T05:22:25.901294930Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 6 05:22:25.902110 containerd[1605]: time="2025-11-06T05:22:25.902045157Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 574.782031ms" Nov 6 05:22:25.904195 containerd[1605]: time="2025-11-06T05:22:25.904148471Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 587.783524ms" Nov 6 05:22:25.979010 containerd[1605]: time="2025-11-06T05:22:25.978938138Z" level=info msg="connecting to shim 9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7" address="unix:///run/containerd/s/9e4c3e3058f984997fe5d89dd6149d1426e5baf1032300f24819a740b57e19e2" namespace=k8s.io protocol=ttrpc version=3 Nov 6 05:22:25.980058 containerd[1605]: time="2025-11-06T05:22:25.979996553Z" level=info msg="connecting to shim 0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb" address="unix:///run/containerd/s/1ab0f070962e82b3346b9d8bd87049bf7492a305e78439205546ade54503ebad" namespace=k8s.io protocol=ttrpc version=3 Nov 6 05:22:26.006241 systemd[1]: Started cri-containerd-9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7.scope - libcontainer container 9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7. Nov 6 05:22:26.009999 systemd[1]: Started cri-containerd-0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb.scope - libcontainer container 0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb. Nov 6 05:22:26.043730 containerd[1605]: time="2025-11-06T05:22:26.043670124Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-hpkqd,Uid:3428d832-b09c-428a-86ef-ffe550d3ad0f,Namespace:kube-system,Attempt:0,} returns sandbox id \"9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7\"" Nov 6 05:22:26.045696 kubelet[1907]: E1106 05:22:26.045559 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:26.048318 containerd[1605]: time="2025-11-06T05:22:26.048264290Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.1\"" Nov 6 05:22:26.059830 containerd[1605]: time="2025-11-06T05:22:26.059776279Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-hxdzw,Uid:b3f756e9-0928-483a-9b1a-60dcfa09a77b,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\"" Nov 6 05:22:26.060767 kubelet[1907]: E1106 05:22:26.060740 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:26.894768 kubelet[1907]: E1106 05:22:26.894718 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:27.148748 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount115198512.mount: Deactivated successfully. Nov 6 05:22:27.797586 containerd[1605]: time="2025-11-06T05:22:27.797496294Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:27.798356 containerd[1605]: time="2025-11-06T05:22:27.798303458Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.1: active requests=0, bytes read=0" Nov 6 05:22:27.799525 containerd[1605]: time="2025-11-06T05:22:27.799487619Z" level=info msg="ImageCreate event name:\"sha256:fc25172553d79197ecd840ec8dba1fba68330079355e974b04c1a441e6a4a0b7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:27.801304 containerd[1605]: time="2025-11-06T05:22:27.801266174Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:913cc83ca0b5588a81d86ce8eedeb3ed1e9c1326e81852a1ea4f622b74ff749a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:27.801822 containerd[1605]: time="2025-11-06T05:22:27.801780819Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.1\" with image id \"sha256:fc25172553d79197ecd840ec8dba1fba68330079355e974b04c1a441e6a4a0b7\", repo tag \"registry.k8s.io/kube-proxy:v1.34.1\", repo digest \"registry.k8s.io/kube-proxy@sha256:913cc83ca0b5588a81d86ce8eedeb3ed1e9c1326e81852a1ea4f622b74ff749a\", size \"25963718\" in 1.753461396s" Nov 6 05:22:27.801822 containerd[1605]: time="2025-11-06T05:22:27.801818189Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.1\" returns image reference \"sha256:fc25172553d79197ecd840ec8dba1fba68330079355e974b04c1a441e6a4a0b7\"" Nov 6 05:22:27.803108 containerd[1605]: time="2025-11-06T05:22:27.803053175Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Nov 6 05:22:27.808517 containerd[1605]: time="2025-11-06T05:22:27.808481225Z" level=info msg="CreateContainer within sandbox \"9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 6 05:22:27.816376 containerd[1605]: time="2025-11-06T05:22:27.816332188Z" level=info msg="Container c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:27.825762 containerd[1605]: time="2025-11-06T05:22:27.825728880Z" level=info msg="CreateContainer within sandbox \"9a948ea9d92251d32946164e22e9a24b61c507078af40f40b681e906eaff35c7\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa\"" Nov 6 05:22:27.826363 containerd[1605]: time="2025-11-06T05:22:27.826322463Z" level=info msg="StartContainer for \"c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa\"" Nov 6 05:22:27.828424 containerd[1605]: time="2025-11-06T05:22:27.828393047Z" level=info msg="connecting to shim c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa" address="unix:///run/containerd/s/9e4c3e3058f984997fe5d89dd6149d1426e5baf1032300f24819a740b57e19e2" protocol=ttrpc version=3 Nov 6 05:22:27.864230 systemd[1]: Started cri-containerd-c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa.scope - libcontainer container c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa. Nov 6 05:22:27.895557 kubelet[1907]: E1106 05:22:27.895510 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:27.913668 containerd[1605]: time="2025-11-06T05:22:27.913479093Z" level=info msg="StartContainer for \"c5d98a923950a37c1e48ab9ac9c147685e794f1a16c136d33713cc7e012c72fa\" returns successfully" Nov 6 05:22:28.027915 kubelet[1907]: E1106 05:22:28.027878 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:28.039582 kubelet[1907]: I1106 05:22:28.039390 1907 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-hpkqd" podStartSLOduration=2.284041456 podStartE2EDuration="4.039371747s" podCreationTimestamp="2025-11-06 05:22:24 +0000 UTC" firstStartedPulling="2025-11-06 05:22:26.047537026 +0000 UTC m=+2.892217481" lastFinishedPulling="2025-11-06 05:22:27.802867317 +0000 UTC m=+4.647547772" observedRunningTime="2025-11-06 05:22:28.039012804 +0000 UTC m=+4.883693259" watchObservedRunningTime="2025-11-06 05:22:28.039371747 +0000 UTC m=+4.884052202" Nov 6 05:22:28.896211 kubelet[1907]: E1106 05:22:28.896151 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:29.029414 kubelet[1907]: E1106 05:22:29.029349 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:29.178168 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3312303138.mount: Deactivated successfully. Nov 6 05:22:29.393675 containerd[1605]: time="2025-11-06T05:22:29.393599387Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:29.394551 containerd[1605]: time="2025-11-06T05:22:29.394494005Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=3641610" Nov 6 05:22:29.395796 containerd[1605]: time="2025-11-06T05:22:29.395750471Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:29.398325 containerd[1605]: time="2025-11-06T05:22:29.398290705Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:29.399274 containerd[1605]: time="2025-11-06T05:22:29.399228283Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"4856838\" in 1.596142196s" Nov 6 05:22:29.399274 containerd[1605]: time="2025-11-06T05:22:29.399256326Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Nov 6 05:22:29.403918 containerd[1605]: time="2025-11-06T05:22:29.403884696Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 6 05:22:29.414132 containerd[1605]: time="2025-11-06T05:22:29.414069326Z" level=info msg="Container d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:29.423441 containerd[1605]: time="2025-11-06T05:22:29.423408310Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df\"" Nov 6 05:22:29.423886 containerd[1605]: time="2025-11-06T05:22:29.423860768Z" level=info msg="StartContainer for \"d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df\"" Nov 6 05:22:29.424663 containerd[1605]: time="2025-11-06T05:22:29.424634018Z" level=info msg="connecting to shim d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df" address="unix:///run/containerd/s/1ab0f070962e82b3346b9d8bd87049bf7492a305e78439205546ade54503ebad" protocol=ttrpc version=3 Nov 6 05:22:29.458232 systemd[1]: Started cri-containerd-d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df.scope - libcontainer container d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df. Nov 6 05:22:29.497815 systemd[1]: cri-containerd-d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df.scope: Deactivated successfully. Nov 6 05:22:29.500550 containerd[1605]: time="2025-11-06T05:22:29.500509923Z" level=info msg="StartContainer for \"d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df\" returns successfully" Nov 6 05:22:29.500851 containerd[1605]: time="2025-11-06T05:22:29.500790899Z" level=info msg="received exit event container_id:\"d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df\" id:\"d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df\" pid:2247 exited_at:{seconds:1762406549 nanos:499967335}" Nov 6 05:22:29.896912 kubelet[1907]: E1106 05:22:29.896869 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:30.032393 kubelet[1907]: E1106 05:22:30.032348 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:30.033226 containerd[1605]: time="2025-11-06T05:22:30.033192923Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Nov 6 05:22:30.086827 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-d23120ab55e4cb9f81159a2a884ddacc57aa77508776cb2b988e623dc99542df-rootfs.mount: Deactivated successfully. Nov 6 05:22:30.897315 kubelet[1907]: E1106 05:22:30.897273 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:31.897497 kubelet[1907]: E1106 05:22:31.897415 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:32.286074 containerd[1605]: time="2025-11-06T05:22:32.285926934Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:32.287377 containerd[1605]: time="2025-11-06T05:22:32.287322391Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=6764692" Nov 6 05:22:32.288872 containerd[1605]: time="2025-11-06T05:22:32.288844235Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:32.292279 containerd[1605]: time="2025-11-06T05:22:32.292253138Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:32.293699 containerd[1605]: time="2025-11-06T05:22:32.293655167Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32996046\" in 2.260419012s" Nov 6 05:22:32.293699 containerd[1605]: time="2025-11-06T05:22:32.293695533Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Nov 6 05:22:32.299251 containerd[1605]: time="2025-11-06T05:22:32.299150282Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 6 05:22:32.307834 containerd[1605]: time="2025-11-06T05:22:32.307777511Z" level=info msg="Container 02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:32.317075 containerd[1605]: time="2025-11-06T05:22:32.317031015Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f\"" Nov 6 05:22:32.317659 containerd[1605]: time="2025-11-06T05:22:32.317595684Z" level=info msg="StartContainer for \"02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f\"" Nov 6 05:22:32.319058 containerd[1605]: time="2025-11-06T05:22:32.319014595Z" level=info msg="connecting to shim 02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f" address="unix:///run/containerd/s/1ab0f070962e82b3346b9d8bd87049bf7492a305e78439205546ade54503ebad" protocol=ttrpc version=3 Nov 6 05:22:32.357452 systemd[1]: Started cri-containerd-02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f.scope - libcontainer container 02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f. Nov 6 05:22:32.407105 systemd[1]: cri-containerd-02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f.scope: Deactivated successfully. Nov 6 05:22:32.408886 containerd[1605]: time="2025-11-06T05:22:32.408843807Z" level=info msg="received exit event container_id:\"02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f\" id:\"02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f\" pid:2322 exited_at:{seconds:1762406552 nanos:407269655}" Nov 6 05:22:32.416910 containerd[1605]: time="2025-11-06T05:22:32.416868766Z" level=info msg="StartContainer for \"02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f\" returns successfully" Nov 6 05:22:32.427483 kubelet[1907]: I1106 05:22:32.427447 1907 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Nov 6 05:22:32.439558 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-02821ce4d5df64bb2c52b2c7f4115c765595b351fa3b3fb75ed2b4c88370a50f-rootfs.mount: Deactivated successfully. Nov 6 05:22:32.898355 kubelet[1907]: E1106 05:22:32.898302 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:33.040538 kubelet[1907]: E1106 05:22:33.040479 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:33.046704 containerd[1605]: time="2025-11-06T05:22:33.046639972Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 6 05:22:33.062669 containerd[1605]: time="2025-11-06T05:22:33.062510826Z" level=info msg="Container 42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:33.073951 containerd[1605]: time="2025-11-06T05:22:33.073835894Z" level=info msg="CreateContainer within sandbox \"0a07e296ba01b52ad0aaa3bcd9da40b456cdc877141c7810eb59a0dff05649eb\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45\"" Nov 6 05:22:33.074935 containerd[1605]: time="2025-11-06T05:22:33.074881816Z" level=info msg="StartContainer for \"42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45\"" Nov 6 05:22:33.075892 containerd[1605]: time="2025-11-06T05:22:33.075864068Z" level=info msg="connecting to shim 42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45" address="unix:///run/containerd/s/1ab0f070962e82b3346b9d8bd87049bf7492a305e78439205546ade54503ebad" protocol=ttrpc version=3 Nov 6 05:22:33.104401 systemd[1]: Started cri-containerd-42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45.scope - libcontainer container 42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45. Nov 6 05:22:33.137153 containerd[1605]: time="2025-11-06T05:22:33.137080380Z" level=info msg="StartContainer for \"42ee8034e9eefec531afafdea4b104e0bcee843481e94e7814389de6bca44d45\" returns successfully" Nov 6 05:22:33.899538 kubelet[1907]: E1106 05:22:33.899428 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:34.045048 kubelet[1907]: E1106 05:22:34.045010 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:34.056061 kubelet[1907]: I1106 05:22:34.055993 1907 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-hxdzw" podStartSLOduration=3.822512388 podStartE2EDuration="10.055974014s" podCreationTimestamp="2025-11-06 05:22:24 +0000 UTC" firstStartedPulling="2025-11-06 05:22:26.061507285 +0000 UTC m=+2.906187740" lastFinishedPulling="2025-11-06 05:22:32.294968911 +0000 UTC m=+9.139649366" observedRunningTime="2025-11-06 05:22:34.05595593 +0000 UTC m=+10.900636385" watchObservedRunningTime="2025-11-06 05:22:34.055974014 +0000 UTC m=+10.900654469" Nov 6 05:22:34.187922 systemd-networkd[1508]: flannel.1: Link UP Nov 6 05:22:34.187933 systemd-networkd[1508]: flannel.1: Gained carrier Nov 6 05:22:34.900346 kubelet[1907]: E1106 05:22:34.900245 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:34.924141 systemd[1]: Created slice kubepods-besteffort-pod74995ac7_3421_4937_95bf_f270172f771e.slice - libcontainer container kubepods-besteffort-pod74995ac7_3421_4937_95bf_f270172f771e.slice. Nov 6 05:22:35.047399 kubelet[1907]: E1106 05:22:35.047344 1907 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 6 05:22:35.092838 kubelet[1907]: I1106 05:22:35.092793 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-cj5tj\" (UniqueName: \"kubernetes.io/projected/74995ac7-3421-4937-95bf-f270172f771e-kube-api-access-cj5tj\") pod \"nginx-deployment-bb8f74bfb-k5tt4\" (UID: \"74995ac7-3421-4937-95bf-f270172f771e\") " pod="default/nginx-deployment-bb8f74bfb-k5tt4" Nov 6 05:22:35.243916 containerd[1605]: time="2025-11-06T05:22:35.243791275Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-k5tt4,Uid:74995ac7-3421-4937-95bf-f270172f771e,Namespace:default,Attempt:0,}" Nov 6 05:22:35.260185 systemd-networkd[1508]: cni0: Link UP Nov 6 05:22:35.260193 systemd-networkd[1508]: cni0: Gained carrier Nov 6 05:22:35.261210 systemd-networkd[1508]: cni0: Lost carrier Nov 6 05:22:35.267686 systemd-networkd[1508]: veth5887ee5f: Link UP Nov 6 05:22:35.270887 kernel: cni0: port 1(veth5887ee5f) entered blocking state Nov 6 05:22:35.270966 kernel: cni0: port 1(veth5887ee5f) entered disabled state Nov 6 05:22:35.272175 kernel: veth5887ee5f: entered allmulticast mode Nov 6 05:22:35.273522 kernel: veth5887ee5f: entered promiscuous mode Nov 6 05:22:35.282395 kernel: cni0: port 1(veth5887ee5f) entered blocking state Nov 6 05:22:35.282476 kernel: cni0: port 1(veth5887ee5f) entered forwarding state Nov 6 05:22:35.282495 systemd-networkd[1508]: veth5887ee5f: Gained carrier Nov 6 05:22:35.283513 systemd-networkd[1508]: cni0: Gained carrier Nov 6 05:22:35.286410 containerd[1605]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a950), "name":"cbr0", "type":"bridge"} Nov 6 05:22:35.286410 containerd[1605]: delegateAdd: netconf sent to delegate plugin: Nov 6 05:22:35.319128 containerd[1605]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-06T05:22:35.319035074Z" level=info msg="connecting to shim 3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc" address="unix:///run/containerd/s/138b3f4bf935dfb047efac3999a886b08fc2a51e2289c9eea7752d9c9568a69a" namespace=k8s.io protocol=ttrpc version=3 Nov 6 05:22:35.448251 systemd[1]: Started cri-containerd-3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc.scope - libcontainer container 3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc. Nov 6 05:22:35.454250 systemd-networkd[1508]: flannel.1: Gained IPv6LL Nov 6 05:22:35.463226 systemd-resolved[1437]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 6 05:22:35.501657 containerd[1605]: time="2025-11-06T05:22:35.501526952Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-k5tt4,Uid:74995ac7-3421-4937-95bf-f270172f771e,Namespace:default,Attempt:0,} returns sandbox id \"3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc\"" Nov 6 05:22:35.502946 containerd[1605]: time="2025-11-06T05:22:35.502904665Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 6 05:22:35.901136 kubelet[1907]: E1106 05:22:35.901044 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:36.605289 systemd-networkd[1508]: veth5887ee5f: Gained IPv6LL Nov 6 05:22:36.902789 kubelet[1907]: E1106 05:22:36.902054 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:37.088753 systemd-networkd[1508]: cni0: Gained IPv6LL Nov 6 05:22:37.902648 kubelet[1907]: E1106 05:22:37.902581 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:38.120569 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount399956400.mount: Deactivated successfully. Nov 6 05:22:38.903701 kubelet[1907]: E1106 05:22:38.903639 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:39.192251 containerd[1605]: time="2025-11-06T05:22:39.192059097Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:39.193065 containerd[1605]: time="2025-11-06T05:22:39.193010811Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73296089" Nov 6 05:22:39.194233 containerd[1605]: time="2025-11-06T05:22:39.194192748Z" level=info msg="ImageCreate event name:\"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:39.196483 containerd[1605]: time="2025-11-06T05:22:39.196445362Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:39.197456 containerd[1605]: time="2025-11-06T05:22:39.197413608Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 3.694474468s" Nov 6 05:22:39.197456 containerd[1605]: time="2025-11-06T05:22:39.197441831Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 6 05:22:39.201668 containerd[1605]: time="2025-11-06T05:22:39.201630156Z" level=info msg="CreateContainer within sandbox \"3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 6 05:22:39.210287 containerd[1605]: time="2025-11-06T05:22:39.210237938Z" level=info msg="Container 767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:39.216626 containerd[1605]: time="2025-11-06T05:22:39.216585522Z" level=info msg="CreateContainer within sandbox \"3b2021b000cf54087bb76331c193642f188b9d510ac0769bea0c26edf7fccbdc\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f\"" Nov 6 05:22:39.217131 containerd[1605]: time="2025-11-06T05:22:39.217097483Z" level=info msg="StartContainer for \"767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f\"" Nov 6 05:22:39.217878 containerd[1605]: time="2025-11-06T05:22:39.217846918Z" level=info msg="connecting to shim 767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f" address="unix:///run/containerd/s/138b3f4bf935dfb047efac3999a886b08fc2a51e2289c9eea7752d9c9568a69a" protocol=ttrpc version=3 Nov 6 05:22:39.243228 systemd[1]: Started cri-containerd-767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f.scope - libcontainer container 767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f. Nov 6 05:22:39.280222 containerd[1605]: time="2025-11-06T05:22:39.280168283Z" level=info msg="StartContainer for \"767be1490b79b972428e50b866811cdf5f8c50f866ccc50034dee7e0c7eb445f\" returns successfully" Nov 6 05:22:39.904386 kubelet[1907]: E1106 05:22:39.904302 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:40.067872 kubelet[1907]: I1106 05:22:40.067790 1907 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-k5tt4" podStartSLOduration=2.37218163 podStartE2EDuration="6.067768124s" podCreationTimestamp="2025-11-06 05:22:34 +0000 UTC" firstStartedPulling="2025-11-06 05:22:35.502647192 +0000 UTC m=+12.347327647" lastFinishedPulling="2025-11-06 05:22:39.198233686 +0000 UTC m=+16.042914141" observedRunningTime="2025-11-06 05:22:40.067681121 +0000 UTC m=+16.912361576" watchObservedRunningTime="2025-11-06 05:22:40.067768124 +0000 UTC m=+16.912448579" Nov 6 05:22:40.905410 kubelet[1907]: E1106 05:22:40.905308 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:41.287381 systemd[1]: Created slice kubepods-besteffort-pod01c46ced_f8bd_448d_8ed4_79f1968d5e4b.slice - libcontainer container kubepods-besteffort-pod01c46ced_f8bd_448d_8ed4_79f1968d5e4b.slice. Nov 6 05:22:41.426780 kubelet[1907]: I1106 05:22:41.426721 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/01c46ced-f8bd-448d-8ed4-79f1968d5e4b-data\") pod \"nfs-server-provisioner-0\" (UID: \"01c46ced-f8bd-448d-8ed4-79f1968d5e4b\") " pod="default/nfs-server-provisioner-0" Nov 6 05:22:41.426780 kubelet[1907]: I1106 05:22:41.426776 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-mggnn\" (UniqueName: \"kubernetes.io/projected/01c46ced-f8bd-448d-8ed4-79f1968d5e4b-kube-api-access-mggnn\") pod \"nfs-server-provisioner-0\" (UID: \"01c46ced-f8bd-448d-8ed4-79f1968d5e4b\") " pod="default/nfs-server-provisioner-0" Nov 6 05:22:41.594828 containerd[1605]: time="2025-11-06T05:22:41.594768795Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:01c46ced-f8bd-448d-8ed4-79f1968d5e4b,Namespace:default,Attempt:0,}" Nov 6 05:22:41.610141 systemd-networkd[1508]: vethf9b7877c: Link UP Nov 6 05:22:41.613583 kernel: cni0: port 2(vethf9b7877c) entered blocking state Nov 6 05:22:41.613643 kernel: cni0: port 2(vethf9b7877c) entered disabled state Nov 6 05:22:41.614924 kernel: vethf9b7877c: entered allmulticast mode Nov 6 05:22:41.617114 kernel: vethf9b7877c: entered promiscuous mode Nov 6 05:22:41.627587 kernel: cni0: port 2(vethf9b7877c) entered blocking state Nov 6 05:22:41.627764 kernel: cni0: port 2(vethf9b7877c) entered forwarding state Nov 6 05:22:41.627673 systemd-networkd[1508]: vethf9b7877c: Gained carrier Nov 6 05:22:41.630064 containerd[1605]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Nov 6 05:22:41.630064 containerd[1605]: delegateAdd: netconf sent to delegate plugin: Nov 6 05:22:41.659855 containerd[1605]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-06T05:22:41.659785495Z" level=info msg="connecting to shim 73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f" address="unix:///run/containerd/s/6b29b38f78b69103cbdb10a0d4ed1c0e2ea10c99c6906d1e294c38e8f6f52572" namespace=k8s.io protocol=ttrpc version=3 Nov 6 05:22:41.883372 systemd[1]: Started cri-containerd-73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f.scope - libcontainer container 73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f. Nov 6 05:22:41.897843 systemd-resolved[1437]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 6 05:22:41.905778 kubelet[1907]: E1106 05:22:41.905743 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:41.934017 containerd[1605]: time="2025-11-06T05:22:41.933962665Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:01c46ced-f8bd-448d-8ed4-79f1968d5e4b,Namespace:default,Attempt:0,} returns sandbox id \"73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f\"" Nov 6 05:22:41.935692 containerd[1605]: time="2025-11-06T05:22:41.935661761Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 6 05:22:42.906437 kubelet[1907]: E1106 05:22:42.906276 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:43.133366 systemd-networkd[1508]: vethf9b7877c: Gained IPv6LL Nov 6 05:22:43.894021 kubelet[1907]: E1106 05:22:43.893933 1907 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:43.906855 kubelet[1907]: E1106 05:22:43.906806 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:44.907110 kubelet[1907]: E1106 05:22:44.906993 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:44.949065 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount572578805.mount: Deactivated successfully. Nov 6 05:22:45.907213 kubelet[1907]: E1106 05:22:45.907140 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:46.907387 kubelet[1907]: E1106 05:22:46.907319 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:47.102032 containerd[1605]: time="2025-11-06T05:22:47.101949615Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:47.102816 containerd[1605]: time="2025-11-06T05:22:47.102743333Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=89929928" Nov 6 05:22:47.103960 containerd[1605]: time="2025-11-06T05:22:47.103911865Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:47.106324 containerd[1605]: time="2025-11-06T05:22:47.106290095Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:47.107164 containerd[1605]: time="2025-11-06T05:22:47.107106826Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 5.171396014s" Nov 6 05:22:47.107221 containerd[1605]: time="2025-11-06T05:22:47.107165917Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Nov 6 05:22:47.111045 containerd[1605]: time="2025-11-06T05:22:47.111003765Z" level=info msg="CreateContainer within sandbox \"73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 6 05:22:47.119787 containerd[1605]: time="2025-11-06T05:22:47.119730641Z" level=info msg="Container 95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:47.129397 containerd[1605]: time="2025-11-06T05:22:47.129354709Z" level=info msg="CreateContainer within sandbox \"73044e24b28532f24d4f984d84cd792999cdc75be8308abeeb0669c8232d747f\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f\"" Nov 6 05:22:47.129825 containerd[1605]: time="2025-11-06T05:22:47.129768856Z" level=info msg="StartContainer for \"95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f\"" Nov 6 05:22:47.130728 containerd[1605]: time="2025-11-06T05:22:47.130699882Z" level=info msg="connecting to shim 95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f" address="unix:///run/containerd/s/6b29b38f78b69103cbdb10a0d4ed1c0e2ea10c99c6906d1e294c38e8f6f52572" protocol=ttrpc version=3 Nov 6 05:22:47.157229 systemd[1]: Started cri-containerd-95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f.scope - libcontainer container 95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f. Nov 6 05:22:47.208489 containerd[1605]: time="2025-11-06T05:22:47.208375702Z" level=info msg="StartContainer for \"95f09c0d43ef19186357b56b2453d68d2a6eade877b55b0cb069bb5c5a16963f\" returns successfully" Nov 6 05:22:47.908079 kubelet[1907]: E1106 05:22:47.907996 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:48.087355 kubelet[1907]: I1106 05:22:48.087268 1907 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.914816125 podStartE2EDuration="7.087249664s" podCreationTimestamp="2025-11-06 05:22:41 +0000 UTC" firstStartedPulling="2025-11-06 05:22:41.935395111 +0000 UTC m=+18.780075566" lastFinishedPulling="2025-11-06 05:22:47.10782865 +0000 UTC m=+23.952509105" observedRunningTime="2025-11-06 05:22:48.087222072 +0000 UTC m=+24.931902547" watchObservedRunningTime="2025-11-06 05:22:48.087249664 +0000 UTC m=+24.931930129" Nov 6 05:22:48.909189 kubelet[1907]: E1106 05:22:48.909114 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:49.910193 kubelet[1907]: E1106 05:22:49.910150 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:50.910689 kubelet[1907]: E1106 05:22:50.910622 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:51.911443 kubelet[1907]: E1106 05:22:51.911373 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:52.606382 systemd[1]: Created slice kubepods-besteffort-pod4fdc75cf_0cc7_4691_8347_4e53beaf213d.slice - libcontainer container kubepods-besteffort-pod4fdc75cf_0cc7_4691_8347_4e53beaf213d.slice. Nov 6 05:22:52.701813 kubelet[1907]: I1106 05:22:52.701766 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-8ec7ea91-145c-4a70-919c-e8d97a9158d5\" (UniqueName: \"kubernetes.io/nfs/4fdc75cf-0cc7-4691-8347-4e53beaf213d-pvc-8ec7ea91-145c-4a70-919c-e8d97a9158d5\") pod \"test-pod-1\" (UID: \"4fdc75cf-0cc7-4691-8347-4e53beaf213d\") " pod="default/test-pod-1" Nov 6 05:22:52.701930 kubelet[1907]: I1106 05:22:52.701818 1907 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-k5b2s\" (UniqueName: \"kubernetes.io/projected/4fdc75cf-0cc7-4691-8347-4e53beaf213d-kube-api-access-k5b2s\") pod \"test-pod-1\" (UID: \"4fdc75cf-0cc7-4691-8347-4e53beaf213d\") " pod="default/test-pod-1" Nov 6 05:22:52.912648 kubelet[1907]: E1106 05:22:52.912464 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:53.059129 kernel: netfs: FS-Cache loaded Nov 6 05:22:53.125413 kernel: RPC: Registered named UNIX socket transport module. Nov 6 05:22:53.125506 kernel: RPC: Registered udp transport module. Nov 6 05:22:53.125527 kernel: RPC: Registered tcp transport module. Nov 6 05:22:53.126281 kernel: RPC: Registered tcp-with-tls transport module. Nov 6 05:22:53.127272 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 6 05:22:53.366399 kernel: NFS: Registering the id_resolver key type Nov 6 05:22:53.366610 kernel: Key type id_resolver registered Nov 6 05:22:53.366630 kernel: Key type id_legacy registered Nov 6 05:22:53.394409 nfsidmap[2881]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 6 05:22:53.395024 nfsidmap[2881]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 6 05:22:53.399056 nfsidmap[2884]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 6 05:22:53.399258 nfsidmap[2884]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 6 05:22:53.406825 nfsrahead[2890]: setting /var/lib/kubelet/pods/4fdc75cf-0cc7-4691-8347-4e53beaf213d/volumes/kubernetes.io~nfs/pvc-8ec7ea91-145c-4a70-919c-e8d97a9158d5 readahead to 128 Nov 6 05:22:53.511922 containerd[1605]: time="2025-11-06T05:22:53.511866120Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4fdc75cf-0cc7-4691-8347-4e53beaf213d,Namespace:default,Attempt:0,}" Nov 6 05:22:53.527012 systemd-networkd[1508]: veth82eb23ee: Link UP Nov 6 05:22:53.529246 kernel: cni0: port 3(veth82eb23ee) entered blocking state Nov 6 05:22:53.529386 kernel: cni0: port 3(veth82eb23ee) entered disabled state Nov 6 05:22:53.529408 kernel: veth82eb23ee: entered allmulticast mode Nov 6 05:22:53.531515 kernel: veth82eb23ee: entered promiscuous mode Nov 6 05:22:53.539489 kernel: cni0: port 3(veth82eb23ee) entered blocking state Nov 6 05:22:53.539531 kernel: cni0: port 3(veth82eb23ee) entered forwarding state Nov 6 05:22:53.539482 systemd-networkd[1508]: veth82eb23ee: Gained carrier Nov 6 05:22:53.541856 containerd[1605]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a950), "name":"cbr0", "type":"bridge"} Nov 6 05:22:53.541856 containerd[1605]: delegateAdd: netconf sent to delegate plugin: Nov 6 05:22:53.745482 containerd[1605]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-06T05:22:53.745359305Z" level=info msg="connecting to shim 1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d" address="unix:///run/containerd/s/bc65dbdad06f42b7d3d111b95b91e7e704342d3a8e66ad157b90d1a6c6df8772" namespace=k8s.io protocol=ttrpc version=3 Nov 6 05:22:53.784266 systemd[1]: Started cri-containerd-1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d.scope - libcontainer container 1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d. Nov 6 05:22:53.797062 systemd-resolved[1437]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 6 05:22:53.833593 containerd[1605]: time="2025-11-06T05:22:53.833520322Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4fdc75cf-0cc7-4691-8347-4e53beaf213d,Namespace:default,Attempt:0,} returns sandbox id \"1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d\"" Nov 6 05:22:53.835117 containerd[1605]: time="2025-11-06T05:22:53.835064539Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 6 05:22:53.913135 kubelet[1907]: E1106 05:22:53.913009 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:54.252399 containerd[1605]: time="2025-11-06T05:22:54.252314436Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 6 05:22:54.253291 containerd[1605]: time="2025-11-06T05:22:54.253258271Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=0" Nov 6 05:22:54.256008 containerd[1605]: time="2025-11-06T05:22:54.255970518Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 420.726575ms" Nov 6 05:22:54.256056 containerd[1605]: time="2025-11-06T05:22:54.256005595Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 6 05:22:54.259892 containerd[1605]: time="2025-11-06T05:22:54.259862761Z" level=info msg="CreateContainer within sandbox \"1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 6 05:22:54.273008 containerd[1605]: time="2025-11-06T05:22:54.272953434Z" level=info msg="Container 8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700: CDI devices from CRI Config.CDIDevices: []" Nov 6 05:22:54.279814 containerd[1605]: time="2025-11-06T05:22:54.279768908Z" level=info msg="CreateContainer within sandbox \"1b8c09bdc8f08d97161ae1adfc4fa3cb89f2e192405b8c5df1bf56e58ac6457d\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700\"" Nov 6 05:22:54.280442 containerd[1605]: time="2025-11-06T05:22:54.280404262Z" level=info msg="StartContainer for \"8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700\"" Nov 6 05:22:54.281508 containerd[1605]: time="2025-11-06T05:22:54.281469610Z" level=info msg="connecting to shim 8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700" address="unix:///run/containerd/s/bc65dbdad06f42b7d3d111b95b91e7e704342d3a8e66ad157b90d1a6c6df8772" protocol=ttrpc version=3 Nov 6 05:22:54.302244 systemd[1]: Started cri-containerd-8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700.scope - libcontainer container 8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700. Nov 6 05:22:54.339991 containerd[1605]: time="2025-11-06T05:22:54.339951947Z" level=info msg="StartContainer for \"8e36841246033780c1c85678e52024293bfe9b42273490d2e413ff4c98b78700\" returns successfully" Nov 6 05:22:54.845452 systemd-networkd[1508]: veth82eb23ee: Gained IPv6LL Nov 6 05:22:54.913556 kubelet[1907]: E1106 05:22:54.913473 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:55.101516 kubelet[1907]: I1106 05:22:55.101344 1907 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=13.6791854 podStartE2EDuration="14.101328385s" podCreationTimestamp="2025-11-06 05:22:41 +0000 UTC" firstStartedPulling="2025-11-06 05:22:53.834720471 +0000 UTC m=+30.679400916" lastFinishedPulling="2025-11-06 05:22:54.256863446 +0000 UTC m=+31.101543901" observedRunningTime="2025-11-06 05:22:55.101278028 +0000 UTC m=+31.945958483" watchObservedRunningTime="2025-11-06 05:22:55.101328385 +0000 UTC m=+31.946008840" Nov 6 05:22:55.914480 kubelet[1907]: E1106 05:22:55.914420 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:56.914798 kubelet[1907]: E1106 05:22:56.914737 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 6 05:22:57.915791 kubelet[1907]: E1106 05:22:57.915714 1907 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"