Oct 21 02:22:09.873113 kernel: Linux version 6.6.159-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Oct 20 23:00:48 -00 2026 Oct 21 02:22:09.873132 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=0072d1930730cace9bbe19324b8e2e3a0f5b7bb58024d2742317d9d224c5cfeb Oct 21 02:22:09.873142 kernel: BIOS-provided physical RAM map: Oct 21 02:22:09.873147 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Oct 21 02:22:09.873153 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Oct 21 02:22:09.873158 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Oct 21 02:22:09.873164 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Oct 21 02:22:09.873169 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Oct 21 02:22:09.873174 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Oct 21 02:22:09.873179 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Oct 21 02:22:09.873184 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Oct 21 02:22:09.873191 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Oct 21 02:22:09.873196 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Oct 21 02:22:09.873201 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Oct 21 02:22:09.873207 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Oct 21 02:22:09.873213 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Oct 21 02:22:09.873219 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Oct 21 02:22:09.873225 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Oct 21 02:22:09.873230 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Oct 21 02:22:09.873236 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Oct 21 02:22:09.873241 kernel: NX (Execute Disable) protection: active Oct 21 02:22:09.873246 kernel: APIC: Static calls initialized Oct 21 02:22:09.873252 kernel: efi: EFI v2.7 by EDK II Oct 21 02:22:09.873257 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b675198 Oct 21 02:22:09.873263 kernel: SMBIOS 2.8 present. Oct 21 02:22:09.873268 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Oct 21 02:22:09.873274 kernel: Hypervisor detected: KVM Oct 21 02:22:09.873279 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 21 02:22:09.873285 kernel: kvm-clock: using sched offset of 4746187679 cycles Oct 21 02:22:09.873291 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 21 02:22:09.873297 kernel: tsc: Detected 2793.438 MHz processor Oct 21 02:22:09.873303 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 21 02:22:09.873309 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 21 02:22:09.873315 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x10000000000 Oct 21 02:22:09.873320 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Oct 21 02:22:09.873326 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 21 02:22:09.873331 kernel: Using GB pages for direct mapping Oct 21 02:22:09.873338 kernel: Secure boot disabled Oct 21 02:22:09.873344 kernel: ACPI: Early table checksum verification disabled Oct 21 02:22:09.873350 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Oct 21 02:22:09.873358 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Oct 21 02:22:09.873364 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873370 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873377 kernel: ACPI: FACS 0x000000009CBDD000 000040 Oct 21 02:22:09.873384 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873390 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873395 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873401 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 21 02:22:09.873407 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Oct 21 02:22:09.873413 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Oct 21 02:22:09.873419 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Oct 21 02:22:09.873426 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Oct 21 02:22:09.873432 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Oct 21 02:22:09.873436 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Oct 21 02:22:09.873441 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Oct 21 02:22:09.873446 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Oct 21 02:22:09.873451 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Oct 21 02:22:09.873456 kernel: No NUMA configuration found Oct 21 02:22:09.873461 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Oct 21 02:22:09.873466 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Oct 21 02:22:09.873472 kernel: Zone ranges: Oct 21 02:22:09.873477 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 21 02:22:09.873482 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Oct 21 02:22:09.873486 kernel: Normal empty Oct 21 02:22:09.873491 kernel: Movable zone start for each node Oct 21 02:22:09.873496 kernel: Early memory node ranges Oct 21 02:22:09.873501 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Oct 21 02:22:09.873506 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Oct 21 02:22:09.873511 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Oct 21 02:22:09.873517 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Oct 21 02:22:09.873522 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Oct 21 02:22:09.873526 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Oct 21 02:22:09.873531 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Oct 21 02:22:09.873536 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 21 02:22:09.873541 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 21 02:22:09.873546 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Oct 21 02:22:09.873550 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 21 02:22:09.873555 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Oct 21 02:22:09.873560 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Oct 21 02:22:09.873566 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Oct 21 02:22:09.873571 kernel: ACPI: PM-Timer IO Port: 0x608 Oct 21 02:22:09.873576 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 21 02:22:09.873581 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 21 02:22:09.873585 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 21 02:22:09.873590 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 21 02:22:09.873595 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 21 02:22:09.873600 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 21 02:22:09.873605 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 21 02:22:09.873611 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 21 02:22:09.873615 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 21 02:22:09.873620 kernel: TSC deadline timer available Oct 21 02:22:09.873625 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Oct 21 02:22:09.873630 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Oct 21 02:22:09.873635 kernel: kvm-guest: KVM setup pv remote TLB flush Oct 21 02:22:09.873654 kernel: kvm-guest: setup PV sched yield Oct 21 02:22:09.873659 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Oct 21 02:22:09.873664 kernel: Booting paravirtualized kernel on KVM Oct 21 02:22:09.873670 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 21 02:22:09.873676 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Oct 21 02:22:09.873681 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u524288 Oct 21 02:22:09.873686 kernel: pcpu-alloc: s196392 r8192 d28888 u524288 alloc=1*2097152 Oct 21 02:22:09.873691 kernel: pcpu-alloc: [0] 0 1 2 3 Oct 21 02:22:09.873695 kernel: kvm-guest: PV spinlocks enabled Oct 21 02:22:09.873700 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 21 02:22:09.873706 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=0072d1930730cace9bbe19324b8e2e3a0f5b7bb58024d2742317d9d224c5cfeb Oct 21 02:22:09.873712 kernel: random: crng init done Oct 21 02:22:09.873717 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 21 02:22:09.873722 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 21 02:22:09.873727 kernel: Fallback order for Node 0: 0 Oct 21 02:22:09.873732 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Oct 21 02:22:09.873736 kernel: Policy zone: DMA32 Oct 21 02:22:09.873741 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 21 02:22:09.873746 kernel: Memory: 2397604K/2567000K available (14336K kernel code, 2288K rwdata, 22780K rodata, 42940K init, 2212K bss, 169192K reserved, 0K cma-reserved) Oct 21 02:22:09.873751 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 21 02:22:09.873758 kernel: ftrace: allocating 37527 entries in 148 pages Oct 21 02:22:09.873762 kernel: ftrace: allocated 148 pages with 3 groups Oct 21 02:22:09.873767 kernel: Dynamic Preempt: voluntary Oct 21 02:22:09.873772 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 21 02:22:09.873783 kernel: rcu: RCU event tracing is enabled. Oct 21 02:22:09.873789 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 21 02:22:09.873795 kernel: Trampoline variant of Tasks RCU enabled. Oct 21 02:22:09.873800 kernel: Rude variant of Tasks RCU enabled. Oct 21 02:22:09.873806 kernel: Tracing variant of Tasks RCU enabled. Oct 21 02:22:09.873811 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 21 02:22:09.873816 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 21 02:22:09.873822 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Oct 21 02:22:09.873828 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 21 02:22:09.873834 kernel: Console: colour dummy device 80x25 Oct 21 02:22:09.873839 kernel: printk: console [ttyS0] enabled Oct 21 02:22:09.873845 kernel: ACPI: Core revision 20230628 Oct 21 02:22:09.873850 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Oct 21 02:22:09.873857 kernel: APIC: Switch to symmetric I/O mode setup Oct 21 02:22:09.873862 kernel: x2apic enabled Oct 21 02:22:09.873868 kernel: APIC: Switched APIC routing to: physical x2apic Oct 21 02:22:09.873873 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Oct 21 02:22:09.873879 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Oct 21 02:22:09.873884 kernel: kvm-guest: setup PV IPIs Oct 21 02:22:09.873890 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 21 02:22:09.873895 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Oct 21 02:22:09.873900 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Oct 21 02:22:09.873907 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 21 02:22:09.873912 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Oct 21 02:22:09.873918 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Oct 21 02:22:09.873923 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 21 02:22:09.873928 kernel: Spectre V2 : Mitigation: Retpolines Oct 21 02:22:09.873934 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 21 02:22:09.873939 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Oct 21 02:22:09.873945 kernel: RETBleed: Vulnerable Oct 21 02:22:09.873950 kernel: Speculative Store Bypass: Vulnerable Oct 21 02:22:09.873957 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 21 02:22:09.873962 kernel: GDS: Unknown: Dependent on hypervisor status Oct 21 02:22:09.873968 kernel: active return thunk: its_return_thunk Oct 21 02:22:09.873973 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 21 02:22:09.873978 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 21 02:22:09.873984 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 21 02:22:09.873989 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 21 02:22:09.873995 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 21 02:22:09.874000 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 21 02:22:09.874007 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 21 02:22:09.874012 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 21 02:22:09.874018 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Oct 21 02:22:09.874023 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Oct 21 02:22:09.874028 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Oct 21 02:22:09.874034 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Oct 21 02:22:09.874039 kernel: Freeing SMP alternatives memory: 32K Oct 21 02:22:09.874045 kernel: pid_max: default: 32768 minimum: 301 Oct 21 02:22:09.874050 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 21 02:22:09.874075 kernel: landlock: Up and running. Oct 21 02:22:09.874080 kernel: SELinux: Initializing. Oct 21 02:22:09.874086 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 21 02:22:09.874091 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 21 02:22:09.874096 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Oct 21 02:22:09.874102 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 21 02:22:09.874107 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 21 02:22:09.874113 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 21 02:22:09.874120 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Oct 21 02:22:09.874125 kernel: signal: max sigframe size: 3632 Oct 21 02:22:09.874131 kernel: rcu: Hierarchical SRCU implementation. Oct 21 02:22:09.874136 kernel: rcu: Max phase no-delay instances is 400. Oct 21 02:22:09.874142 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 21 02:22:09.874148 kernel: smp: Bringing up secondary CPUs ... Oct 21 02:22:09.874153 kernel: smpboot: x86: Booting SMP configuration: Oct 21 02:22:09.874158 kernel: .... node #0, CPUs: #1 #2 #3 Oct 21 02:22:09.874164 kernel: smp: Brought up 1 node, 4 CPUs Oct 21 02:22:09.874169 kernel: smpboot: Max logical packages: 1 Oct 21 02:22:09.874175 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Oct 21 02:22:09.874181 kernel: devtmpfs: initialized Oct 21 02:22:09.874186 kernel: x86/mm: Memory block size: 128MB Oct 21 02:22:09.874191 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Oct 21 02:22:09.874197 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Oct 21 02:22:09.874202 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Oct 21 02:22:09.874208 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Oct 21 02:22:09.874213 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Oct 21 02:22:09.874220 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 21 02:22:09.874226 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 21 02:22:09.874231 kernel: pinctrl core: initialized pinctrl subsystem Oct 21 02:22:09.874237 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 21 02:22:09.874242 kernel: audit: initializing netlink subsys (disabled) Oct 21 02:22:09.874248 kernel: audit: type=2000 audit(1792549329.908:1): state=initialized audit_enabled=0 res=1 Oct 21 02:22:09.874253 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 21 02:22:09.874258 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 21 02:22:09.874264 kernel: cpuidle: using governor menu Oct 21 02:22:09.874270 kernel: efi: Freeing EFI boot services memory: 29232K Oct 21 02:22:09.874276 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 21 02:22:09.874281 kernel: dca service started, version 1.12.1 Oct 21 02:22:09.874287 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Oct 21 02:22:09.874292 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Oct 21 02:22:09.874298 kernel: PCI: Using configuration type 1 for base access Oct 21 02:22:09.874303 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 21 02:22:09.874308 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 21 02:22:09.874314 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 21 02:22:09.874321 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 21 02:22:09.874326 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 21 02:22:09.874331 kernel: ACPI: Added _OSI(Module Device) Oct 21 02:22:09.874337 kernel: ACPI: Added _OSI(Processor Device) Oct 21 02:22:09.874342 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 21 02:22:09.874348 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 21 02:22:09.874353 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Oct 21 02:22:09.874359 kernel: ACPI: Interpreter enabled Oct 21 02:22:09.874364 kernel: ACPI: PM: (supports S0 S3 S5) Oct 21 02:22:09.874371 kernel: ACPI: Using IOAPIC for interrupt routing Oct 21 02:22:09.874376 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 21 02:22:09.874381 kernel: PCI: Using E820 reservations for host bridge windows Oct 21 02:22:09.874387 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Oct 21 02:22:09.874392 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 21 02:22:09.874513 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 21 02:22:09.874578 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Oct 21 02:22:09.874635 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Oct 21 02:22:09.874659 kernel: PCI host bridge to bus 0000:00 Oct 21 02:22:09.874725 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 21 02:22:09.874776 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 21 02:22:09.874828 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 21 02:22:09.874879 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Oct 21 02:22:09.874928 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Oct 21 02:22:09.874977 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Oct 21 02:22:09.875028 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 21 02:22:09.875130 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Oct 21 02:22:09.875192 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Oct 21 02:22:09.875250 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Oct 21 02:22:09.875306 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Oct 21 02:22:09.875361 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Oct 21 02:22:09.875419 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Oct 21 02:22:09.875475 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 21 02:22:09.875537 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Oct 21 02:22:09.875594 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Oct 21 02:22:09.875670 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Oct 21 02:22:09.875727 kernel: pci 0000:00:02.0: BAR 4 [mem 0x800000000-0x800003fff 64bit pref] Oct 21 02:22:09.875788 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Oct 21 02:22:09.875846 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Oct 21 02:22:09.875902 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Oct 21 02:22:09.875957 kernel: pci 0000:00:03.0: BAR 4 [mem 0x800004000-0x800007fff 64bit pref] Oct 21 02:22:09.876017 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Oct 21 02:22:09.876098 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Oct 21 02:22:09.876155 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Oct 21 02:22:09.876210 kernel: pci 0000:00:04.0: BAR 4 [mem 0x800008000-0x80000bfff 64bit pref] Oct 21 02:22:09.876268 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Oct 21 02:22:09.876329 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Oct 21 02:22:09.876385 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Oct 21 02:22:09.876448 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Oct 21 02:22:09.876504 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Oct 21 02:22:09.876560 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Oct 21 02:22:09.876621 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Oct 21 02:22:09.876693 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Oct 21 02:22:09.876700 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 21 02:22:09.876706 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 21 02:22:09.876711 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 21 02:22:09.876717 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 21 02:22:09.876722 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Oct 21 02:22:09.876727 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Oct 21 02:22:09.876733 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Oct 21 02:22:09.876740 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Oct 21 02:22:09.876745 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Oct 21 02:22:09.876751 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Oct 21 02:22:09.876756 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Oct 21 02:22:09.876761 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Oct 21 02:22:09.876767 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Oct 21 02:22:09.876772 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Oct 21 02:22:09.876777 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Oct 21 02:22:09.876783 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Oct 21 02:22:09.876789 kernel: iommu: Default domain type: Translated Oct 21 02:22:09.876795 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 21 02:22:09.876800 kernel: efivars: Registered efivars operations Oct 21 02:22:09.876806 kernel: PCI: Using ACPI for IRQ routing Oct 21 02:22:09.876811 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 21 02:22:09.876816 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Oct 21 02:22:09.876822 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Oct 21 02:22:09.876827 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Oct 21 02:22:09.876832 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Oct 21 02:22:09.876907 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Oct 21 02:22:09.876963 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Oct 21 02:22:09.877019 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 21 02:22:09.877026 kernel: vgaarb: loaded Oct 21 02:22:09.877031 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 21 02:22:09.877036 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Oct 21 02:22:09.877042 kernel: clocksource: Switched to clocksource kvm-clock Oct 21 02:22:09.877047 kernel: VFS: Disk quotas dquot_6.6.0 Oct 21 02:22:09.877072 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 21 02:22:09.877080 kernel: pnp: PnP ACPI init Oct 21 02:22:09.877145 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Oct 21 02:22:09.877153 kernel: pnp: PnP ACPI: found 6 devices Oct 21 02:22:09.877159 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 21 02:22:09.877165 kernel: NET: Registered PF_INET protocol family Oct 21 02:22:09.877170 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 21 02:22:09.877176 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 21 02:22:09.877181 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 21 02:22:09.877189 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 21 02:22:09.877194 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 21 02:22:09.877200 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 21 02:22:09.877206 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 21 02:22:09.877211 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 21 02:22:09.877217 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 21 02:22:09.877222 kernel: NET: Registered PF_XDP protocol family Oct 21 02:22:09.877278 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Oct 21 02:22:09.877336 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Oct 21 02:22:09.877389 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 21 02:22:09.877440 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 21 02:22:09.877489 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 21 02:22:09.877538 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Oct 21 02:22:09.877586 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Oct 21 02:22:09.877635 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Oct 21 02:22:09.877656 kernel: PCI: CLS 0 bytes, default 64 Oct 21 02:22:09.877664 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 21 02:22:09.877669 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Oct 21 02:22:09.877675 kernel: Initialise system trusted keyrings Oct 21 02:22:09.877680 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 21 02:22:09.877686 kernel: Key type asymmetric registered Oct 21 02:22:09.877691 kernel: Asymmetric key parser 'x509' registered Oct 21 02:22:09.877696 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 21 02:22:09.877702 kernel: io scheduler mq-deadline registered Oct 21 02:22:09.877707 kernel: io scheduler kyber registered Oct 21 02:22:09.877714 kernel: io scheduler bfq registered Oct 21 02:22:09.877719 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 21 02:22:09.877725 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Oct 21 02:22:09.877731 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Oct 21 02:22:09.877736 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Oct 21 02:22:09.877741 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 21 02:22:09.877747 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 21 02:22:09.877752 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 21 02:22:09.877758 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 21 02:22:09.877766 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 21 02:22:09.877824 kernel: rtc_cmos 00:04: RTC can wake from S4 Oct 21 02:22:09.877832 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 21 02:22:09.877882 kernel: rtc_cmos 00:04: registered as rtc0 Oct 21 02:22:09.877934 kernel: rtc_cmos 00:04: setting system clock to 2026-10-21T02:22:09 UTC (1792549329) Oct 21 02:22:09.877987 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Oct 21 02:22:09.877994 kernel: intel_pstate: CPU model not supported Oct 21 02:22:09.877999 kernel: efifb: probing for efifb Oct 21 02:22:09.878006 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Oct 21 02:22:09.878012 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Oct 21 02:22:09.878017 kernel: efifb: scrolling: redraw Oct 21 02:22:09.878023 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Oct 21 02:22:09.878028 kernel: Console: switching to colour frame buffer device 100x37 Oct 21 02:22:09.878043 kernel: fb0: EFI VGA frame buffer device Oct 21 02:22:09.878051 kernel: pstore: Using crash dump compression: deflate Oct 21 02:22:09.878077 kernel: pstore: Registered efi_pstore as persistent store backend Oct 21 02:22:09.878083 kernel: NET: Registered PF_INET6 protocol family Oct 21 02:22:09.878090 kernel: Segment Routing with IPv6 Oct 21 02:22:09.878096 kernel: In-situ OAM (IOAM) with IPv6 Oct 21 02:22:09.878101 kernel: NET: Registered PF_PACKET protocol family Oct 21 02:22:09.878107 kernel: Key type dns_resolver registered Oct 21 02:22:09.878112 kernel: IPI shorthand broadcast: enabled Oct 21 02:22:09.878118 kernel: sched_clock: Marking stable (806007990, 202275971)->(1091687519, -83403558) Oct 21 02:22:09.878124 kernel: registered taskstats version 1 Oct 21 02:22:09.878129 kernel: Loading compiled-in X.509 certificates Oct 21 02:22:09.878135 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.159-flatcar: 9cccdc321976c2ff70299c824a909cc09d325025' Oct 21 02:22:09.878142 kernel: Key type .fscrypt registered Oct 21 02:22:09.878147 kernel: Key type fscrypt-provisioning registered Oct 21 02:22:09.878153 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 21 02:22:09.878158 kernel: ima: Allocated hash algorithm: sha1 Oct 21 02:22:09.878164 kernel: ima: No architecture policies found Oct 21 02:22:09.878169 kernel: clk: Disabling unused clocks Oct 21 02:22:09.878175 kernel: Freeing unused kernel image (initmem) memory: 42940K Oct 21 02:22:09.878181 kernel: Write protecting the kernel read-only data: 38912k Oct 21 02:22:09.878186 kernel: Freeing unused kernel image (rodata/data gap) memory: 1796K Oct 21 02:22:09.878193 kernel: Run /init as init process Oct 21 02:22:09.878199 kernel: with arguments: Oct 21 02:22:09.878206 kernel: /init Oct 21 02:22:09.878212 kernel: with environment: Oct 21 02:22:09.878217 kernel: HOME=/ Oct 21 02:22:09.878222 kernel: TERM=linux Oct 21 02:22:09.878231 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Oct 21 02:22:09.878239 systemd[1]: Detected virtualization kvm. Oct 21 02:22:09.878245 systemd[1]: Detected architecture x86-64. Oct 21 02:22:09.878251 systemd[1]: Running in initrd. Oct 21 02:22:09.878257 systemd[1]: No hostname configured, using default hostname. Oct 21 02:22:09.878263 systemd[1]: Hostname set to . Oct 21 02:22:09.878269 systemd[1]: Initializing machine ID from VM UUID. Oct 21 02:22:09.878276 systemd[1]: Queued start job for default target initrd.target. Oct 21 02:22:09.878282 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 02:22:09.878288 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 02:22:09.878294 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 21 02:22:09.878300 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 21 02:22:09.878306 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 21 02:22:09.878313 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 21 02:22:09.878321 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 21 02:22:09.878327 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 21 02:22:09.878333 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 02:22:09.878339 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 21 02:22:09.878345 systemd[1]: Reached target paths.target - Path Units. Oct 21 02:22:09.878351 systemd[1]: Reached target slices.target - Slice Units. Oct 21 02:22:09.878357 systemd[1]: Reached target swap.target - Swaps. Oct 21 02:22:09.878363 systemd[1]: Reached target timers.target - Timer Units. Oct 21 02:22:09.878371 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 21 02:22:09.878377 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 21 02:22:09.878383 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 21 02:22:09.878389 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 21 02:22:09.878395 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 21 02:22:09.878401 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 21 02:22:09.878407 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 21 02:22:09.878413 systemd[1]: Reached target sockets.target - Socket Units. Oct 21 02:22:09.878420 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 21 02:22:09.878426 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 21 02:22:09.878433 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 21 02:22:09.878439 systemd[1]: Starting systemd-fsck-usr.service... Oct 21 02:22:09.878445 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 21 02:22:09.878451 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 21 02:22:09.878457 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:09.878463 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 21 02:22:09.878481 systemd-journald[194]: Collecting audit messages is disabled. Oct 21 02:22:09.878497 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 02:22:09.878503 systemd[1]: Finished systemd-fsck-usr.service. Oct 21 02:22:09.878511 systemd-journald[194]: Journal started Oct 21 02:22:09.878526 systemd-journald[194]: Runtime Journal (/run/log/journal/801830ea48f34876b717504c54e12b0b) is 6.0M, max 48.2M, 42.2M free. Oct 21 02:22:09.884018 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 21 02:22:09.884043 systemd[1]: Started systemd-journald.service - Journal Service. Oct 21 02:22:09.884425 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 21 02:22:09.885693 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 02:22:09.888545 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 21 02:22:09.893811 systemd-modules-load[195]: Inserted module 'overlay' Oct 21 02:22:09.898287 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 02:22:09.900228 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 02:22:09.904764 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:09.915234 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 21 02:22:09.922089 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 21 02:22:09.923845 systemd-modules-load[195]: Inserted module 'br_netfilter' Oct 21 02:22:09.924401 kernel: Bridge firewalling registered Oct 21 02:22:09.924374 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 21 02:22:09.925592 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 21 02:22:09.934961 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 21 02:22:09.936419 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 21 02:22:09.940919 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 02:22:09.944454 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 21 02:22:09.957383 dracut-cmdline[231]: dracut-dracut-053 Oct 21 02:22:09.960177 dracut-cmdline[231]: Using kernel command line parameters: rd.driver.pre=btrfs 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=0072d1930730cace9bbe19324b8e2e3a0f5b7bb58024d2742317d9d224c5cfeb Oct 21 02:22:09.961713 systemd-resolved[228]: Positive Trust Anchors: Oct 21 02:22:09.961720 systemd-resolved[228]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 21 02:22:09.961743 systemd-resolved[228]: 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 Oct 21 02:22:09.963574 systemd-resolved[228]: Defaulting to hostname 'linux'. Oct 21 02:22:09.964256 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 21 02:22:09.966577 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 21 02:22:10.040102 kernel: SCSI subsystem initialized Oct 21 02:22:10.048097 kernel: Loading iSCSI transport class v2.0-870. Oct 21 02:22:10.058096 kernel: iscsi: registered transport (tcp) Oct 21 02:22:10.078444 kernel: iscsi: registered transport (qla4xxx) Oct 21 02:22:10.078502 kernel: QLogic iSCSI HBA Driver Oct 21 02:22:10.107949 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 21 02:22:10.122249 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 21 02:22:10.143183 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 21 02:22:10.143254 kernel: device-mapper: uevent: version 1.0.3 Oct 21 02:22:10.143269 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 21 02:22:10.179116 kernel: raid6: avx512x4 gen() 44894 MB/s Oct 21 02:22:10.196080 kernel: raid6: avx512x2 gen() 45079 MB/s Oct 21 02:22:10.213109 kernel: raid6: avx512x1 gen() 45799 MB/s Oct 21 02:22:10.230088 kernel: raid6: avx2x4 gen() 36249 MB/s Oct 21 02:22:10.247106 kernel: raid6: avx2x2 gen() 37037 MB/s Oct 21 02:22:10.264631 kernel: raid6: avx2x1 gen() 28098 MB/s Oct 21 02:22:10.264733 kernel: raid6: using algorithm avx512x1 gen() 45799 MB/s Oct 21 02:22:10.283181 kernel: raid6: .... xor() 24148 MB/s, rmw enabled Oct 21 02:22:10.283225 kernel: raid6: using avx512x2 recovery algorithm Oct 21 02:22:10.302096 kernel: xor: automatically using best checksumming function avx Oct 21 02:22:10.438106 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 21 02:22:10.447763 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 21 02:22:10.459204 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 02:22:10.471160 systemd-udevd[415]: Using default interface naming scheme 'v255'. Oct 21 02:22:10.474241 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 02:22:10.481221 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 21 02:22:10.491250 dracut-pre-trigger[421]: rd.md=0: removing MD RAID activation Oct 21 02:22:10.518142 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 21 02:22:10.534249 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 21 02:22:10.567893 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 02:22:10.573206 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 21 02:22:10.581757 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 21 02:22:10.585217 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 21 02:22:10.585994 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 02:22:10.586409 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 21 02:22:10.597267 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 21 02:22:10.604083 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Oct 21 02:22:10.605153 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 21 02:22:10.609331 kernel: cryptd: max_cpu_qlen set to 1000 Oct 21 02:22:10.609362 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Oct 21 02:22:10.617135 kernel: AVX2 version of gcm_enc/dec engaged. Oct 21 02:22:10.617182 kernel: AES CTR mode by8 optimization enabled Oct 21 02:22:10.622047 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 21 02:22:10.627429 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 21 02:22:10.627447 kernel: GPT:9289727 != 19775487 Oct 21 02:22:10.627455 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 21 02:22:10.627462 kernel: GPT:9289727 != 19775487 Oct 21 02:22:10.627468 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 21 02:22:10.627480 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 21 02:22:10.622242 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 02:22:10.632094 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 21 02:22:10.636045 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 02:22:10.637156 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:10.643328 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:10.651082 kernel: BTRFS: device fsid 4040596c-a921-4132-a4d6-a50142c73985 devid 1 transid 32 /dev/vda3 scanned by (udev-worker) (474) Oct 21 02:22:10.651118 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (479) Oct 21 02:22:10.657038 kernel: libata version 3.00 loaded. Oct 21 02:22:10.656267 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:10.662140 kernel: ahci 0000:00:1f.2: version 3.0 Oct 21 02:22:10.662282 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Oct 21 02:22:10.666087 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Oct 21 02:22:10.666195 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Oct 21 02:22:10.667633 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:10.671686 kernel: scsi host0: ahci Oct 21 02:22:10.671827 kernel: scsi host1: ahci Oct 21 02:22:10.671899 kernel: scsi host2: ahci Oct 21 02:22:10.672079 kernel: scsi host3: ahci Oct 21 02:22:10.674246 kernel: scsi host4: ahci Oct 21 02:22:10.674371 kernel: scsi host5: ahci Oct 21 02:22:10.674451 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Oct 21 02:22:10.676495 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Oct 21 02:22:10.676507 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Oct 21 02:22:10.676612 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 21 02:22:10.685330 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Oct 21 02:22:10.685345 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Oct 21 02:22:10.685352 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Oct 21 02:22:10.686572 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 21 02:22:10.693679 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 21 02:22:10.697543 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 21 02:22:10.698175 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 21 02:22:10.716188 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 21 02:22:10.716467 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 02:22:10.716504 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:10.719621 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:10.727304 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 21 02:22:10.727322 disk-uuid[569]: Primary Header is updated. Oct 21 02:22:10.727322 disk-uuid[569]: Secondary Entries is updated. Oct 21 02:22:10.727322 disk-uuid[569]: Secondary Header is updated. Oct 21 02:22:10.733120 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 21 02:22:10.728333 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:10.735395 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 21 02:22:10.744524 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:10.755246 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 21 02:22:10.769623 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 02:22:10.989100 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 21 02:22:10.989193 kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 21 02:22:10.992143 kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 21 02:22:10.992352 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Oct 21 02:22:10.995141 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 21 02:22:10.995197 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 21 02:22:10.996111 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Oct 21 02:22:10.998330 kernel: ata3.00: applying bridge limits Oct 21 02:22:10.998473 kernel: ata3.00: configured for UDMA/100 Oct 21 02:22:11.000199 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Oct 21 02:22:11.045114 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Oct 21 02:22:11.075143 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 21 02:22:11.087171 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Oct 21 02:22:11.735495 disk-uuid[571]: The operation has completed successfully. Oct 21 02:22:11.737438 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 21 02:22:11.759584 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 21 02:22:11.759689 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 21 02:22:11.782280 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 21 02:22:11.785387 sh[601]: Success Oct 21 02:22:11.798084 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Oct 21 02:22:11.827155 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 21 02:22:11.838163 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 21 02:22:11.840550 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 21 02:22:11.855089 kernel: BTRFS info (device dm-0): first mount of filesystem 4040596c-a921-4132-a4d6-a50142c73985 Oct 21 02:22:11.855172 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 21 02:22:11.857590 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 21 02:22:11.857610 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 21 02:22:11.858640 kernel: BTRFS info (device dm-0): using free space tree Oct 21 02:22:11.864223 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 21 02:22:11.865433 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 21 02:22:11.885256 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 21 02:22:11.887406 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 21 02:22:11.899579 kernel: BTRFS info (device vda6): first mount of filesystem 8fa6ab43-41b6-4314-99da-31a41f8f11b8 Oct 21 02:22:11.899614 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 21 02:22:11.899622 kernel: BTRFS info (device vda6): using free space tree Oct 21 02:22:11.903097 kernel: BTRFS info (device vda6): auto enabling async discard Oct 21 02:22:11.909295 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 21 02:22:11.911808 kernel: BTRFS info (device vda6): last unmount of filesystem 8fa6ab43-41b6-4314-99da-31a41f8f11b8 Oct 21 02:22:11.916730 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 21 02:22:11.927604 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 21 02:22:11.987021 ignition[703]: Ignition 2.19.0 Oct 21 02:22:11.987047 ignition[703]: Stage: fetch-offline Oct 21 02:22:11.987113 ignition[703]: no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:11.987120 ignition[703]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:11.987234 ignition[703]: parsed url from cmdline: "" Oct 21 02:22:11.987236 ignition[703]: no config URL provided Oct 21 02:22:11.987240 ignition[703]: reading system config file "/usr/lib/ignition/user.ign" Oct 21 02:22:11.987246 ignition[703]: no config at "/usr/lib/ignition/user.ign" Oct 21 02:22:11.987271 ignition[703]: op(1): [started] loading QEMU firmware config module Oct 21 02:22:11.996248 unknown[703]: fetched base config from "system" Oct 21 02:22:11.987275 ignition[703]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 21 02:22:11.996254 unknown[703]: fetched user config from "qemu" Oct 21 02:22:11.993254 ignition[703]: op(1): [finished] loading QEMU firmware config module Oct 21 02:22:11.998738 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 21 02:22:11.994099 ignition[703]: parsing config with SHA512: de69decb49f27ec7a7f014a18e9b8b6fa38a01f526cda420f2ec9e553e6dde6ad1c8aded6a0ed8cb2bbba17edf32a4f471c4ca57028cd6e9f2284b10aa850233 Oct 21 02:22:11.996510 ignition[703]: fetch-offline: fetch-offline passed Oct 21 02:22:11.996557 ignition[703]: Ignition finished successfully Oct 21 02:22:12.023122 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 21 02:22:12.032240 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 21 02:22:12.049028 systemd-networkd[791]: lo: Link UP Oct 21 02:22:12.049046 systemd-networkd[791]: lo: Gained carrier Oct 21 02:22:12.049896 systemd-networkd[791]: Enumeration completed Oct 21 02:22:12.050002 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 21 02:22:12.050342 systemd-networkd[791]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 21 02:22:12.050344 systemd-networkd[791]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 21 02:22:12.050849 systemd[1]: Reached target network.target - Network. Oct 21 02:22:12.051046 systemd-networkd[791]: eth0: Link UP Oct 21 02:22:12.051048 systemd-networkd[791]: eth0: Gained carrier Oct 21 02:22:12.051088 systemd-networkd[791]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 21 02:22:12.053006 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 21 02:22:12.053680 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 21 02:22:12.072570 ignition[794]: Ignition 2.19.0 Oct 21 02:22:12.072584 ignition[794]: Stage: kargs Oct 21 02:22:12.072750 ignition[794]: no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:12.072758 ignition[794]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:12.075427 systemd-networkd[791]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 21 02:22:12.073393 ignition[794]: kargs: kargs passed Oct 21 02:22:12.075814 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 21 02:22:12.073423 ignition[794]: Ignition finished successfully Oct 21 02:22:12.087251 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 21 02:22:12.098732 ignition[803]: Ignition 2.19.0 Oct 21 02:22:12.098805 ignition[803]: Stage: disks Oct 21 02:22:12.098937 ignition[803]: no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:12.098943 ignition[803]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:12.099481 ignition[803]: disks: disks passed Oct 21 02:22:12.102104 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 21 02:22:12.099508 ignition[803]: Ignition finished successfully Oct 21 02:22:12.104973 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 21 02:22:12.105979 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 21 02:22:12.108821 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 21 02:22:12.109426 systemd[1]: Reached target sysinit.target - System Initialization. Oct 21 02:22:12.113783 systemd[1]: Reached target basic.target - Basic System. Oct 21 02:22:12.129457 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 21 02:22:12.140182 systemd-fsck[813]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 21 02:22:12.143785 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 21 02:22:12.147866 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 21 02:22:12.234078 kernel: EXT4-fs (vda9): mounted filesystem b00a3f09-0b6b-4e9d-841f-e8566d972fe8 r/w with ordered data mode. Quota mode: none. Oct 21 02:22:12.234173 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 21 02:22:12.236646 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 21 02:22:12.250152 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 21 02:22:12.253331 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 21 02:22:12.257162 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 21 02:22:12.260886 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (821) Oct 21 02:22:12.260904 kernel: BTRFS info (device vda6): first mount of filesystem 8fa6ab43-41b6-4314-99da-31a41f8f11b8 Oct 21 02:22:12.260912 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 21 02:22:12.260920 kernel: BTRFS info (device vda6): using free space tree Oct 21 02:22:12.257205 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 21 02:22:12.267857 kernel: BTRFS info (device vda6): auto enabling async discard Oct 21 02:22:12.257223 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 21 02:22:12.264749 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 21 02:22:12.269041 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 21 02:22:12.290206 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 21 02:22:12.317898 initrd-setup-root[845]: cut: /sysroot/etc/passwd: No such file or directory Oct 21 02:22:12.322393 initrd-setup-root[852]: cut: /sysroot/etc/group: No such file or directory Oct 21 02:22:12.326999 initrd-setup-root[859]: cut: /sysroot/etc/shadow: No such file or directory Oct 21 02:22:12.331037 initrd-setup-root[866]: cut: /sysroot/etc/gshadow: No such file or directory Oct 21 02:22:12.399030 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 21 02:22:12.412198 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 21 02:22:12.414211 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 21 02:22:12.421083 kernel: BTRFS info (device vda6): last unmount of filesystem 8fa6ab43-41b6-4314-99da-31a41f8f11b8 Oct 21 02:22:12.433395 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 21 02:22:12.441829 ignition[935]: INFO : Ignition 2.19.0 Oct 21 02:22:12.441829 ignition[935]: INFO : Stage: mount Oct 21 02:22:12.444255 ignition[935]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:12.444255 ignition[935]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:12.444255 ignition[935]: INFO : mount: mount passed Oct 21 02:22:12.444255 ignition[935]: INFO : Ignition finished successfully Oct 21 02:22:12.450560 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 21 02:22:12.464223 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 21 02:22:12.855100 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 21 02:22:12.870369 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 21 02:22:12.877726 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (947) Oct 21 02:22:12.877765 kernel: BTRFS info (device vda6): first mount of filesystem 8fa6ab43-41b6-4314-99da-31a41f8f11b8 Oct 21 02:22:12.877777 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 21 02:22:12.878861 kernel: BTRFS info (device vda6): using free space tree Oct 21 02:22:12.883099 kernel: BTRFS info (device vda6): auto enabling async discard Oct 21 02:22:12.884193 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 21 02:22:12.913817 ignition[964]: INFO : Ignition 2.19.0 Oct 21 02:22:12.913817 ignition[964]: INFO : Stage: files Oct 21 02:22:12.915991 ignition[964]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:12.915991 ignition[964]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:12.919622 ignition[964]: DEBUG : files: compiled without relabeling support, skipping Oct 21 02:22:12.922531 ignition[964]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 21 02:22:12.922531 ignition[964]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 21 02:22:12.929236 ignition[964]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 21 02:22:12.931303 ignition[964]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 21 02:22:12.933352 unknown[964]: wrote ssh authorized keys file for user: core Oct 21 02:22:12.934957 ignition[964]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 21 02:22:12.937192 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Oct 21 02:22:12.940269 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.35.1-x86-64.raw: attempt #1 Oct 21 02:22:13.269171 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Oct 21 02:22:13.333372 systemd-networkd[791]: eth0: Gained IPv6LL Oct 21 02:22:13.451241 ignition[964]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Oct 21 02:22:13.451241 ignition[964]: INFO : files: op(8): [started] processing unit "containerd.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(8): [finished] processing unit "containerd.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Oct 21 02:22:13.457196 ignition[964]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Oct 21 02:22:13.492618 ignition[964]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 21 02:22:13.497148 ignition[964]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 21 02:22:13.499296 ignition[964]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Oct 21 02:22:13.499296 ignition[964]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 21 02:22:13.499296 ignition[964]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 21 02:22:13.499296 ignition[964]: INFO : files: files passed Oct 21 02:22:13.499296 ignition[964]: INFO : Ignition finished successfully Oct 21 02:22:13.507086 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 21 02:22:13.516303 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 21 02:22:13.517769 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 21 02:22:13.521020 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 21 02:22:13.521125 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 21 02:22:13.528398 initrd-setup-root-after-ignition[992]: grep: /sysroot/oem/oem-release: No such file or directory Oct 21 02:22:13.532114 initrd-setup-root-after-ignition[994]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 21 02:22:13.532114 initrd-setup-root-after-ignition[994]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 21 02:22:13.536202 initrd-setup-root-after-ignition[998]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 21 02:22:13.538975 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 21 02:22:13.539694 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 21 02:22:13.555309 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 21 02:22:13.576491 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 21 02:22:13.576611 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 21 02:22:13.579606 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 21 02:22:13.580387 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 21 02:22:13.583844 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 21 02:22:13.593218 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 21 02:22:13.604985 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 21 02:22:13.606976 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 21 02:22:13.619519 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 21 02:22:13.620404 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 02:22:13.623109 systemd[1]: Stopped target timers.target - Timer Units. Oct 21 02:22:13.626025 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 21 02:22:13.626223 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 21 02:22:13.630401 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 21 02:22:13.631142 systemd[1]: Stopped target basic.target - Basic System. Oct 21 02:22:13.636337 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 21 02:22:13.636976 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 21 02:22:13.642179 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 21 02:22:13.645075 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 21 02:22:13.645784 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 21 02:22:13.650936 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 21 02:22:13.653537 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 21 02:22:13.656179 systemd[1]: Stopped target swap.target - Swaps. Oct 21 02:22:13.658253 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 21 02:22:13.658439 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 21 02:22:13.662149 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 21 02:22:13.662839 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 02:22:13.665559 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 21 02:22:13.668836 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 02:22:13.669412 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 21 02:22:13.669537 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 21 02:22:13.675786 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 21 02:22:13.675957 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 21 02:22:13.676763 systemd[1]: Stopped target paths.target - Path Units. Oct 21 02:22:13.681960 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 21 02:22:13.683465 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 02:22:13.686867 systemd[1]: Stopped target slices.target - Slice Units. Oct 21 02:22:13.687471 systemd[1]: Stopped target sockets.target - Socket Units. Oct 21 02:22:13.691558 systemd[1]: iscsid.socket: Deactivated successfully. Oct 21 02:22:13.691718 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 21 02:22:13.693905 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 21 02:22:13.694011 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 21 02:22:13.696262 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 21 02:22:13.696380 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 21 02:22:13.696910 systemd[1]: ignition-files.service: Deactivated successfully. Oct 21 02:22:13.697029 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 21 02:22:13.712387 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 21 02:22:13.714638 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 21 02:22:13.717681 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 21 02:22:13.717901 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 02:22:13.718613 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 21 02:22:13.718756 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 21 02:22:13.728820 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 21 02:22:13.728911 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 21 02:22:13.734141 ignition[1019]: INFO : Ignition 2.19.0 Oct 21 02:22:13.734141 ignition[1019]: INFO : Stage: umount Oct 21 02:22:13.734141 ignition[1019]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 21 02:22:13.734141 ignition[1019]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 21 02:22:13.734141 ignition[1019]: INFO : umount: umount passed Oct 21 02:22:13.734141 ignition[1019]: INFO : Ignition finished successfully Oct 21 02:22:13.734158 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 21 02:22:13.734243 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 21 02:22:13.737957 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 21 02:22:13.739828 systemd[1]: Stopped target network.target - Network. Oct 21 02:22:13.740369 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 21 02:22:13.740418 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 21 02:22:13.744613 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 21 02:22:13.744683 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 21 02:22:13.746905 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 21 02:22:13.746940 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 21 02:22:13.750000 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 21 02:22:13.750035 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 21 02:22:13.751018 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 21 02:22:13.754425 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 21 02:22:13.760219 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 21 02:22:13.760315 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 21 02:22:13.763450 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 21 02:22:13.763491 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 02:22:13.769172 systemd-networkd[791]: eth0: DHCPv6 lease lost Oct 21 02:22:13.774379 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 21 02:22:13.774489 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 21 02:22:13.775221 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 21 02:22:13.775285 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 21 02:22:13.782407 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 21 02:22:13.782450 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 21 02:22:13.782880 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 21 02:22:13.782916 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 21 02:22:13.797217 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 21 02:22:13.798478 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 21 02:22:13.798529 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 21 02:22:13.801423 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 21 02:22:13.801459 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 21 02:22:13.804360 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 21 02:22:13.804400 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 21 02:22:13.805950 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 02:22:13.816436 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 21 02:22:13.816595 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 21 02:22:13.829898 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 21 02:22:13.830033 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 02:22:13.833329 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 21 02:22:13.833365 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 21 02:22:13.836357 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 21 02:22:13.836388 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 21 02:22:13.839103 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 21 02:22:13.839148 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 21 02:22:13.841893 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 21 02:22:13.841923 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 21 02:22:13.846046 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 21 02:22:13.846118 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 21 02:22:13.861341 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 21 02:22:13.862038 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 21 02:22:13.862138 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 02:22:13.864941 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 21 02:22:13.864992 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 02:22:13.867703 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 21 02:22:13.867738 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 02:22:13.870735 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 02:22:13.870768 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:13.874179 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 21 02:22:13.874255 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 21 02:22:13.877203 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 21 02:22:13.883185 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 21 02:22:13.892725 systemd[1]: Switching root. Oct 21 02:22:13.917697 systemd-journald[194]: Journal stopped Oct 21 02:22:14.618936 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). Oct 21 02:22:14.618996 kernel: SELinux: policy capability network_peer_controls=1 Oct 21 02:22:14.619020 kernel: SELinux: policy capability open_perms=1 Oct 21 02:22:14.619030 kernel: SELinux: policy capability extended_socket_class=1 Oct 21 02:22:14.619037 kernel: SELinux: policy capability always_check_network=0 Oct 21 02:22:14.619045 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 21 02:22:14.619077 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 21 02:22:14.619085 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 21 02:22:14.619092 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 21 02:22:14.619103 kernel: audit: type=1403 audit(1792549334.049:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 21 02:22:14.619114 systemd[1]: Successfully loaded SELinux policy in 32.055ms. Oct 21 02:22:14.619131 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.080ms. Oct 21 02:22:14.619140 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Oct 21 02:22:14.619148 systemd[1]: Detected virtualization kvm. Oct 21 02:22:14.619156 systemd[1]: Detected architecture x86-64. Oct 21 02:22:14.619164 systemd[1]: Detected first boot. Oct 21 02:22:14.619172 systemd[1]: Initializing machine ID from VM UUID. Oct 21 02:22:14.619180 zram_generator::config[1085]: No configuration found. Oct 21 02:22:14.619188 systemd[1]: Populated /etc with preset unit settings. Oct 21 02:22:14.619198 systemd[1]: Queued start job for default target multi-user.target. Oct 21 02:22:14.619209 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 21 02:22:14.619218 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 21 02:22:14.619225 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 21 02:22:14.619233 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 21 02:22:14.619243 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 21 02:22:14.619257 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 21 02:22:14.619265 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 21 02:22:14.619275 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 21 02:22:14.619282 systemd[1]: Created slice user.slice - User and Session Slice. Oct 21 02:22:14.619293 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 21 02:22:14.619301 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 21 02:22:14.619309 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 21 02:22:14.619316 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 21 02:22:14.619324 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 21 02:22:14.619332 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 21 02:22:14.619340 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 21 02:22:14.619349 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 21 02:22:14.619357 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 21 02:22:14.619364 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 21 02:22:14.619373 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 21 02:22:14.619380 systemd[1]: Reached target slices.target - Slice Units. Oct 21 02:22:14.619388 systemd[1]: Reached target swap.target - Swaps. Oct 21 02:22:14.619395 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 21 02:22:14.619402 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 21 02:22:14.619411 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 21 02:22:14.619421 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 21 02:22:14.619429 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 21 02:22:14.619436 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 21 02:22:14.619444 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 21 02:22:14.619452 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 21 02:22:14.619460 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 21 02:22:14.619467 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 21 02:22:14.619475 systemd[1]: Mounting media.mount - External Media Directory... Oct 21 02:22:14.619484 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:14.619492 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 21 02:22:14.619499 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 21 02:22:14.619506 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 21 02:22:14.619514 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 21 02:22:14.619522 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 21 02:22:14.619530 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 21 02:22:14.619538 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 21 02:22:14.619545 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 21 02:22:14.619555 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 21 02:22:14.619563 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 21 02:22:14.619571 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 21 02:22:14.619578 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 21 02:22:14.619587 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 21 02:22:14.619595 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Oct 21 02:22:14.619603 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.) Oct 21 02:22:14.619613 kernel: fuse: init (API version 7.39) Oct 21 02:22:14.619622 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 21 02:22:14.619629 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 21 02:22:14.619637 kernel: loop: module loaded Oct 21 02:22:14.619644 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 21 02:22:14.619686 systemd-journald[1173]: Collecting audit messages is disabled. Oct 21 02:22:14.619705 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 21 02:22:14.619714 systemd-journald[1173]: Journal started Oct 21 02:22:14.619732 systemd-journald[1173]: Runtime Journal (/run/log/journal/801830ea48f34876b717504c54e12b0b) is 6.0M, max 48.2M, 42.2M free. Oct 21 02:22:14.629250 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 21 02:22:14.633211 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:14.633362 kernel: ACPI: bus type drm_connector registered Oct 21 02:22:14.639449 systemd[1]: Started systemd-journald.service - Journal Service. Oct 21 02:22:14.641644 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 21 02:22:14.643851 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 21 02:22:14.645959 systemd[1]: Mounted media.mount - External Media Directory. Oct 21 02:22:14.647835 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 21 02:22:14.649842 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 21 02:22:14.652008 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 21 02:22:14.653828 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 21 02:22:14.655891 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 21 02:22:14.657896 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 21 02:22:14.658041 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 21 02:22:14.660460 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 21 02:22:14.660822 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 21 02:22:14.663282 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 21 02:22:14.663475 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 21 02:22:14.665903 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 21 02:22:14.666108 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 21 02:22:14.668842 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 21 02:22:14.668974 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 21 02:22:14.671477 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 21 02:22:14.671658 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 21 02:22:14.674159 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 21 02:22:14.676347 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 21 02:22:14.678413 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 21 02:22:14.689395 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 21 02:22:14.702240 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 21 02:22:14.704830 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 21 02:22:14.706775 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 21 02:22:14.709532 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 21 02:22:14.711839 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 21 02:22:14.712418 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 21 02:22:14.713176 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 21 02:22:14.715828 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 21 02:22:14.717259 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 21 02:22:14.721040 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 21 02:22:14.723810 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 21 02:22:14.725256 systemd-journald[1173]: Time spent on flushing to /var/log/journal/801830ea48f34876b717504c54e12b0b is 10.885ms for 974 entries. Oct 21 02:22:14.725256 systemd-journald[1173]: System Journal (/var/log/journal/801830ea48f34876b717504c54e12b0b) is 8.0M, max 195.6M, 187.6M free. Oct 21 02:22:14.742231 systemd-journald[1173]: Received client request to flush runtime journal. Oct 21 02:22:14.727505 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 21 02:22:14.733213 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 21 02:22:14.735206 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 21 02:22:14.738917 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 21 02:22:14.753442 systemd-tmpfiles[1219]: ACLs are not supported, ignoring. Oct 21 02:22:14.753462 systemd-tmpfiles[1219]: ACLs are not supported, ignoring. Oct 21 02:22:14.754196 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 21 02:22:14.756300 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 21 02:22:14.758585 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 21 02:22:14.760354 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 21 02:22:14.764319 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 21 02:22:14.767192 udevadm[1229]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 21 02:22:14.788300 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 21 02:22:14.801447 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 21 02:22:14.814605 systemd-tmpfiles[1240]: ACLs are not supported, ignoring. Oct 21 02:22:14.814630 systemd-tmpfiles[1240]: ACLs are not supported, ignoring. Oct 21 02:22:14.818261 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 21 02:22:15.089042 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 21 02:22:15.107307 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 21 02:22:15.123531 systemd-udevd[1246]: Using default interface naming scheme 'v255'. Oct 21 02:22:15.137220 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 21 02:22:15.146405 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 21 02:22:15.160175 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 21 02:22:15.165329 systemd[1]: Found device dev-ttyS0.device - /dev/ttyS0. Oct 21 02:22:15.174117 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1247) Oct 21 02:22:15.200952 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 21 02:22:15.216369 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 21 02:22:15.220086 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 21 02:22:15.226426 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Oct 21 02:22:15.226651 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Oct 21 02:22:15.226711 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 21 02:22:15.228081 kernel: ACPI: button: Power Button [PWRF] Oct 21 02:22:15.230038 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Oct 21 02:22:15.234195 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Oct 21 02:22:15.254576 systemd-networkd[1253]: lo: Link UP Oct 21 02:22:15.254584 systemd-networkd[1253]: lo: Gained carrier Oct 21 02:22:15.256191 systemd-networkd[1253]: Enumeration completed Oct 21 02:22:15.256938 systemd-networkd[1253]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 21 02:22:15.257013 systemd-networkd[1253]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 21 02:22:15.257166 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 21 02:22:15.257787 systemd-networkd[1253]: eth0: Link UP Oct 21 02:22:15.257792 systemd-networkd[1253]: eth0: Gained carrier Oct 21 02:22:15.257806 systemd-networkd[1253]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 21 02:22:15.266234 kernel: mousedev: PS/2 mouse device common for all mice Oct 21 02:22:15.269349 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 21 02:22:15.272146 systemd-networkd[1253]: eth0: DHCPv4 address 10.0.0.16/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 21 02:22:15.279328 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:15.285311 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 21 02:22:15.285532 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:15.319883 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 21 02:22:15.390811 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 21 02:22:15.405137 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 21 02:22:15.423234 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 21 02:22:15.430857 lvm[1295]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 21 02:22:15.470926 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 21 02:22:15.472865 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 21 02:22:15.493355 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 21 02:22:15.499155 lvm[1298]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 21 02:22:15.523199 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 21 02:22:15.525205 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 21 02:22:15.527010 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). Oct 21 02:22:15.527046 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 21 02:22:15.528535 systemd[1]: Reached target machines.target - Containers. Oct 21 02:22:15.530963 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 21 02:22:15.546433 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 21 02:22:15.549560 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 21 02:22:15.550994 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 21 02:22:15.551801 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 21 02:22:15.554273 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 21 02:22:15.558178 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 21 02:22:15.560647 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 21 02:22:15.566857 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 21 02:22:15.569085 kernel: loop0: detected capacity change from 0 to 140768 Oct 21 02:22:15.577269 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 21 02:22:15.577881 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 21 02:22:15.591077 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 21 02:22:15.618080 kernel: loop1: detected capacity change from 0 to 142488 Oct 21 02:22:15.652103 kernel: loop2: detected capacity change from 0 to 217752 Oct 21 02:22:15.687187 kernel: loop3: detected capacity change from 0 to 140768 Oct 21 02:22:15.698215 kernel: loop4: detected capacity change from 0 to 142488 Oct 21 02:22:15.708101 kernel: loop5: detected capacity change from 0 to 217752 Oct 21 02:22:15.714413 (sd-merge)[1320]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Oct 21 02:22:15.714782 (sd-merge)[1320]: Merged extensions into '/usr'. Oct 21 02:22:15.717359 systemd[1]: Reloading requested from client PID 1306 ('systemd-sysext') (unit systemd-sysext.service)... Oct 21 02:22:15.717378 systemd[1]: Reloading... Oct 21 02:22:15.755157 zram_generator::config[1345]: No configuration found. Oct 21 02:22:15.770011 ldconfig[1303]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 21 02:22:15.837151 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 21 02:22:15.893511 systemd[1]: Reloading finished in 175 ms. Oct 21 02:22:15.918590 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 21 02:22:15.920462 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 21 02:22:15.937438 systemd[1]: Starting ensure-sysext.service... Oct 21 02:22:15.939984 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 21 02:22:15.943818 systemd[1]: Reloading requested from client PID 1392 ('systemctl') (unit ensure-sysext.service)... Oct 21 02:22:15.943839 systemd[1]: Reloading... Oct 21 02:22:15.957985 systemd-tmpfiles[1393]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 21 02:22:15.958376 systemd-tmpfiles[1393]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 21 02:22:15.958913 systemd-tmpfiles[1393]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 21 02:22:15.959150 systemd-tmpfiles[1393]: ACLs are not supported, ignoring. Oct 21 02:22:15.959198 systemd-tmpfiles[1393]: ACLs are not supported, ignoring. Oct 21 02:22:15.961277 systemd-tmpfiles[1393]: Detected autofs mount point /boot during canonicalization of boot. Oct 21 02:22:15.961294 systemd-tmpfiles[1393]: Skipping /boot Oct 21 02:22:15.966784 systemd-tmpfiles[1393]: Detected autofs mount point /boot during canonicalization of boot. Oct 21 02:22:15.966793 systemd-tmpfiles[1393]: Skipping /boot Oct 21 02:22:15.977097 zram_generator::config[1417]: No configuration found. Oct 21 02:22:16.062376 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 21 02:22:16.102459 systemd[1]: Reloading finished in 158 ms. Oct 21 02:22:16.118571 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 21 02:22:16.139648 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 21 02:22:16.143266 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 21 02:22:16.146965 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 21 02:22:16.149811 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 21 02:22:16.154172 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 21 02:22:16.166997 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.167183 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 21 02:22:16.171284 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 21 02:22:16.175341 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 21 02:22:16.182715 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 21 02:22:16.184532 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 21 02:22:16.184804 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.186214 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 21 02:22:16.186863 augenrules[1493]: No rules Oct 21 02:22:16.188712 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 21 02:22:16.190824 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 21 02:22:16.190985 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 21 02:22:16.193126 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 21 02:22:16.193233 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 21 02:22:16.195589 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 21 02:22:16.195735 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 21 02:22:16.198286 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 21 02:22:16.200391 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 21 02:22:16.207973 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.208130 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 21 02:22:16.212297 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 21 02:22:16.214777 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 21 02:22:16.215132 systemd-resolved[1470]: Positive Trust Anchors: Oct 21 02:22:16.215142 systemd-resolved[1470]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 21 02:22:16.215178 systemd-resolved[1470]: 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 Oct 21 02:22:16.217269 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 21 02:22:16.217863 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 21 02:22:16.219600 systemd-resolved[1470]: Defaulting to hostname 'linux'. Oct 21 02:22:16.220372 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 21 02:22:16.223614 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). Oct 21 02:22:16.223793 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.224807 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 21 02:22:16.226799 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 21 02:22:16.226941 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 21 02:22:16.228736 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 21 02:22:16.228844 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 21 02:22:16.230764 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 21 02:22:16.230904 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 21 02:22:16.232659 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 21 02:22:16.237978 systemd[1]: Reached target network.target - Network. Oct 21 02:22:16.239308 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 21 02:22:16.241340 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.241716 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 21 02:22:16.246293 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 21 02:22:16.247952 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 21 02:22:16.249956 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 21 02:22:16.253166 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 21 02:22:16.254695 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 21 02:22:16.254856 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). Oct 21 02:22:16.254967 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 21 02:22:16.256488 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 21 02:22:16.256619 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 21 02:22:16.258954 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 21 02:22:16.259145 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 21 02:22:16.261107 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 21 02:22:16.261239 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 21 02:22:16.263419 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 21 02:22:16.263697 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 21 02:22:16.266975 systemd[1]: Finished ensure-sysext.service. Oct 21 02:22:16.271809 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 21 02:22:16.271881 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 21 02:22:16.287341 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 21 02:22:16.339178 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 21 02:22:16.341083 systemd[1]: Reached target sysinit.target - System Initialization. Oct 21 02:22:17.684912 systemd-resolved[1470]: Clock change detected. Flushing caches. Oct 21 02:22:17.684950 systemd-timesyncd[1538]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 21 02:22:17.684992 systemd-timesyncd[1538]: Initial clock synchronization to Wed 2026-10-21 02:22:17.684839 UTC. Oct 21 02:22:17.686396 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 21 02:22:17.688083 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 21 02:22:17.689666 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 21 02:22:17.691248 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 21 02:22:17.691279 systemd[1]: Reached target paths.target - Path Units. Oct 21 02:22:17.692632 systemd[1]: Reached target time-set.target - System Time Set. Oct 21 02:22:17.694066 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 21 02:22:17.695504 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 21 02:22:17.697080 systemd[1]: Reached target timers.target - Timer Units. Oct 21 02:22:17.698766 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 21 02:22:17.701612 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 21 02:22:17.703635 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 21 02:22:17.710495 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 21 02:22:17.711881 systemd[1]: Reached target sockets.target - Socket Units. Oct 21 02:22:17.713109 systemd[1]: Reached target basic.target - Basic System. Oct 21 02:22:17.714456 systemd[1]: System is tainted: cgroupsv1 Oct 21 02:22:17.714491 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 21 02:22:17.714506 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 21 02:22:17.715366 systemd[1]: Starting containerd.service - containerd container runtime... Oct 21 02:22:17.717409 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 21 02:22:17.719635 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 21 02:22:17.724519 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 21 02:22:17.725869 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). Oct 21 02:22:17.727560 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 21 02:22:17.729646 jq[1544]: false Oct 21 02:22:17.731317 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 21 02:22:17.736377 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 21 02:22:17.741722 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 21 02:22:17.743139 extend-filesystems[1545]: Found loop3 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found loop4 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found loop5 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found sr0 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda1 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda2 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda3 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found usr Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda4 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda6 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda7 Oct 21 02:22:17.743139 extend-filesystems[1545]: Found vda9 Oct 21 02:22:17.743139 extend-filesystems[1545]: Checking size of /dev/vda9 Oct 21 02:22:17.771475 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1261) Oct 21 02:22:17.771504 extend-filesystems[1545]: Resized partition /dev/vda9 Oct 21 02:22:17.779360 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Oct 21 02:22:17.743587 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 21 02:22:17.747322 dbus-daemon[1543]: [system] SELinux support is enabled Oct 21 02:22:17.779702 extend-filesystems[1568]: resize2fs 1.47.1 (20-May-2024) Oct 21 02:22:17.746268 systemd[1]: Starting update-engine.service - Update Engine... Oct 21 02:22:17.749659 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 21 02:22:17.782497 update_engine[1557]: I20261021 02:22:17.774354 1557 main.cc:92] Flatcar Update Engine starting Oct 21 02:22:17.752663 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 21 02:22:17.767708 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 21 02:22:17.767928 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 21 02:22:17.768144 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 21 02:22:17.768295 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 21 02:22:17.779783 systemd[1]: motdgen.service: Deactivated successfully. Oct 21 02:22:17.779938 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 21 02:22:17.784491 jq[1560]: true Oct 21 02:22:17.786037 update_engine[1557]: I20261021 02:22:17.785969 1557 update_check_scheduler.cc:74] Next update check in 8m29s Oct 21 02:22:17.799427 jq[1577]: true Oct 21 02:22:17.799085 (ntainerd)[1573]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 21 02:22:17.808110 systemd[1]: Started update-engine.service - Update Engine. Oct 21 02:22:17.808915 systemd-logind[1552]: Watching system buttons on /dev/input/event1 (Power Button) Oct 21 02:22:17.808927 systemd-logind[1552]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 21 02:22:17.810274 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). Oct 21 02:22:17.810308 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 21 02:22:17.810814 systemd-logind[1552]: New seat seat0. Oct 21 02:22:17.812485 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). Oct 21 02:22:17.812509 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 21 02:22:17.814772 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 21 02:22:17.823209 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 21 02:22:17.841629 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Oct 21 02:22:17.841668 extend-filesystems[1568]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 21 02:22:17.841668 extend-filesystems[1568]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 21 02:22:17.841668 extend-filesystems[1568]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Oct 21 02:22:17.824763 systemd[1]: Started systemd-logind.service - User Login Management. Oct 21 02:22:17.851400 extend-filesystems[1545]: Resized filesystem in /dev/vda9 Oct 21 02:22:17.844873 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 21 02:22:17.845097 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 21 02:22:17.856314 locksmithd[1590]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 21 02:22:17.856798 bash[1600]: Updated "/home/core/.ssh/authorized_keys" Oct 21 02:22:17.857715 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 21 02:22:17.861153 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 21 02:22:17.877898 systemd-networkd[1253]: eth0: Gained IPv6LL Oct 21 02:22:17.879202 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 21 02:22:17.881995 systemd[1]: Reached target network-online.target - Network is Online. Oct 21 02:22:17.882491 sshd_keygen[1569]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 21 02:22:17.889594 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 21 02:22:17.892820 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 21 02:22:17.896137 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 21 02:22:17.912307 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 21 02:22:17.914590 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 21 02:22:17.914745 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 21 02:22:17.924811 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 21 02:22:17.926195 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 21 02:22:17.926867 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 21 02:22:17.931793 systemd[1]: issuegen.service: Deactivated successfully. Oct 21 02:22:17.932056 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 21 02:22:17.936541 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 21 02:22:17.948386 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 21 02:22:17.960840 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 21 02:22:17.963772 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 21 02:22:17.965681 systemd[1]: Reached target getty.target - Login Prompts. Oct 21 02:22:17.979251 containerd[1573]: time="2026-10-21T02:22:17.979145199Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Oct 21 02:22:17.995758 containerd[1573]: time="2026-10-21T02:22:17.995666258Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.997188 containerd[1573]: time="2026-10-21T02:22:17.997131344Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.159-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 21 02:22:17.997188 containerd[1573]: time="2026-10-21T02:22:17.997165436Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 21 02:22:17.997188 containerd[1573]: time="2026-10-21T02:22:17.997179901Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 21 02:22:17.997287 containerd[1573]: time="2026-10-21T02:22:17.997280189Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 21 02:22:17.997303 containerd[1573]: time="2026-10-21T02:22:17.997292460Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997583198Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997638698Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997887687Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997942690Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997959671Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.997972212Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998250 containerd[1573]: time="2026-10-21T02:22:17.998140646Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998675 containerd[1573]: time="2026-10-21T02:22:17.998660602Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998844 containerd[1573]: time="2026-10-21T02:22:17.998822395Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Oct 21 02:22:17.998910 containerd[1573]: time="2026-10-21T02:22:17.998900512Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 21 02:22:17.998994 containerd[1573]: time="2026-10-21T02:22:17.998986484Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 21 02:22:17.999091 containerd[1573]: time="2026-10-21T02:22:17.999079993Z" level=info msg="metadata content store policy set" policy=shared Oct 21 02:22:18.002511 containerd[1573]: time="2026-10-21T02:22:18.002489130Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 21 02:22:18.002561 containerd[1573]: time="2026-10-21T02:22:18.002533086Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 21 02:22:18.002561 containerd[1573]: time="2026-10-21T02:22:18.002546113Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 21 02:22:18.002561 containerd[1573]: time="2026-10-21T02:22:18.002557287Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 21 02:22:18.002621 containerd[1573]: time="2026-10-21T02:22:18.002568245Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 21 02:22:18.002671 containerd[1573]: time="2026-10-21T02:22:18.002654316Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 21 02:22:18.002951 containerd[1573]: time="2026-10-21T02:22:18.002915735Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 21 02:22:18.003081 containerd[1573]: time="2026-10-21T02:22:18.003027000Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 21 02:22:18.003100 containerd[1573]: time="2026-10-21T02:22:18.003079587Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 21 02:22:18.003100 containerd[1573]: time="2026-10-21T02:22:18.003089863Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 21 02:22:18.003125 containerd[1573]: time="2026-10-21T02:22:18.003100861Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003125 containerd[1573]: time="2026-10-21T02:22:18.003111394Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003125 containerd[1573]: time="2026-10-21T02:22:18.003120207Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003160 containerd[1573]: time="2026-10-21T02:22:18.003129804Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003160 containerd[1573]: time="2026-10-21T02:22:18.003140407Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003160 containerd[1573]: time="2026-10-21T02:22:18.003152385Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003202 containerd[1573]: time="2026-10-21T02:22:18.003161369Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003202 containerd[1573]: time="2026-10-21T02:22:18.003170135Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 21 02:22:18.003202 containerd[1573]: time="2026-10-21T02:22:18.003184360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003202 containerd[1573]: time="2026-10-21T02:22:18.003194099Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003203557Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003212670Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003221179Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003230245Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003238465Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003256 containerd[1573]: time="2026-10-21T02:22:18.003247044Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003256805Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003273904Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003283458Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003291768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003299988Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003310962Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003325557Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003334 containerd[1573]: time="2026-10-21T02:22:18.003333559Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003341734Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003376447Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003388928Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003396602Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003405643Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003435504Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003446577Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 21 02:22:18.003453 containerd[1573]: time="2026-10-21T02:22:18.003453896Z" level=info msg="NRI interface is disabled by configuration." Oct 21 02:22:18.003558 containerd[1573]: time="2026-10-21T02:22:18.003461610Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 21 02:22:18.003690 containerd[1573]: time="2026-10-21T02:22:18.003652678Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:false] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} 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}" Oct 21 02:22:18.003804 containerd[1573]: time="2026-10-21T02:22:18.003697055Z" level=info msg="Connect containerd service" Oct 21 02:22:18.003804 containerd[1573]: time="2026-10-21T02:22:18.003721235Z" level=info msg="using legacy CRI server" Oct 21 02:22:18.003804 containerd[1573]: time="2026-10-21T02:22:18.003725777Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 21 02:22:18.003869 containerd[1573]: time="2026-10-21T02:22:18.003814601Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 21 02:22:18.004252 containerd[1573]: time="2026-10-21T02:22:18.004230540Z" 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" Oct 21 02:22:18.004399 containerd[1573]: time="2026-10-21T02:22:18.004366145Z" level=info msg="Start subscribing containerd event" Oct 21 02:22:18.004456 containerd[1573]: time="2026-10-21T02:22:18.004404066Z" level=info msg="Start recovering state" Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004506036Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004510244Z" level=info msg="Start event monitor" Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004551404Z" level=info msg="Start snapshots syncer" Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004562745Z" level=info msg="Start cni network conf syncer for default" Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004569417Z" level=info msg="Start streaming server" Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004566063Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 21 02:22:18.004670 containerd[1573]: time="2026-10-21T02:22:18.004641469Z" level=info msg="containerd successfully booted in 0.026992s" Oct 21 02:22:18.004789 systemd[1]: Started containerd.service - containerd container runtime. Oct 21 02:22:18.534507 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 21 02:22:18.536468 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 21 02:22:18.538148 systemd[1]: Startup finished in 5.289s (kernel) + 3.175s (userspace) = 8.464s. Oct 21 02:22:18.538944 (kubelet)[1672]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Oct 21 02:22:18.877493 kubelet[1672]: E1021 02:22:18.877344 1672 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" Oct 21 02:22:18.879461 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Oct 21 02:22:18.879585 systemd[1]: kubelet.service: Failed with result 'exit-code'. Oct 21 02:22:24.169142 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 21 02:22:24.179617 systemd[1]: Started sshd@0-10.0.0.16:22-10.0.0.1:50984.service - OpenSSH per-connection server daemon (10.0.0.1:50984). Oct 21 02:22:24.224339 sshd[1686]: Accepted publickey for core from 10.0.0.1 port 50984 ssh2: RSA SHA256:rhPn/Ye82NVm+nkyPGp3yf9osD605bTCG61O+izBTHI Oct 21 02:22:24.226225 sshd[1686]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 02:22:24.233112 systemd-logind[1552]: New session 1 of user core. Oct 21 02:22:24.233837 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 21 02:22:24.244657 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 21 02:22:24.252730 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 21 02:22:24.254329 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 21 02:22:24.259886 (systemd)[1692]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 21 02:22:24.340643 systemd[1692]: Queued start job for default target default.target. Oct 21 02:22:24.340936 systemd[1692]: Created slice app.slice - User Application Slice. Oct 21 02:22:24.340963 systemd[1692]: Reached target paths.target - Paths. Oct 21 02:22:24.340972 systemd[1692]: Reached target timers.target - Timers. Oct 21 02:22:24.354549 systemd[1692]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 21 02:22:24.359500 systemd[1692]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 21 02:22:24.359544 systemd[1692]: Reached target sockets.target - Sockets. Oct 21 02:22:24.359552 systemd[1692]: Reached target basic.target - Basic System. Oct 21 02:22:24.359576 systemd[1692]: Reached target default.target - Main User Target. Oct 21 02:22:24.359594 systemd[1692]: Startup finished in 94ms. Oct 21 02:22:24.359857 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 21 02:22:24.360857 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 21 02:22:24.419087 systemd[1]: Started sshd@1-10.0.0.16:22-10.0.0.1:50992.service - OpenSSH per-connection server daemon (10.0.0.1:50992). Oct 21 02:22:24.452517 sshd[1704]: Accepted publickey for core from 10.0.0.1 port 50992 ssh2: RSA SHA256:rhPn/Ye82NVm+nkyPGp3yf9osD605bTCG61O+izBTHI Oct 21 02:22:24.453538 sshd[1704]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 02:22:24.456787 systemd-logind[1552]: New session 2 of user core. Oct 21 02:22:24.468603 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 21 02:22:24.519533 sshd[1704]: pam_unix(sshd:session): session closed for user core Oct 21 02:22:24.542834 systemd[1]: Started sshd@2-10.0.0.16:22-10.0.0.1:51004.service - OpenSSH per-connection server daemon (10.0.0.1:51004). Oct 21 02:22:24.543176 systemd[1]: sshd@1-10.0.0.16:22-10.0.0.1:50992.service: Deactivated successfully. Oct 21 02:22:24.544354 systemd[1]: session-2.scope: Deactivated successfully. Oct 21 02:22:24.545041 systemd-logind[1552]: Session 2 logged out. Waiting for processes to exit. Oct 21 02:22:24.546228 systemd-logind[1552]: Removed session 2. Oct 21 02:22:24.573333 sshd[1709]: Accepted publickey for core from 10.0.0.1 port 51004 ssh2: RSA SHA256:rhPn/Ye82NVm+nkyPGp3yf9osD605bTCG61O+izBTHI Oct 21 02:22:24.574213 sshd[1709]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 02:22:24.577305 systemd-logind[1552]: New session 3 of user core. Oct 21 02:22:24.592621 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 21 02:22:24.639708 sshd[1709]: pam_unix(sshd:session): session closed for user core Oct 21 02:22:24.651051 systemd[1]: Started sshd@3-10.0.0.16:22-10.0.0.1:51016.service - OpenSSH per-connection server daemon (10.0.0.1:51016). Oct 21 02:22:24.651341 systemd[1]: sshd@2-10.0.0.16:22-10.0.0.1:51004.service: Deactivated successfully. Oct 21 02:22:24.652889 systemd-logind[1552]: Session 3 logged out. Waiting for processes to exit. Oct 21 02:22:24.653244 systemd[1]: session-3.scope: Deactivated successfully. Oct 21 02:22:24.654110 systemd-logind[1552]: Removed session 3. Oct 21 02:22:24.681014 sshd[1717]: Accepted publickey for core from 10.0.0.1 port 51016 ssh2: RSA SHA256:rhPn/Ye82NVm+nkyPGp3yf9osD605bTCG61O+izBTHI Oct 21 02:22:24.681839 sshd[1717]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 02:22:24.684610 systemd-logind[1552]: New session 4 of user core. Oct 21 02:22:24.694582 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 21 02:22:24.744690 sshd[1717]: pam_unix(sshd:session): session closed for user core Oct 21 02:22:24.761599 systemd[1]: Started sshd@4-10.0.0.16:22-10.0.0.1:51018.service - OpenSSH per-connection server daemon (10.0.0.1:51018). Oct 21 02:22:24.761851 systemd[1]: sshd@3-10.0.0.16:22-10.0.0.1:51016.service: Deactivated successfully. Oct 21 02:22:24.763402 systemd-logind[1552]: Session 4 logged out. Waiting for processes to exit. Oct 21 02:22:24.763856 systemd[1]: session-4.scope: Deactivated successfully. Oct 21 02:22:24.764561 systemd-logind[1552]: Removed session 4. Oct 21 02:22:24.792955 sshd[1725]: Accepted publickey for core from 10.0.0.1 port 51018 ssh2: RSA SHA256:rhPn/Ye82NVm+nkyPGp3yf9osD605bTCG61O+izBTHI Oct 21 02:22:24.794332 sshd[1725]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 21 02:22:24.798443 systemd-logind[1552]: New session 5 of user core. Oct 21 02:22:24.808605 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 21 02:22:24.863950 sudo[1732]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Oct 21 02:22:24.864186 sudo[1732]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 21 02:22:24.882790 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 21 02:22:24.895804 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 21 02:22:24.895979 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 21 02:22:25.330383 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 21 02:22:25.339974 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 21 02:22:25.358595 systemd[1]: Reloading requested from client PID 1787 ('systemctl') (unit session-5.scope)... Oct 21 02:22:25.358619 systemd[1]: Reloading... Oct 21 02:22:25.413462 zram_generator::config[1825]: No configuration found. Oct 21 02:22:25.493094 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Oct 21 02:22:25.539537 systemd[1]: Reloading finished in 180 ms. Oct 21 02:22:25.567224 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Oct 21 02:22:25.567277 systemd[1]: kubelet.service: Failed with result 'signal'. Oct 21 02:22:25.567513 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 21 02:22:25.569341 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 21 02:22:25.677141 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 21 02:22:25.680388 (kubelet)[1886]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Oct 21 02:22:25.711017 kubelet[1886]: 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. Oct 21 02:22:25.887725 kubelet[1886]: I1021 02:22:25.887662 1886 server.go:525] "Kubelet version" kubeletVersion="v1.35.1" Oct 21 02:22:25.887725 kubelet[1886]: I1021 02:22:25.887702 1886 server.go:527] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Oct 21 02:22:25.887725 kubelet[1886]: I1021 02:22:25.887715 1886 watchdog_linux.go:95] "Systemd watchdog is not enabled" Oct 21 02:22:25.887725 kubelet[1886]: I1021 02:22:25.887719 1886 watchdog_linux.go:138] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Oct 21 02:22:25.887934 kubelet[1886]: I1021 02:22:25.887920 1886 server.go:951] "Client rotation is on, will bootstrap in background" Oct 21 02:22:25.894473 kubelet[1886]: I1021 02:22:25.893143 1886 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Oct 21 02:22:25.897619 kubelet[1886]: E1021 02:22:25.897570 1886 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Oct 21 02:22:25.897619 kubelet[1886]: I1021 02:22:25.897609 1886 server.go:1395] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Oct 21 02:22:25.901405 kubelet[1886]: I1021 02:22:25.901372 1886 server.go:775] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Oct 21 02:22:25.903088 kubelet[1886]: I1021 02:22:25.902994 1886 container_manager_linux.go:272] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Oct 21 02:22:25.903201 kubelet[1886]: I1021 02:22:25.903031 1886 container_manager_linux.go:277] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.16","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"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},{"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}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":1} Oct 21 02:22:25.903201 kubelet[1886]: I1021 02:22:25.903197 1886 topology_manager.go:143] "Creating topology manager with none policy" Oct 21 02:22:25.903201 kubelet[1886]: I1021 02:22:25.903204 1886 container_manager_linux.go:308] "Creating device plugin manager" Oct 21 02:22:25.903382 kubelet[1886]: I1021 02:22:25.903276 1886 container_manager_linux.go:317] "Creating Dynamic Resource Allocation (DRA) manager" Oct 21 02:22:25.979038 kubelet[1886]: I1021 02:22:25.978915 1886 state_mem.go:41] "Initialized" logger="CPUManager state memory" Oct 21 02:22:25.979162 kubelet[1886]: I1021 02:22:25.979103 1886 kubelet.go:482] "Attempting to sync node with API server" Oct 21 02:22:25.979162 kubelet[1886]: I1021 02:22:25.979116 1886 kubelet.go:383] "Adding static pod path" path="/etc/kubernetes/manifests" Oct 21 02:22:25.979162 kubelet[1886]: I1021 02:22:25.979137 1886 kubelet.go:394] "Adding apiserver pod source" Oct 21 02:22:25.979162 kubelet[1886]: I1021 02:22:25.979147 1886 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Oct 21 02:22:25.979632 kubelet[1886]: E1021 02:22:25.979594 1886 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:25.979684 kubelet[1886]: E1021 02:22:25.979661 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:25.981234 kubelet[1886]: I1021 02:22:25.981185 1886 kuberuntime_manager.go:294] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Oct 21 02:22:25.982817 kubelet[1886]: I1021 02:22:25.982789 1886 kubelet.go:943] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Oct 21 02:22:25.982865 kubelet[1886]: I1021 02:22:25.982825 1886 kubelet.go:970] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Oct 21 02:22:25.982880 kubelet[1886]: W1021 02:22:25.982868 1886 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Oct 21 02:22:25.985489 kubelet[1886]: I1021 02:22:25.985467 1886 server.go:1257] "Started kubelet" Oct 21 02:22:25.987078 kubelet[1886]: I1021 02:22:25.987038 1886 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Oct 21 02:22:25.988792 kubelet[1886]: I1021 02:22:25.988611 1886 server.go:182] "Starting to listen" address="0.0.0.0" port=10250 Oct 21 02:22:25.989265 kubelet[1886]: I1021 02:22:25.989233 1886 server.go:317] "Adding debug handlers to kubelet server" Oct 21 02:22:25.991501 kubelet[1886]: I1021 02:22:25.990911 1886 volume_manager.go:311] "Starting Kubelet Volume Manager" Oct 21 02:22:25.991501 kubelet[1886]: I1021 02:22:25.990967 1886 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Oct 21 02:22:25.991501 kubelet[1886]: I1021 02:22:25.991006 1886 reconciler.go:29] "Reconciler: start to sync state" Oct 21 02:22:25.991501 kubelet[1886]: I1021 02:22:25.991320 1886 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Oct 21 02:22:25.991501 kubelet[1886]: I1021 02:22:25.991377 1886 server_v1.go:49] "podresources" method="list" useActivePods=true Oct 21 02:22:25.993081 kubelet[1886]: I1021 02:22:25.992900 1886 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Oct 21 02:22:25.994243 kubelet[1886]: E1021 02:22:25.993210 1886 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.16\" not found" Oct 21 02:22:25.994868 kubelet[1886]: I1021 02:22:25.994828 1886 factory.go:223] Registration of the systemd container factory successfully Oct 21 02:22:25.994933 kubelet[1886]: I1021 02:22:25.994914 1886 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 Oct 21 02:22:25.995161 kubelet[1886]: E1021 02:22:25.995131 1886 kubelet.go:1656] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Oct 21 02:22:25.995742 kubelet[1886]: I1021 02:22:25.995689 1886 server.go:254] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Oct 21 02:22:25.996558 kubelet[1886]: I1021 02:22:25.996531 1886 factory.go:223] Registration of the containerd container factory successfully Oct 21 02:22:25.998247 kubelet[1886]: E1021 02:22:25.998219 1886 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.16\" not found" node="10.0.0.16" Oct 21 02:22:26.007440 kubelet[1886]: I1021 02:22:26.007388 1886 cpu_manager.go:225] "Starting" policy="none" Oct 21 02:22:26.007440 kubelet[1886]: I1021 02:22:26.007401 1886 cpu_manager.go:226] "Reconciling" reconcilePeriod="10s" Oct 21 02:22:26.007440 kubelet[1886]: I1021 02:22:26.007435 1886 state_mem.go:41] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Oct 21 02:22:26.010020 kubelet[1886]: I1021 02:22:26.009954 1886 policy_none.go:50] "Start" Oct 21 02:22:26.010020 kubelet[1886]: I1021 02:22:26.009977 1886 memory_manager.go:187] "Starting memorymanager" policy="None" Oct 21 02:22:26.010020 kubelet[1886]: I1021 02:22:26.010018 1886 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Oct 21 02:22:26.011603 kubelet[1886]: I1021 02:22:26.011571 1886 policy_none.go:44] "Start" Oct 21 02:22:26.015735 kubelet[1886]: E1021 02:22:26.015700 1886 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Oct 21 02:22:26.015892 kubelet[1886]: I1021 02:22:26.015825 1886 eviction_manager.go:194] "Eviction manager: starting control loop" Oct 21 02:22:26.015976 kubelet[1886]: I1021 02:22:26.015926 1886 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Oct 21 02:22:26.017440 kubelet[1886]: I1021 02:22:26.017400 1886 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Oct 21 02:22:26.018658 kubelet[1886]: E1021 02:22:26.018638 1886 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Oct 21 02:22:26.018725 kubelet[1886]: E1021 02:22:26.018667 1886 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.16\" not found" Oct 21 02:22:26.018838 kubelet[1886]: I1021 02:22:26.018773 1886 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Oct 21 02:22:26.047340 kubelet[1886]: I1021 02:22:26.047312 1886 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Oct 21 02:22:26.047340 kubelet[1886]: I1021 02:22:26.047346 1886 status_manager.go:249] "Starting to sync pod status with apiserver" Oct 21 02:22:26.047445 kubelet[1886]: I1021 02:22:26.047368 1886 kubelet.go:2501] "Starting kubelet main sync loop" Oct 21 02:22:26.047445 kubelet[1886]: E1021 02:22:26.047427 1886 kubelet.go:2525] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Oct 21 02:22:26.117434 kubelet[1886]: I1021 02:22:26.117361 1886 kubelet_node_status.go:74] "Attempting to register node" node="10.0.0.16" Oct 21 02:22:26.122198 kubelet[1886]: I1021 02:22:26.121839 1886 kubelet_node_status.go:77] "Successfully registered node" node="10.0.0.16" Oct 21 02:22:26.129156 kubelet[1886]: I1021 02:22:26.129112 1886 kuberuntime_manager.go:2062] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Oct 21 02:22:26.129972 containerd[1573]: time="2026-10-21T02:22:26.129810909Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Oct 21 02:22:26.130739 kubelet[1886]: I1021 02:22:26.130518 1886 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Oct 21 02:22:26.188482 sudo[1732]: pam_unix(sudo:session): session closed for user root Oct 21 02:22:26.189729 sshd[1725]: pam_unix(sshd:session): session closed for user core Oct 21 02:22:26.192392 systemd[1]: sshd@4-10.0.0.16:22-10.0.0.1:51018.service: Deactivated successfully. Oct 21 02:22:26.194039 systemd-logind[1552]: Session 5 logged out. Waiting for processes to exit. Oct 21 02:22:26.194056 systemd[1]: session-5.scope: Deactivated successfully. Oct 21 02:22:26.194895 systemd-logind[1552]: Removed session 5. Oct 21 02:22:26.889663 kubelet[1886]: I1021 02:22:26.889541 1886 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Oct 21 02:22:26.890347 kubelet[1886]: I1021 02:22:26.889920 1886 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Oct 21 02:22:26.890347 kubelet[1886]: I1021 02:22:26.889952 1886 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Oct 21 02:22:26.890347 kubelet[1886]: I1021 02:22:26.889919 1886 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Oct 21 02:22:26.980640 kubelet[1886]: E1021 02:22:26.980515 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:26.980640 kubelet[1886]: I1021 02:22:26.980554 1886 apiserver.go:52] "Watching apiserver" Oct 21 02:22:26.991388 kubelet[1886]: I1021 02:22:26.991345 1886 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Oct 21 02:22:26.997384 kubelet[1886]: I1021 02:22:26.997354 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-cni\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.997492 kubelet[1886]: I1021 02:22:26.997396 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-flannel-cfg\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.997492 kubelet[1886]: I1021 02:22:26.997470 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-xtables-lock\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.997796 kubelet[1886]: I1021 02:22:26.997760 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gg776\" (UniqueName: \"kubernetes.io/projected/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-kube-api-access-gg776\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.997940 kubelet[1886]: I1021 02:22:26.997835 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/aa017fe2-345a-4984-ad28-b9fd858fbc18-lib-modules\") pod \"kube-proxy-k88lm\" (UID: \"aa017fe2-345a-4984-ad28-b9fd858fbc18\") " pod="kube-system/kube-proxy-k88lm" Oct 21 02:22:26.997940 kubelet[1886]: I1021 02:22:26.997914 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5x695\" (UniqueName: \"kubernetes.io/projected/aa017fe2-345a-4984-ad28-b9fd858fbc18-kube-api-access-5x695\") pod \"kube-proxy-k88lm\" (UID: \"aa017fe2-345a-4984-ad28-b9fd858fbc18\") " pod="kube-system/kube-proxy-k88lm" Oct 21 02:22:26.998090 kubelet[1886]: I1021 02:22:26.998046 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-run\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.998133 kubelet[1886]: I1021 02:22:26.998114 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/cf558f41-b400-43e9-bd4d-55bb92cb6bb3-cni-plugin\") pod \"kube-flannel-ds-dnm4h\" (UID: \"cf558f41-b400-43e9-bd4d-55bb92cb6bb3\") " pod="kube-flannel/kube-flannel-ds-dnm4h" Oct 21 02:22:26.998206 kubelet[1886]: I1021 02:22:26.998174 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/aa017fe2-345a-4984-ad28-b9fd858fbc18-kube-proxy\") pod \"kube-proxy-k88lm\" (UID: \"aa017fe2-345a-4984-ad28-b9fd858fbc18\") " pod="kube-system/kube-proxy-k88lm" Oct 21 02:22:26.998257 kubelet[1886]: I1021 02:22:26.998233 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/aa017fe2-345a-4984-ad28-b9fd858fbc18-xtables-lock\") pod \"kube-proxy-k88lm\" (UID: \"aa017fe2-345a-4984-ad28-b9fd858fbc18\") " pod="kube-system/kube-proxy-k88lm" Oct 21 02:22:27.293047 kubelet[1886]: E1021 02:22:27.292843 1886 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" Oct 21 02:22:27.293949 containerd[1573]: time="2026-10-21T02:22:27.293902962Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-dnm4h,Uid:cf558f41-b400-43e9-bd4d-55bb92cb6bb3,Namespace:kube-flannel,Attempt:0,}" Oct 21 02:22:27.294450 kubelet[1886]: E1021 02:22:27.294406 1886 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" Oct 21 02:22:27.294772 containerd[1573]: time="2026-10-21T02:22:27.294748524Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-k88lm,Uid:aa017fe2-345a-4984-ad28-b9fd858fbc18,Namespace:kube-system,Attempt:0,}" Oct 21 02:22:27.664966 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount316850555.mount: Deactivated successfully. Oct 21 02:22:27.670489 containerd[1573]: time="2026-10-21T02:22:27.670370317Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 21 02:22:27.671502 containerd[1573]: time="2026-10-21T02:22:27.671456807Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 21 02:22:27.671743 containerd[1573]: time="2026-10-21T02:22:27.671702486Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Oct 21 02:22:27.672265 containerd[1573]: time="2026-10-21T02:22:27.672235101Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312116" Oct 21 02:22:27.672789 containerd[1573]: time="2026-10-21T02:22:27.672765104Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 21 02:22:27.676297 containerd[1573]: time="2026-10-21T02:22:27.676255649Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 21 02:22:27.677103 containerd[1573]: time="2026-10-21T02:22:27.677060455Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 382.259456ms" Oct 21 02:22:27.677625 containerd[1573]: time="2026-10-21T02:22:27.677597600Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 383.587082ms" Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744950933Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744985799Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744997412Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744875671Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744981462Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 21 02:22:27.745054 containerd[1573]: time="2026-10-21T02:22:27.744989831Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:27.745503 containerd[1573]: time="2026-10-21T02:22:27.745104961Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:27.745503 containerd[1573]: time="2026-10-21T02:22:27.745050271Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:27.805279 containerd[1573]: time="2026-10-21T02:22:27.805208701Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-k88lm,Uid:aa017fe2-345a-4984-ad28-b9fd858fbc18,Namespace:kube-system,Attempt:0,} returns sandbox id \"4d650afad14e0276d7424460cdf15557d9986efa2baed2bb467e2aebab6dd709\"" Oct 21 02:22:27.806245 kubelet[1886]: E1021 02:22:27.806208 1886 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" Oct 21 02:22:27.807698 containerd[1573]: time="2026-10-21T02:22:27.807621714Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.9\"" Oct 21 02:22:27.821215 containerd[1573]: time="2026-10-21T02:22:27.821163176Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-dnm4h,Uid:cf558f41-b400-43e9-bd4d-55bb92cb6bb3,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\"" Oct 21 02:22:27.821789 kubelet[1886]: E1021 02:22:27.821765 1886 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" Oct 21 02:22:27.981511 kubelet[1886]: E1021 02:22:27.981345 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:28.450966 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount542293328.mount: Deactivated successfully. Oct 21 02:22:28.633554 containerd[1573]: time="2026-10-21T02:22:28.633484173Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.35.9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:28.634306 containerd[1573]: time="2026-10-21T02:22:28.634264747Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.35.9: active requests=0, bytes read=27180378" Oct 21 02:22:28.635090 containerd[1573]: time="2026-10-21T02:22:28.635042590Z" level=info msg="ImageCreate event name:\"sha256:96f81a7f09902e7b4d576db8ea407eecd69a63b3f0aed2e2992ad5b23a73c5fa\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:28.636855 containerd[1573]: time="2026-10-21T02:22:28.636799530Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:d08adb0c8c2c68075f1e6fa6c4c82880c5af54c1686ac20d22af612082c32a31\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:28.637260 containerd[1573]: time="2026-10-21T02:22:28.637228163Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.35.9\" with image id \"sha256:96f81a7f09902e7b4d576db8ea407eecd69a63b3f0aed2e2992ad5b23a73c5fa\", repo tag \"registry.k8s.io/kube-proxy:v1.35.9\", repo digest \"registry.k8s.io/kube-proxy@sha256:d08adb0c8c2c68075f1e6fa6c4c82880c5af54c1686ac20d22af612082c32a31\", size \"27179348\" in 829.530659ms" Oct 21 02:22:28.637260 containerd[1573]: time="2026-10-21T02:22:28.637256119Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.9\" returns image reference \"sha256:96f81a7f09902e7b4d576db8ea407eecd69a63b3f0aed2e2992ad5b23a73c5fa\"" Oct 21 02:22:28.638282 containerd[1573]: time="2026-10-21T02:22:28.638253789Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Oct 21 02:22:28.642313 containerd[1573]: time="2026-10-21T02:22:28.642070334Z" level=info msg="CreateContainer within sandbox \"4d650afad14e0276d7424460cdf15557d9986efa2baed2bb467e2aebab6dd709\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Oct 21 02:22:28.654774 containerd[1573]: time="2026-10-21T02:22:28.654719103Z" level=info msg="CreateContainer within sandbox \"4d650afad14e0276d7424460cdf15557d9986efa2baed2bb467e2aebab6dd709\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"51baeca4e89a6c8463a913fa81016e775fb5280062aed32e7308d58e26d2a269\"" Oct 21 02:22:28.655349 containerd[1573]: time="2026-10-21T02:22:28.655320050Z" level=info msg="StartContainer for \"51baeca4e89a6c8463a913fa81016e775fb5280062aed32e7308d58e26d2a269\"" Oct 21 02:22:28.706733 containerd[1573]: time="2026-10-21T02:22:28.706576652Z" level=info msg="StartContainer for \"51baeca4e89a6c8463a913fa81016e775fb5280062aed32e7308d58e26d2a269\" returns successfully" Oct 21 02:22:28.982464 kubelet[1886]: E1021 02:22:28.982268 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:29.058406 kubelet[1886]: E1021 02:22:29.058371 1886 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" Oct 21 02:22:29.073097 kubelet[1886]: I1021 02:22:29.072989 1886 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-system/kube-proxy-k88lm" podStartSLOduration=2.241881264 podStartE2EDuration="3.072977923s" podCreationTimestamp="2026-10-21 02:22:26 +0000 UTC" firstStartedPulling="2026-10-21 02:22:27.807035884 +0000 UTC m=+2.123886662" lastFinishedPulling="2026-10-21 02:22:28.638132551 +0000 UTC m=+2.954983321" observedRunningTime="2026-10-21 02:22:29.072891363 +0000 UTC m=+3.389742149" watchObservedRunningTime="2026-10-21 02:22:29.072977923 +0000 UTC m=+3.389828703" Oct 21 02:22:29.984642 kubelet[1886]: E1021 02:22:29.984143 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:30.059978 kubelet[1886]: E1021 02:22:30.059917 1886 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" Oct 21 02:22:30.096242 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1434772789.mount: Deactivated successfully. Oct 21 02:22:30.136307 containerd[1573]: time="2026-10-21T02:22:30.136178151Z" 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\"}" Oct 21 02:22:30.137162 containerd[1573]: time="2026-10-21T02:22:30.137072738Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Oct 21 02:22:30.138444 containerd[1573]: time="2026-10-21T02:22:30.138308527Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:30.141739 containerd[1573]: time="2026-10-21T02:22:30.141664974Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:30.143290 containerd[1573]: time="2026-10-21T02:22:30.143214616Z" 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.504927116s" Oct 21 02:22:30.143290 containerd[1573]: time="2026-10-21T02:22:30.143269812Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Oct 21 02:22:30.148634 containerd[1573]: time="2026-10-21T02:22:30.148580531Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Oct 21 02:22:30.162019 containerd[1573]: time="2026-10-21T02:22:30.161951146Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1\"" Oct 21 02:22:30.162654 containerd[1573]: time="2026-10-21T02:22:30.162628832Z" level=info msg="StartContainer for \"b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1\"" Oct 21 02:22:30.277616 containerd[1573]: time="2026-10-21T02:22:30.277461846Z" level=info msg="StartContainer for \"b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1\" returns successfully" Oct 21 02:22:30.302939 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1-rootfs.mount: Deactivated successfully. Oct 21 02:22:30.383627 containerd[1573]: time="2026-10-21T02:22:30.383336070Z" level=info msg="shim disconnected" id=b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1 namespace=k8s.io Oct 21 02:22:30.383627 containerd[1573]: time="2026-10-21T02:22:30.383393478Z" level=warning msg="cleaning up after shim disconnected" id=b7e4167abd9aa0ae79bea736d324a3331ac5639965af4a8b5f88b14434efdfa1 namespace=k8s.io Oct 21 02:22:30.383627 containerd[1573]: time="2026-10-21T02:22:30.383401262Z" level=info msg="cleaning up dead shim" namespace=k8s.io Oct 21 02:22:30.985657 kubelet[1886]: E1021 02:22:30.985553 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:31.063369 kubelet[1886]: E1021 02:22:31.063324 1886 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" Oct 21 02:22:31.064240 containerd[1573]: time="2026-10-21T02:22:31.064176615Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Oct 21 02:22:31.985996 kubelet[1886]: E1021 02:22:31.985910 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:32.987094 kubelet[1886]: E1021 02:22:32.987007 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:33.355083 containerd[1573]: time="2026-10-21T02:22:33.354857689Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:33.355708 containerd[1573]: time="2026-10-21T02:22:33.355658409Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Oct 21 02:22:33.356894 containerd[1573]: time="2026-10-21T02:22:33.356858133Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:33.360707 containerd[1573]: time="2026-10-21T02:22:33.360656255Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:33.362833 containerd[1573]: time="2026-10-21T02:22:33.362767526Z" 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.2985462s" Oct 21 02:22:33.362833 containerd[1573]: time="2026-10-21T02:22:33.362822473Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Oct 21 02:22:33.368912 containerd[1573]: time="2026-10-21T02:22:33.368864359Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Oct 21 02:22:33.380343 containerd[1573]: time="2026-10-21T02:22:33.380282221Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909\"" Oct 21 02:22:33.380782 containerd[1573]: time="2026-10-21T02:22:33.380755791Z" level=info msg="StartContainer for \"43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909\"" Oct 21 02:22:33.544329 containerd[1573]: time="2026-10-21T02:22:33.544268885Z" level=info msg="StartContainer for \"43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909\" returns successfully" Oct 21 02:22:33.563180 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909-rootfs.mount: Deactivated successfully. Oct 21 02:22:33.578934 kubelet[1886]: I1021 02:22:33.578878 1886 kubelet_node_status.go:427] "Fast updating node status as it just became ready" Oct 21 02:22:33.641181 containerd[1573]: time="2026-10-21T02:22:33.640901236Z" level=info msg="shim disconnected" id=43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909 namespace=k8s.io Oct 21 02:22:33.641181 containerd[1573]: time="2026-10-21T02:22:33.640983355Z" level=warning msg="cleaning up after shim disconnected" id=43716649c91c214c0e10a6c57a53d5fdf651d11697fe3bf84acce35a6d6df909 namespace=k8s.io Oct 21 02:22:33.641181 containerd[1573]: time="2026-10-21T02:22:33.640997475Z" level=info msg="cleaning up dead shim" namespace=k8s.io Oct 21 02:22:33.987814 kubelet[1886]: E1021 02:22:33.987582 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:34.072963 kubelet[1886]: E1021 02:22:34.072838 1886 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" Oct 21 02:22:34.079245 containerd[1573]: time="2026-10-21T02:22:34.079145108Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Oct 21 02:22:34.096595 containerd[1573]: time="2026-10-21T02:22:34.096393876Z" level=info msg="CreateContainer within sandbox \"e98a5ded135cf09aa0d7d31a230fe6d80afdb861e1e363acbb588ee7fb215d27\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"ebbbc41b42377948c1e8b179d2ce6a9f3e062476a7202ec503dc43ae4d33dcd5\"" Oct 21 02:22:34.097247 containerd[1573]: time="2026-10-21T02:22:34.097207864Z" level=info msg="StartContainer for \"ebbbc41b42377948c1e8b179d2ce6a9f3e062476a7202ec503dc43ae4d33dcd5\"" Oct 21 02:22:34.220183 containerd[1573]: time="2026-10-21T02:22:34.220088887Z" level=info msg="StartContainer for \"ebbbc41b42377948c1e8b179d2ce6a9f3e062476a7202ec503dc43ae4d33dcd5\" returns successfully" Oct 21 02:22:34.987956 kubelet[1886]: E1021 02:22:34.987826 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:35.077098 kubelet[1886]: E1021 02:22:35.077038 1886 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" Oct 21 02:22:35.090791 kubelet[1886]: I1021 02:22:35.090699 1886 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-dnm4h" podStartSLOduration=2.839400875 podStartE2EDuration="9.090682207s" podCreationTimestamp="2026-10-21 02:22:26 +0000 UTC" firstStartedPulling="2026-10-21 02:22:27.822858039 +0000 UTC m=+2.139708809" lastFinishedPulling="2026-10-21 02:22:34.074139369 +0000 UTC m=+8.390990141" observedRunningTime="2026-10-21 02:22:35.090669408 +0000 UTC m=+9.407520193" watchObservedRunningTime="2026-10-21 02:22:35.090682207 +0000 UTC m=+9.407532984" Oct 21 02:22:35.334703 systemd-networkd[1253]: flannel.1: Link UP Oct 21 02:22:35.334712 systemd-networkd[1253]: flannel.1: Gained carrier Oct 21 02:22:35.989034 kubelet[1886]: E1021 02:22:35.988932 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:36.079957 kubelet[1886]: E1021 02:22:36.079878 1886 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" Oct 21 02:22:36.990390 kubelet[1886]: E1021 02:22:36.990276 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:37.109208 kubelet[1886]: I1021 02:22:37.109104 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-dm8rp\" (UniqueName: \"kubernetes.io/projected/233f9350-f4ee-411e-a1af-72063a531a3e-kube-api-access-dm8rp\") pod \"nginx-deployment-6cc69d4fc7-hf5nt\" (UID: \"233f9350-f4ee-411e-a1af-72063a531a3e\") " pod="default/nginx-deployment-6cc69d4fc7-hf5nt" Oct 21 02:22:37.140787 systemd-networkd[1253]: flannel.1: Gained IPv6LL Oct 21 02:22:37.236279 containerd[1573]: time="2026-10-21T02:22:37.236231346Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-hf5nt,Uid:233f9350-f4ee-411e-a1af-72063a531a3e,Namespace:default,Attempt:0,}" Oct 21 02:22:37.259808 systemd-networkd[1253]: cni0: Link UP Oct 21 02:22:37.259814 systemd-networkd[1253]: cni0: Gained carrier Oct 21 02:22:37.261327 systemd-networkd[1253]: cni0: Lost carrier Oct 21 02:22:37.266300 systemd-networkd[1253]: vetha270a17e: Link UP Oct 21 02:22:37.269458 kernel: cni0: port 1(vetha270a17e) entered blocking state Oct 21 02:22:37.269509 kernel: cni0: port 1(vetha270a17e) entered disabled state Oct 21 02:22:37.269522 kernel: vetha270a17e: entered allmulticast mode Oct 21 02:22:37.271035 kernel: vetha270a17e: entered promiscuous mode Oct 21 02:22:37.272165 kernel: cni0: port 1(vetha270a17e) entered blocking state Oct 21 02:22:37.272193 kernel: cni0: port 1(vetha270a17e) entered forwarding state Oct 21 02:22:37.274248 kernel: cni0: port 1(vetha270a17e) entered disabled state Oct 21 02:22:37.281314 kernel: cni0: port 1(vetha270a17e) entered blocking state Oct 21 02:22:37.281502 kernel: cni0: port 1(vetha270a17e) entered forwarding state Oct 21 02:22:37.281530 systemd-networkd[1253]: vetha270a17e: Gained carrier Oct 21 02:22:37.281810 systemd-networkd[1253]: cni0: Gained carrier Oct 21 02:22:37.284289 containerd[1573]: 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"} Oct 21 02:22:37.284289 containerd[1573]: delegateAdd: netconf sent to delegate plugin: Oct 21 02:22:37.312526 containerd[1573]: {"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="2026-10-21T02:22:37.312239629Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 21 02:22:37.312526 containerd[1573]: time="2026-10-21T02:22:37.312298658Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 21 02:22:37.312526 containerd[1573]: time="2026-10-21T02:22:37.312318681Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:37.312526 containerd[1573]: time="2026-10-21T02:22:37.312447046Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:37.381896 systemd-resolved[1470]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 21 02:22:37.421268 containerd[1573]: time="2026-10-21T02:22:37.421190287Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-hf5nt,Uid:233f9350-f4ee-411e-a1af-72063a531a3e,Namespace:default,Attempt:0,} returns sandbox id \"7661c522bbf7b09c3e4e6e4bf6c0ab8b1a3a16b523ad30c1c5da2c80b7f662ea\"" Oct 21 02:22:37.422841 containerd[1573]: time="2026-10-21T02:22:37.422793541Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 21 02:22:37.990616 kubelet[1886]: E1021 02:22:37.990490 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:38.612938 systemd-networkd[1253]: cni0: Gained IPv6LL Oct 21 02:22:38.812686 systemd-networkd[1253]: vetha270a17e: Gained IPv6LL Oct 21 02:22:38.890729 kernel: hrtimer: interrupt took 2766395 ns Oct 21 02:22:38.991294 kubelet[1886]: E1021 02:22:38.991220 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:39.992466 kubelet[1886]: E1021 02:22:39.992319 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:40.640225 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2124031805.mount: Deactivated successfully. Oct 21 02:22:41.125319 kubelet[1886]: E1021 02:22:41.124312 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:41.892352 containerd[1573]: time="2026-10-21T02:22:41.892285621Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:41.892973 containerd[1573]: time="2026-10-21T02:22:41.892826303Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=64611197" Oct 21 02:22:41.893712 containerd[1573]: time="2026-10-21T02:22:41.893676462Z" level=info msg="ImageCreate event name:\"sha256:8f59ff5046a70e421d35ed7d1e862a963215c9689b36cb8f64a6c42f9cf2955d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:41.900442 containerd[1573]: time="2026-10-21T02:22:41.897908880Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:50dc40e9ed93d19d1cf11bdcc014f8db4f7cc6a927f22d7114bb6ddf4d19f92d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:41.901152 containerd[1573]: time="2026-10-21T02:22:41.901079107Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8f59ff5046a70e421d35ed7d1e862a963215c9689b36cb8f64a6c42f9cf2955d\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:50dc40e9ed93d19d1cf11bdcc014f8db4f7cc6a927f22d7114bb6ddf4d19f92d\", size \"64611075\" in 4.478238428s" Oct 21 02:22:41.901242 containerd[1573]: time="2026-10-21T02:22:41.901168483Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8f59ff5046a70e421d35ed7d1e862a963215c9689b36cb8f64a6c42f9cf2955d\"" Oct 21 02:22:41.906543 containerd[1573]: time="2026-10-21T02:22:41.906485498Z" level=info msg="CreateContainer within sandbox \"7661c522bbf7b09c3e4e6e4bf6c0ab8b1a3a16b523ad30c1c5da2c80b7f662ea\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Oct 21 02:22:41.917329 containerd[1573]: time="2026-10-21T02:22:41.917264132Z" level=info msg="CreateContainer within sandbox \"7661c522bbf7b09c3e4e6e4bf6c0ab8b1a3a16b523ad30c1c5da2c80b7f662ea\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"60adec2fc78a1df0f02ae7b76f1d061958c2aca2e0f23f97bd8622eb6f944357\"" Oct 21 02:22:41.917774 containerd[1573]: time="2026-10-21T02:22:41.917735317Z" level=info msg="StartContainer for \"60adec2fc78a1df0f02ae7b76f1d061958c2aca2e0f23f97bd8622eb6f944357\"" Oct 21 02:22:41.918654 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1975814601.mount: Deactivated successfully. Oct 21 02:22:42.055794 containerd[1573]: time="2026-10-21T02:22:42.055715892Z" level=info msg="StartContainer for \"60adec2fc78a1df0f02ae7b76f1d061958c2aca2e0f23f97bd8622eb6f944357\" returns successfully" Oct 21 02:22:42.126523 kubelet[1886]: E1021 02:22:42.126331 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:43.126771 kubelet[1886]: E1021 02:22:43.126675 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:43.246541 kubelet[1886]: I1021 02:22:43.246377 1886 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nginx-deployment-6cc69d4fc7-hf5nt" podStartSLOduration=2.766592095 podStartE2EDuration="7.246351634s" podCreationTimestamp="2026-10-21 02:22:36 +0000 UTC" firstStartedPulling="2026-10-21 02:22:37.422403397 +0000 UTC m=+11.739254166" lastFinishedPulling="2026-10-21 02:22:41.902162935 +0000 UTC m=+16.219013705" observedRunningTime="2026-10-21 02:22:42.177513137 +0000 UTC m=+16.494363905" watchObservedRunningTime="2026-10-21 02:22:43.246351634 +0000 UTC m=+17.563202414" Oct 21 02:22:43.261994 kubelet[1886]: I1021 02:22:43.261856 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gddrs\" (UniqueName: \"kubernetes.io/projected/93ab34fb-efd7-448f-abb3-9b9a2fdc629a-kube-api-access-gddrs\") pod \"nfs-server-provisioner-0\" (UID: \"93ab34fb-efd7-448f-abb3-9b9a2fdc629a\") " pod="default/nfs-server-provisioner-0" Oct 21 02:22:43.261994 kubelet[1886]: I1021 02:22:43.261949 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/93ab34fb-efd7-448f-abb3-9b9a2fdc629a-data\") pod \"nfs-server-provisioner-0\" (UID: \"93ab34fb-efd7-448f-abb3-9b9a2fdc629a\") " pod="default/nfs-server-provisioner-0" Oct 21 02:22:43.556195 containerd[1573]: time="2026-10-21T02:22:43.555903878Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:93ab34fb-efd7-448f-abb3-9b9a2fdc629a,Namespace:default,Attempt:0,}" Oct 21 02:22:43.584517 systemd-networkd[1253]: vethef2d04be: Link UP Oct 21 02:22:43.587299 kernel: cni0: port 2(vethef2d04be) entered blocking state Oct 21 02:22:43.587371 kernel: cni0: port 2(vethef2d04be) entered disabled state Oct 21 02:22:43.587406 kernel: vethef2d04be: entered allmulticast mode Oct 21 02:22:43.588912 kernel: vethef2d04be: entered promiscuous mode Oct 21 02:22:43.599519 kernel: cni0: port 2(vethef2d04be) entered blocking state Oct 21 02:22:43.599565 kernel: cni0: port 2(vethef2d04be) entered forwarding state Oct 21 02:22:43.599748 systemd-networkd[1253]: vethef2d04be: Gained carrier Oct 21 02:22:43.650510 containerd[1573]: 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"} Oct 21 02:22:43.650510 containerd[1573]: delegateAdd: netconf sent to delegate plugin: Oct 21 02:22:43.837931 containerd[1573]: {"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="2026-10-21T02:22:43.835851259Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 21 02:22:43.837931 containerd[1573]: time="2026-10-21T02:22:43.837694225Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 21 02:22:43.837931 containerd[1573]: time="2026-10-21T02:22:43.837705765Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:43.837931 containerd[1573]: time="2026-10-21T02:22:43.837790465Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:43.913342 systemd-resolved[1470]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 21 02:22:43.944299 containerd[1573]: time="2026-10-21T02:22:43.944255423Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:93ab34fb-efd7-448f-abb3-9b9a2fdc629a,Namespace:default,Attempt:0,} returns sandbox id \"83e7afa0e6cf68f40718eed43e0e13c1bdf49a4bee499ffceb723ad2de3afe31\"" Oct 21 02:22:43.945975 containerd[1573]: time="2026-10-21T02:22:43.945951588Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Oct 21 02:22:44.127887 kubelet[1886]: E1021 02:22:44.127515 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:45.128312 kubelet[1886]: E1021 02:22:45.128228 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:45.396602 systemd-networkd[1253]: vethef2d04be: Gained IPv6LL Oct 21 02:22:45.975855 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2472166940.mount: Deactivated successfully. Oct 21 02:22:45.979895 kubelet[1886]: E1021 02:22:45.979842 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:46.129435 kubelet[1886]: E1021 02:22:46.129337 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:47.130351 kubelet[1886]: E1021 02:22:47.130283 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:48.130945 kubelet[1886]: E1021 02:22:48.130856 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:48.751721 containerd[1573]: time="2026-10-21T02:22:48.751621961Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:48.752779 containerd[1573]: time="2026-10-21T02:22:48.752606501Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039378" Oct 21 02:22:48.754725 containerd[1573]: time="2026-10-21T02:22:48.754670065Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:48.757258 containerd[1573]: time="2026-10-21T02:22:48.757184713Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:48.758680 containerd[1573]: time="2026-10-21T02:22:48.758597041Z" 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 4.812609015s" Oct 21 02:22:48.758680 containerd[1573]: time="2026-10-21T02:22:48.758653727Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Oct 21 02:22:48.765122 containerd[1573]: time="2026-10-21T02:22:48.765065272Z" level=info msg="CreateContainer within sandbox \"83e7afa0e6cf68f40718eed43e0e13c1bdf49a4bee499ffceb723ad2de3afe31\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Oct 21 02:22:48.777976 containerd[1573]: time="2026-10-21T02:22:48.777910436Z" level=info msg="CreateContainer within sandbox \"83e7afa0e6cf68f40718eed43e0e13c1bdf49a4bee499ffceb723ad2de3afe31\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"2e9e81ebfc6f83b506189ac8e91900e7ce07726cee6e69836d85cc2e22d35faa\"" Oct 21 02:22:48.778979 containerd[1573]: time="2026-10-21T02:22:48.778868979Z" level=info msg="StartContainer for \"2e9e81ebfc6f83b506189ac8e91900e7ce07726cee6e69836d85cc2e22d35faa\"" Oct 21 02:22:48.865211 containerd[1573]: time="2026-10-21T02:22:48.865113434Z" level=info msg="StartContainer for \"2e9e81ebfc6f83b506189ac8e91900e7ce07726cee6e69836d85cc2e22d35faa\" returns successfully" Oct 21 02:22:49.132342 kubelet[1886]: E1021 02:22:49.131937 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:49.211955 kubelet[1886]: I1021 02:22:49.211883 1886 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.3978802909999999 podStartE2EDuration="6.211869476s" podCreationTimestamp="2026-10-21 02:22:43 +0000 UTC" firstStartedPulling="2026-10-21 02:22:43.94569364 +0000 UTC m=+18.262544409" lastFinishedPulling="2026-10-21 02:22:48.759682825 +0000 UTC m=+23.076533594" observedRunningTime="2026-10-21 02:22:49.211750654 +0000 UTC m=+23.528601426" watchObservedRunningTime="2026-10-21 02:22:49.211869476 +0000 UTC m=+23.528720256" Oct 21 02:22:50.134002 kubelet[1886]: E1021 02:22:50.133842 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:51.134511 kubelet[1886]: E1021 02:22:51.134437 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:52.134835 kubelet[1886]: E1021 02:22:52.134740 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:53.135586 kubelet[1886]: E1021 02:22:53.135336 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:54.135924 kubelet[1886]: E1021 02:22:54.135846 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:54.143390 kubelet[1886]: I1021 02:22:54.143267 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-9f44e311-0e01-46de-a81f-a1c711a96a67\" (UniqueName: \"kubernetes.io/nfs/bfee651d-56f2-49a4-b072-1eb30ffa1353-pvc-9f44e311-0e01-46de-a81f-a1c711a96a67\") pod \"test-pod-1\" (UID: \"bfee651d-56f2-49a4-b072-1eb30ffa1353\") " pod="default/test-pod-1" Oct 21 02:22:54.143588 kubelet[1886]: I1021 02:22:54.143400 1886 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gckt5\" (UniqueName: \"kubernetes.io/projected/bfee651d-56f2-49a4-b072-1eb30ffa1353-kube-api-access-gckt5\") pod \"test-pod-1\" (UID: \"bfee651d-56f2-49a4-b072-1eb30ffa1353\") " pod="default/test-pod-1" Oct 21 02:22:54.281487 kernel: FS-Cache: Loaded Oct 21 02:22:54.360007 kernel: RPC: Registered named UNIX socket transport module. Oct 21 02:22:54.360268 kernel: RPC: Registered udp transport module. Oct 21 02:22:54.360297 kernel: RPC: Registered tcp transport module. Oct 21 02:22:54.361007 kernel: RPC: Registered tcp-with-tls transport module. Oct 21 02:22:54.362038 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 21 02:22:54.632196 kernel: NFS: Registering the id_resolver key type Oct 21 02:22:54.632506 kernel: Key type id_resolver registered Oct 21 02:22:54.632529 kernel: Key type id_legacy registered Oct 21 02:22:54.740368 nfsidmap[2894]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 21 02:22:54.744593 nfsidmap[2897]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 21 02:22:55.032636 containerd[1573]: time="2026-10-21T02:22:55.032386309Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:bfee651d-56f2-49a4-b072-1eb30ffa1353,Namespace:default,Attempt:0,}" Oct 21 02:22:55.136975 kubelet[1886]: E1021 02:22:55.136888 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:55.253443 systemd-networkd[1253]: veth907cc713: Link UP Oct 21 02:22:55.255403 kernel: cni0: port 3(veth907cc713) entered blocking state Oct 21 02:22:55.255519 kernel: cni0: port 3(veth907cc713) entered disabled state Oct 21 02:22:55.255564 kernel: veth907cc713: entered allmulticast mode Oct 21 02:22:55.259285 kernel: veth907cc713: entered promiscuous mode Oct 21 02:22:55.275573 kernel: cni0: port 3(veth907cc713) entered blocking state Oct 21 02:22:55.275734 kernel: cni0: port 3(veth907cc713) entered forwarding state Oct 21 02:22:55.275824 systemd-networkd[1253]: veth907cc713: Gained carrier Oct 21 02:22:55.282755 containerd[1573]: 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)(0xc000104950), "name":"cbr0", "type":"bridge"} Oct 21 02:22:55.282755 containerd[1573]: delegateAdd: netconf sent to delegate plugin: Oct 21 02:22:55.332060 containerd[1573]: {"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="2026-10-21T02:22:55.331919012Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 21 02:22:55.332060 containerd[1573]: time="2026-10-21T02:22:55.331986262Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 21 02:22:55.332060 containerd[1573]: time="2026-10-21T02:22:55.331999718Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:55.332312 containerd[1573]: time="2026-10-21T02:22:55.332093708Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 21 02:22:55.358279 systemd[1]: run-containerd-runc-k8s.io-d741121a65903398b9a5d3ceddb91a0d73fd99f85df25b54b00c7c9ba1ed286e-runc.7w4QSp.mount: Deactivated successfully. Oct 21 02:22:55.372260 systemd-resolved[1470]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 21 02:22:55.425407 containerd[1573]: time="2026-10-21T02:22:55.425326950Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:bfee651d-56f2-49a4-b072-1eb30ffa1353,Namespace:default,Attempt:0,} returns sandbox id \"d741121a65903398b9a5d3ceddb91a0d73fd99f85df25b54b00c7c9ba1ed286e\"" Oct 21 02:22:55.428496 containerd[1573]: time="2026-10-21T02:22:55.428225357Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 21 02:22:55.876948 containerd[1573]: time="2026-10-21T02:22:55.876823735Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 21 02:22:55.877518 containerd[1573]: time="2026-10-21T02:22:55.877456840Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Oct 21 02:22:55.884185 containerd[1573]: time="2026-10-21T02:22:55.882227867Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8f59ff5046a70e421d35ed7d1e862a963215c9689b36cb8f64a6c42f9cf2955d\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:50dc40e9ed93d19d1cf11bdcc014f8db4f7cc6a927f22d7114bb6ddf4d19f92d\", size \"64611075\" in 453.812076ms" Oct 21 02:22:55.884185 containerd[1573]: time="2026-10-21T02:22:55.882274143Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8f59ff5046a70e421d35ed7d1e862a963215c9689b36cb8f64a6c42f9cf2955d\"" Oct 21 02:22:55.896213 containerd[1573]: time="2026-10-21T02:22:55.896125197Z" level=info msg="CreateContainer within sandbox \"d741121a65903398b9a5d3ceddb91a0d73fd99f85df25b54b00c7c9ba1ed286e\" for container &ContainerMetadata{Name:test,Attempt:0,}" Oct 21 02:22:55.913814 containerd[1573]: time="2026-10-21T02:22:55.913724231Z" level=info msg="CreateContainer within sandbox \"d741121a65903398b9a5d3ceddb91a0d73fd99f85df25b54b00c7c9ba1ed286e\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"f94962302bd59cf37be314b30c69201afc7511805360dc788e240354d5392bfd\"" Oct 21 02:22:55.914735 containerd[1573]: time="2026-10-21T02:22:55.914701765Z" level=info msg="StartContainer for \"f94962302bd59cf37be314b30c69201afc7511805360dc788e240354d5392bfd\"" Oct 21 02:22:56.011068 containerd[1573]: time="2026-10-21T02:22:56.010992143Z" level=info msg="StartContainer for \"f94962302bd59cf37be314b30c69201afc7511805360dc788e240354d5392bfd\" returns successfully" Oct 21 02:22:56.137887 kubelet[1886]: E1021 02:22:56.137708 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:56.235121 kubelet[1886]: I1021 02:22:56.234900 1886 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=12.775966645 podStartE2EDuration="13.234843025s" podCreationTimestamp="2026-10-21 02:22:43 +0000 UTC" firstStartedPulling="2026-10-21 02:22:55.427244009 +0000 UTC m=+29.744094779" lastFinishedPulling="2026-10-21 02:22:55.886120383 +0000 UTC m=+30.202971159" observedRunningTime="2026-10-21 02:22:56.234747365 +0000 UTC m=+30.551598144" watchObservedRunningTime="2026-10-21 02:22:56.234843025 +0000 UTC m=+30.551693798" Oct 21 02:22:56.917291 systemd-networkd[1253]: veth907cc713: Gained IPv6LL Oct 21 02:22:57.138917 kubelet[1886]: E1021 02:22:57.138814 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:58.140102 kubelet[1886]: E1021 02:22:58.140015 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:22:59.141041 kubelet[1886]: E1021 02:22:59.140870 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 21 02:23:00.141257 kubelet[1886]: E1021 02:23:00.141163 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"