Oct 13 05:11:24.331323 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 13 05:11:24.331348 kernel: Linux version 6.12.51-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT Mon Oct 13 03:30:16 -00 2025 Oct 13 05:11:24.331357 kernel: KASLR enabled Oct 13 05:11:24.331363 kernel: efi: EFI v2.7 by EDK II Oct 13 05:11:24.331369 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Oct 13 05:11:24.331374 kernel: random: crng init done Oct 13 05:11:24.331381 kernel: secureboot: Secure boot disabled Oct 13 05:11:24.331387 kernel: ACPI: Early table checksum verification disabled Oct 13 05:11:24.331396 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 13 05:11:24.331402 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 13 05:11:24.331409 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331415 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331421 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331427 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331436 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331443 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331450 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331456 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331463 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 13 05:11:24.331469 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 13 05:11:24.331476 kernel: ACPI: Use ACPI SPCR as default console: No Oct 13 05:11:24.331483 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 05:11:24.331491 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Oct 13 05:11:24.331498 kernel: Zone ranges: Oct 13 05:11:24.331504 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 05:11:24.331510 kernel: DMA32 empty Oct 13 05:11:24.331517 kernel: Normal empty Oct 13 05:11:24.331523 kernel: Device empty Oct 13 05:11:24.331530 kernel: Movable zone start for each node Oct 13 05:11:24.331536 kernel: Early memory node ranges Oct 13 05:11:24.331543 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Oct 13 05:11:24.331549 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Oct 13 05:11:24.331556 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Oct 13 05:11:24.331562 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 13 05:11:24.331570 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 13 05:11:24.331577 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 13 05:11:24.331583 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 13 05:11:24.331589 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 13 05:11:24.331596 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 13 05:11:24.331602 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 13 05:11:24.331613 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 13 05:11:24.331620 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 13 05:11:24.331628 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 13 05:11:24.331635 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 13 05:11:24.331642 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 13 05:11:24.331649 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Oct 13 05:11:24.331655 kernel: psci: probing for conduit method from ACPI. Oct 13 05:11:24.331662 kernel: psci: PSCIv1.1 detected in firmware. Oct 13 05:11:24.331671 kernel: psci: Using standard PSCI v0.2 function IDs Oct 13 05:11:24.331677 kernel: psci: Trusted OS migration not required Oct 13 05:11:24.331684 kernel: psci: SMC Calling Convention v1.1 Oct 13 05:11:24.331691 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 13 05:11:24.331698 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Oct 13 05:11:24.331706 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Oct 13 05:11:24.331712 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 13 05:11:24.331719 kernel: Detected PIPT I-cache on CPU0 Oct 13 05:11:24.331727 kernel: CPU features: detected: GIC system register CPU interface Oct 13 05:11:24.331734 kernel: CPU features: detected: Spectre-v4 Oct 13 05:11:24.331741 kernel: CPU features: detected: Spectre-BHB Oct 13 05:11:24.331750 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 13 05:11:24.331757 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 13 05:11:24.331764 kernel: CPU features: detected: ARM erratum 1418040 Oct 13 05:11:24.331771 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 13 05:11:24.331778 kernel: alternatives: applying boot alternatives Oct 13 05:11:24.331786 kernel: 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 acpi=force verity.usrhash=1a81e36b39d22063d1d9b2ac3307af6d1e57cfd926c8fafd214fb74284e73d99 Oct 13 05:11:24.331806 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 13 05:11:24.331813 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 13 05:11:24.331820 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 13 05:11:24.331827 kernel: Fallback order for Node 0: 0 Oct 13 05:11:24.331837 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Oct 13 05:11:24.331844 kernel: Policy zone: DMA Oct 13 05:11:24.331851 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 13 05:11:24.331858 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Oct 13 05:11:24.331865 kernel: software IO TLB: area num 4. Oct 13 05:11:24.331872 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Oct 13 05:11:24.331879 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Oct 13 05:11:24.331886 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 13 05:11:24.331893 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 13 05:11:24.331901 kernel: rcu: RCU event tracing is enabled. Oct 13 05:11:24.331908 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 13 05:11:24.331917 kernel: Trampoline variant of Tasks RCU enabled. Oct 13 05:11:24.331924 kernel: Tracing variant of Tasks RCU enabled. Oct 13 05:11:24.331932 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 13 05:11:24.331939 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 13 05:11:24.331946 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 13 05:11:24.331966 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 13 05:11:24.331974 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 13 05:11:24.331980 kernel: GICv3: 256 SPIs implemented Oct 13 05:11:24.331987 kernel: GICv3: 0 Extended SPIs implemented Oct 13 05:11:24.331994 kernel: Root IRQ handler: gic_handle_irq Oct 13 05:11:24.332001 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 13 05:11:24.332010 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Oct 13 05:11:24.332018 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 13 05:11:24.332025 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 13 05:11:24.332033 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Oct 13 05:11:24.332040 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Oct 13 05:11:24.332047 kernel: GICv3: using LPI property table @0x0000000040130000 Oct 13 05:11:24.332054 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Oct 13 05:11:24.332061 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 13 05:11:24.332068 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 05:11:24.332074 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 13 05:11:24.332081 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 13 05:11:24.332090 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 13 05:11:24.332097 kernel: arm-pv: using stolen time PV Oct 13 05:11:24.332104 kernel: Console: colour dummy device 80x25 Oct 13 05:11:24.332112 kernel: ACPI: Core revision 20240827 Oct 13 05:11:24.332119 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 13 05:11:24.332126 kernel: pid_max: default: 32768 minimum: 301 Oct 13 05:11:24.332134 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 13 05:11:24.332141 kernel: landlock: Up and running. Oct 13 05:11:24.332149 kernel: SELinux: Initializing. Oct 13 05:11:24.332156 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 05:11:24.332163 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 13 05:11:24.332171 kernel: rcu: Hierarchical SRCU implementation. Oct 13 05:11:24.332178 kernel: rcu: Max phase no-delay instances is 400. Oct 13 05:11:24.332185 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 13 05:11:24.332192 kernel: Remapping and enabling EFI services. Oct 13 05:11:24.332200 kernel: smp: Bringing up secondary CPUs ... Oct 13 05:11:24.332212 kernel: Detected PIPT I-cache on CPU1 Oct 13 05:11:24.332221 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 13 05:11:24.332228 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Oct 13 05:11:24.332236 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 05:11:24.332243 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 13 05:11:24.332250 kernel: Detected PIPT I-cache on CPU2 Oct 13 05:11:24.332258 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 13 05:11:24.332267 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Oct 13 05:11:24.332274 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 05:11:24.332281 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 13 05:11:24.332289 kernel: Detected PIPT I-cache on CPU3 Oct 13 05:11:24.332296 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 13 05:11:24.332304 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Oct 13 05:11:24.332313 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 13 05:11:24.332320 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 13 05:11:24.332328 kernel: smp: Brought up 1 node, 4 CPUs Oct 13 05:11:24.332335 kernel: SMP: Total of 4 processors activated. Oct 13 05:11:24.332343 kernel: CPU: All CPU(s) started at EL1 Oct 13 05:11:24.332350 kernel: CPU features: detected: 32-bit EL0 Support Oct 13 05:11:24.332358 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 13 05:11:24.332367 kernel: CPU features: detected: Common not Private translations Oct 13 05:11:24.332374 kernel: CPU features: detected: CRC32 instructions Oct 13 05:11:24.332381 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 13 05:11:24.332389 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 13 05:11:24.332396 kernel: CPU features: detected: LSE atomic instructions Oct 13 05:11:24.332403 kernel: CPU features: detected: Privileged Access Never Oct 13 05:11:24.332411 kernel: CPU features: detected: RAS Extension Support Oct 13 05:11:24.332418 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 13 05:11:24.332427 kernel: alternatives: applying system-wide alternatives Oct 13 05:11:24.332435 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Oct 13 05:11:24.332442 kernel: Memory: 2450400K/2572288K available (11200K kernel code, 2456K rwdata, 9080K rodata, 12992K init, 1038K bss, 99552K reserved, 16384K cma-reserved) Oct 13 05:11:24.332450 kernel: devtmpfs: initialized Oct 13 05:11:24.332458 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 13 05:11:24.332465 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 13 05:11:24.332473 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 13 05:11:24.332482 kernel: 0 pages in range for non-PLT usage Oct 13 05:11:24.332489 kernel: 515040 pages in range for PLT usage Oct 13 05:11:24.332496 kernel: pinctrl core: initialized pinctrl subsystem Oct 13 05:11:24.332504 kernel: SMBIOS 3.0.0 present. Oct 13 05:11:24.332511 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 13 05:11:24.332518 kernel: DMI: Memory slots populated: 1/1 Oct 13 05:11:24.332526 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 13 05:11:24.332534 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 13 05:11:24.332542 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 13 05:11:24.332549 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 13 05:11:24.332557 kernel: audit: initializing netlink subsys (disabled) Oct 13 05:11:24.332564 kernel: audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 Oct 13 05:11:24.332572 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 13 05:11:24.332579 kernel: cpuidle: using governor menu Oct 13 05:11:24.332588 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 13 05:11:24.332596 kernel: ASID allocator initialised with 32768 entries Oct 13 05:11:24.332604 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 13 05:11:24.332611 kernel: Serial: AMBA PL011 UART driver Oct 13 05:11:24.332619 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 13 05:11:24.332626 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 13 05:11:24.332633 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 13 05:11:24.332641 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 13 05:11:24.332649 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 13 05:11:24.332657 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 13 05:11:24.332664 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 13 05:11:24.332671 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 13 05:11:24.332679 kernel: ACPI: Added _OSI(Module Device) Oct 13 05:11:24.332686 kernel: ACPI: Added _OSI(Processor Device) Oct 13 05:11:24.332693 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 13 05:11:24.332702 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 13 05:11:24.332709 kernel: ACPI: Interpreter enabled Oct 13 05:11:24.332717 kernel: ACPI: Using GIC for interrupt routing Oct 13 05:11:24.332724 kernel: ACPI: MCFG table detected, 1 entries Oct 13 05:11:24.332731 kernel: ACPI: CPU0 has been hot-added Oct 13 05:11:24.332738 kernel: ACPI: CPU1 has been hot-added Oct 13 05:11:24.332746 kernel: ACPI: CPU2 has been hot-added Oct 13 05:11:24.332754 kernel: ACPI: CPU3 has been hot-added Oct 13 05:11:24.332762 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 13 05:11:24.332769 kernel: printk: legacy console [ttyAMA0] enabled Oct 13 05:11:24.332777 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 13 05:11:24.332940 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 13 05:11:24.333075 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 13 05:11:24.333165 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 13 05:11:24.333247 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 13 05:11:24.333328 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 13 05:11:24.333338 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 13 05:11:24.333345 kernel: PCI host bridge to bus 0000:00 Oct 13 05:11:24.333436 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 13 05:11:24.333513 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 13 05:11:24.333605 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 13 05:11:24.333679 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 13 05:11:24.333780 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Oct 13 05:11:24.333889 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 13 05:11:24.334009 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Oct 13 05:11:24.334126 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Oct 13 05:11:24.334210 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Oct 13 05:11:24.334291 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Oct 13 05:11:24.334371 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Oct 13 05:11:24.334457 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Oct 13 05:11:24.334534 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 13 05:11:24.334612 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 13 05:11:24.334686 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 13 05:11:24.334696 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 13 05:11:24.334704 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 13 05:11:24.334711 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 13 05:11:24.334719 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 13 05:11:24.334728 kernel: iommu: Default domain type: Translated Oct 13 05:11:24.334736 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 13 05:11:24.334743 kernel: efivars: Registered efivars operations Oct 13 05:11:24.334750 kernel: vgaarb: loaded Oct 13 05:11:24.334758 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 13 05:11:24.334765 kernel: VFS: Disk quotas dquot_6.6.0 Oct 13 05:11:24.334773 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 13 05:11:24.334781 kernel: pnp: PnP ACPI init Oct 13 05:11:24.334882 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 13 05:11:24.334893 kernel: pnp: PnP ACPI: found 1 devices Oct 13 05:11:24.334901 kernel: NET: Registered PF_INET protocol family Oct 13 05:11:24.334908 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 13 05:11:24.334916 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 13 05:11:24.334924 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 13 05:11:24.334933 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 13 05:11:24.334941 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 13 05:11:24.334961 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 13 05:11:24.334970 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 05:11:24.334978 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 13 05:11:24.334986 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 13 05:11:24.334993 kernel: PCI: CLS 0 bytes, default 64 Oct 13 05:11:24.335003 kernel: kvm [1]: HYP mode not available Oct 13 05:11:24.335010 kernel: Initialise system trusted keyrings Oct 13 05:11:24.335017 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 13 05:11:24.335025 kernel: Key type asymmetric registered Oct 13 05:11:24.335032 kernel: Asymmetric key parser 'x509' registered Oct 13 05:11:24.335040 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 13 05:11:24.335047 kernel: io scheduler mq-deadline registered Oct 13 05:11:24.335056 kernel: io scheduler kyber registered Oct 13 05:11:24.335063 kernel: io scheduler bfq registered Oct 13 05:11:24.335071 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 13 05:11:24.335078 kernel: ACPI: button: Power Button [PWRB] Oct 13 05:11:24.335086 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 13 05:11:24.335192 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 13 05:11:24.335203 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 13 05:11:24.335212 kernel: thunder_xcv, ver 1.0 Oct 13 05:11:24.335220 kernel: thunder_bgx, ver 1.0 Oct 13 05:11:24.335227 kernel: nicpf, ver 1.0 Oct 13 05:11:24.335235 kernel: nicvf, ver 1.0 Oct 13 05:11:24.335328 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 13 05:11:24.335406 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-13T05:11:23 UTC (1760332283) Oct 13 05:11:24.335416 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 13 05:11:24.335426 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 13 05:11:24.335433 kernel: watchdog: NMI not fully supported Oct 13 05:11:24.335441 kernel: watchdog: Hard watchdog permanently disabled Oct 13 05:11:24.335448 kernel: NET: Registered PF_INET6 protocol family Oct 13 05:11:24.335456 kernel: Segment Routing with IPv6 Oct 13 05:11:24.335463 kernel: In-situ OAM (IOAM) with IPv6 Oct 13 05:11:24.335471 kernel: NET: Registered PF_PACKET protocol family Oct 13 05:11:24.335479 kernel: Key type dns_resolver registered Oct 13 05:11:24.335487 kernel: registered taskstats version 1 Oct 13 05:11:24.335495 kernel: Loading compiled-in X.509 certificates Oct 13 05:11:24.335502 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.51-flatcar: 0d5be6bcdaeaf26c55e47d87e2567b03196058e4' Oct 13 05:11:24.335510 kernel: Demotion targets for Node 0: null Oct 13 05:11:24.335517 kernel: Key type .fscrypt registered Oct 13 05:11:24.335524 kernel: Key type fscrypt-provisioning registered Oct 13 05:11:24.335533 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 13 05:11:24.335541 kernel: ima: Allocated hash algorithm: sha1 Oct 13 05:11:24.335548 kernel: ima: No architecture policies found Oct 13 05:11:24.335556 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 13 05:11:24.335563 kernel: clk: Disabling unused clocks Oct 13 05:11:24.335570 kernel: PM: genpd: Disabling unused power domains Oct 13 05:11:24.335578 kernel: Freeing unused kernel memory: 12992K Oct 13 05:11:24.335587 kernel: Run /init as init process Oct 13 05:11:24.335594 kernel: with arguments: Oct 13 05:11:24.335602 kernel: /init Oct 13 05:11:24.335609 kernel: with environment: Oct 13 05:11:24.335616 kernel: HOME=/ Oct 13 05:11:24.335624 kernel: TERM=linux Oct 13 05:11:24.335631 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 13 05:11:24.335726 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 13 05:11:24.335818 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Oct 13 05:11:24.335829 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 13 05:11:24.335837 kernel: GPT:16515071 != 27000831 Oct 13 05:11:24.335844 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 13 05:11:24.335852 kernel: GPT:16515071 != 27000831 Oct 13 05:11:24.335861 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 13 05:11:24.335869 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 13 05:11:24.335876 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335884 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335891 kernel: SCSI subsystem initialized Oct 13 05:11:24.335910 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335918 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 13 05:11:24.335928 kernel: device-mapper: uevent: version 1.0.3 Oct 13 05:11:24.335935 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 13 05:11:24.335943 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 13 05:11:24.335959 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335967 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335990 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.335998 kernel: raid6: neonx8 gen() 15776 MB/s Oct 13 05:11:24.336006 kernel: raid6: neonx4 gen() 15829 MB/s Oct 13 05:11:24.336017 kernel: raid6: neonx2 gen() 13205 MB/s Oct 13 05:11:24.336024 kernel: raid6: neonx1 gen() 10435 MB/s Oct 13 05:11:24.336032 kernel: raid6: int64x8 gen() 6909 MB/s Oct 13 05:11:24.336039 kernel: raid6: int64x4 gen() 7356 MB/s Oct 13 05:11:24.336047 kernel: raid6: int64x2 gen() 6106 MB/s Oct 13 05:11:24.336055 kernel: raid6: int64x1 gen() 5049 MB/s Oct 13 05:11:24.336063 kernel: raid6: using algorithm neonx4 gen() 15829 MB/s Oct 13 05:11:24.336072 kernel: raid6: .... xor() 12359 MB/s, rmw enabled Oct 13 05:11:24.336080 kernel: raid6: using neon recovery algorithm Oct 13 05:11:24.336088 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336096 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336103 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336111 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336119 kernel: xor: measuring software checksum speed Oct 13 05:11:24.336127 kernel: 8regs : 21584 MB/sec Oct 13 05:11:24.336135 kernel: 32regs : 21687 MB/sec Oct 13 05:11:24.336143 kernel: arm64_neon : 28196 MB/sec Oct 13 05:11:24.336151 kernel: xor: using function: arm64_neon (28196 MB/sec) Oct 13 05:11:24.336159 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336166 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 13 05:11:24.336175 kernel: BTRFS: device fsid 976d1a25-6e06-4ce9-b674-96d83e61f95d devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (203) Oct 13 05:11:24.336183 kernel: BTRFS info (device dm-0): first mount of filesystem 976d1a25-6e06-4ce9-b674-96d83e61f95d Oct 13 05:11:24.336191 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 13 05:11:24.336200 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 13 05:11:24.336208 kernel: BTRFS info (device dm-0): enabling free space tree Oct 13 05:11:24.336216 kernel: Invalid ELF header magic: != \u007fELF Oct 13 05:11:24.336223 kernel: loop: module loaded Oct 13 05:11:24.336231 kernel: loop0: detected capacity change from 0 to 91456 Oct 13 05:11:24.336238 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 13 05:11:24.336247 systemd[1]: Successfully made /usr/ read-only. Oct 13 05:11:24.336259 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 13 05:11:24.336268 systemd[1]: Detected virtualization kvm. Oct 13 05:11:24.336275 systemd[1]: Detected architecture arm64. Oct 13 05:11:24.336283 systemd[1]: Running in initrd. Oct 13 05:11:24.336291 systemd[1]: No hostname configured, using default hostname. Oct 13 05:11:24.336300 systemd[1]: Hostname set to . Oct 13 05:11:24.336308 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 13 05:11:24.336316 systemd[1]: Queued start job for default target initrd.target. Oct 13 05:11:24.336325 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 13 05:11:24.336332 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 13 05:11:24.336341 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 13 05:11:24.336349 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 13 05:11:24.336364 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 13 05:11:24.336374 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 13 05:11:24.336383 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 13 05:11:24.336391 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 13 05:11:24.336401 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 13 05:11:24.336410 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 13 05:11:24.336418 systemd[1]: Reached target paths.target - Path Units. Oct 13 05:11:24.336426 systemd[1]: Reached target slices.target - Slice Units. Oct 13 05:11:24.336435 systemd[1]: Reached target swap.target - Swaps. Oct 13 05:11:24.336444 systemd[1]: Reached target timers.target - Timer Units. Oct 13 05:11:24.336452 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 13 05:11:24.336462 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 13 05:11:24.336471 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 13 05:11:24.336480 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 13 05:11:24.336488 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 13 05:11:24.336497 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 13 05:11:24.336506 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 13 05:11:24.336515 systemd[1]: Reached target sockets.target - Socket Units. Oct 13 05:11:24.336525 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 13 05:11:24.336533 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 13 05:11:24.336542 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 13 05:11:24.336550 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 13 05:11:24.336559 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Oct 13 05:11:24.336568 systemd[1]: Starting systemd-fsck-usr.service... Oct 13 05:11:24.336578 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 13 05:11:24.336586 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 13 05:11:24.336595 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 13 05:11:24.336604 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 13 05:11:24.336614 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 13 05:11:24.336623 systemd[1]: Finished systemd-fsck-usr.service. Oct 13 05:11:24.336632 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 13 05:11:24.336640 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 13 05:11:24.336648 kernel: Bridge firewalling registered Oct 13 05:11:24.336656 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 13 05:11:24.336685 systemd-journald[343]: Collecting audit messages is disabled. Oct 13 05:11:24.336705 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 13 05:11:24.336716 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 13 05:11:24.336726 systemd-journald[343]: Journal started Oct 13 05:11:24.336745 systemd-journald[343]: Runtime Journal (/run/log/journal/52632218a21146ef898d13d8dbfa2127) is 6M, max 48.5M, 42.4M free. Oct 13 05:11:24.326649 systemd-modules-load[344]: Inserted module 'br_netfilter' Oct 13 05:11:24.341995 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 13 05:11:24.344716 systemd[1]: Started systemd-journald.service - Journal Service. Oct 13 05:11:24.348025 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 13 05:11:24.350129 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 13 05:11:24.352182 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 13 05:11:24.355854 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 13 05:11:24.358721 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 13 05:11:24.360339 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 13 05:11:24.378433 systemd-tmpfiles[375]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 13 05:11:24.382012 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 13 05:11:24.390486 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 13 05:11:24.393888 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 13 05:11:24.409316 systemd-resolved[374]: Positive Trust Anchors: Oct 13 05:11:24.409343 systemd-resolved[374]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 13 05:11:24.409347 systemd-resolved[374]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 13 05:11:24.409378 systemd-resolved[374]: 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 13 05:11:24.420556 dracut-cmdline[389]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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 acpi=force verity.usrhash=1a81e36b39d22063d1d9b2ac3307af6d1e57cfd926c8fafd214fb74284e73d99 Oct 13 05:11:24.431260 systemd-resolved[374]: Defaulting to hostname 'linux'. Oct 13 05:11:24.432233 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 13 05:11:24.434340 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 13 05:11:24.487984 kernel: Loading iSCSI transport class v2.0-870. Oct 13 05:11:24.495964 kernel: iscsi: registered transport (tcp) Oct 13 05:11:24.508971 kernel: iscsi: registered transport (qla4xxx) Oct 13 05:11:24.508998 kernel: QLogic iSCSI HBA Driver Oct 13 05:11:24.528520 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 13 05:11:24.546115 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 13 05:11:24.548284 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 13 05:11:24.593031 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 13 05:11:24.594721 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 13 05:11:24.597136 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 13 05:11:24.632116 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 13 05:11:24.635107 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 13 05:11:24.663368 systemd-udevd[616]: Using default interface naming scheme 'v257'. Oct 13 05:11:24.671292 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 13 05:11:24.673814 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 13 05:11:24.698785 dracut-pre-trigger[687]: rd.md=0: removing MD RAID activation Oct 13 05:11:24.703920 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 13 05:11:24.706423 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 13 05:11:24.725854 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 13 05:11:24.728927 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 13 05:11:24.750645 systemd-networkd[744]: lo: Link UP Oct 13 05:11:24.750654 systemd-networkd[744]: lo: Gained carrier Oct 13 05:11:24.751130 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 13 05:11:24.752284 systemd[1]: Reached target network.target - Network. Oct 13 05:11:24.785244 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 13 05:11:24.788124 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 13 05:11:24.827997 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 13 05:11:24.843885 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 13 05:11:24.852012 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 13 05:11:24.858671 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 13 05:11:24.860724 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 13 05:11:24.876452 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 13 05:11:24.876565 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 13 05:11:24.878819 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 13 05:11:24.881601 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 13 05:11:24.884299 disk-uuid[801]: Primary Header is updated. Oct 13 05:11:24.884299 disk-uuid[801]: Secondary Entries is updated. Oct 13 05:11:24.884299 disk-uuid[801]: Secondary Header is updated. Oct 13 05:11:24.902932 systemd-networkd[744]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 13 05:11:24.902943 systemd-networkd[744]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 13 05:11:24.903638 systemd-networkd[744]: eth0: Link UP Oct 13 05:11:24.903830 systemd-networkd[744]: eth0: Gained carrier Oct 13 05:11:24.903840 systemd-networkd[744]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 13 05:11:24.923055 systemd-networkd[744]: eth0: DHCPv4 address 10.0.0.124/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 13 05:11:24.923238 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 13 05:11:24.954930 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 13 05:11:24.956182 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 13 05:11:24.957605 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 13 05:11:24.959566 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 13 05:11:24.962221 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 13 05:11:24.987960 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 13 05:11:25.922459 disk-uuid[803]: Warning: The kernel is still using the old partition table. Oct 13 05:11:25.922459 disk-uuid[803]: The new table will be used at the next reboot or after you Oct 13 05:11:25.922459 disk-uuid[803]: run partprobe(8) or kpartx(8) Oct 13 05:11:25.922459 disk-uuid[803]: The operation has completed successfully. Oct 13 05:11:25.928068 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 13 05:11:25.928181 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 13 05:11:25.930039 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 13 05:11:25.961976 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (833) Oct 13 05:11:25.963737 kernel: BTRFS info (device vda6): first mount of filesystem e9d5eae2-c289-4bda-a378-1699d81be8dc Oct 13 05:11:25.963756 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 13 05:11:25.966476 kernel: BTRFS info (device vda6): turning on async discard Oct 13 05:11:25.966500 kernel: BTRFS info (device vda6): enabling free space tree Oct 13 05:11:25.971967 kernel: BTRFS info (device vda6): last unmount of filesystem e9d5eae2-c289-4bda-a378-1699d81be8dc Oct 13 05:11:25.973430 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 13 05:11:25.975685 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 13 05:11:26.091509 ignition[852]: Ignition 2.22.0 Oct 13 05:11:26.091525 ignition[852]: Stage: fetch-offline Oct 13 05:11:26.091562 ignition[852]: no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:26.091572 ignition[852]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:26.091665 ignition[852]: parsed url from cmdline: "" Oct 13 05:11:26.091668 ignition[852]: no config URL provided Oct 13 05:11:26.091672 ignition[852]: reading system config file "/usr/lib/ignition/user.ign" Oct 13 05:11:26.091680 ignition[852]: no config at "/usr/lib/ignition/user.ign" Oct 13 05:11:26.091720 ignition[852]: op(1): [started] loading QEMU firmware config module Oct 13 05:11:26.091724 ignition[852]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 13 05:11:26.102532 ignition[852]: op(1): [finished] loading QEMU firmware config module Oct 13 05:11:26.102561 ignition[852]: QEMU firmware config was not found. Ignoring... Oct 13 05:11:26.109782 ignition[852]: parsing config with SHA512: 5d504c1df7a02190ae1770ef219b6b594f55808aaa34dcd6b3a740e42f3e80edd3fd1193d141221dda79816296b8a47cf32cbc04e598c8161526415242aa2f95 Oct 13 05:11:26.113812 unknown[852]: fetched base config from "system" Oct 13 05:11:26.113825 unknown[852]: fetched user config from "qemu" Oct 13 05:11:26.114098 ignition[852]: fetch-offline: fetch-offline passed Oct 13 05:11:26.114153 ignition[852]: Ignition finished successfully Oct 13 05:11:26.117498 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 13 05:11:26.130427 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 13 05:11:26.131376 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 13 05:11:26.164541 ignition[867]: Ignition 2.22.0 Oct 13 05:11:26.164557 ignition[867]: Stage: kargs Oct 13 05:11:26.164683 ignition[867]: no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:26.164691 ignition[867]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:26.167461 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 13 05:11:26.165284 ignition[867]: kargs: kargs passed Oct 13 05:11:26.165325 ignition[867]: Ignition finished successfully Oct 13 05:11:26.169872 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 13 05:11:26.200504 ignition[875]: Ignition 2.22.0 Oct 13 05:11:26.200524 ignition[875]: Stage: disks Oct 13 05:11:26.200668 ignition[875]: no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:26.200676 ignition[875]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:26.202889 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 13 05:11:26.201255 ignition[875]: disks: disks passed Oct 13 05:11:26.205042 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 13 05:11:26.201297 ignition[875]: Ignition finished successfully Oct 13 05:11:26.206745 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 13 05:11:26.208363 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 13 05:11:26.210161 systemd[1]: Reached target sysinit.target - System Initialization. Oct 13 05:11:26.211699 systemd[1]: Reached target basic.target - Basic System. Oct 13 05:11:26.214472 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 13 05:11:26.261396 systemd-fsck[885]: ROOT: clean, 15/456736 files, 38230/456704 blocks Oct 13 05:11:26.266056 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 13 05:11:26.268827 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 13 05:11:26.342933 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 13 05:11:26.344352 kernel: EXT4-fs (vda9): mounted filesystem a42694d5-feb9-4394-9ac1-a45818242d2d r/w with ordered data mode. Quota mode: none. Oct 13 05:11:26.344003 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 13 05:11:26.346221 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 13 05:11:26.347583 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 13 05:11:26.348390 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 13 05:11:26.348421 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 13 05:11:26.348446 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 13 05:11:26.360400 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 13 05:11:26.362521 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 13 05:11:26.367485 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (893) Oct 13 05:11:26.367516 kernel: BTRFS info (device vda6): first mount of filesystem e9d5eae2-c289-4bda-a378-1699d81be8dc Oct 13 05:11:26.367534 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 13 05:11:26.370658 kernel: BTRFS info (device vda6): turning on async discard Oct 13 05:11:26.370699 kernel: BTRFS info (device vda6): enabling free space tree Oct 13 05:11:26.371773 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 13 05:11:26.399512 initrd-setup-root[917]: cut: /sysroot/etc/passwd: No such file or directory Oct 13 05:11:26.402533 initrd-setup-root[924]: cut: /sysroot/etc/group: No such file or directory Oct 13 05:11:26.405532 initrd-setup-root[931]: cut: /sysroot/etc/shadow: No such file or directory Oct 13 05:11:26.408460 initrd-setup-root[938]: cut: /sysroot/etc/gshadow: No such file or directory Oct 13 05:11:26.474044 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 13 05:11:26.477104 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 13 05:11:26.478691 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 13 05:11:26.493269 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 13 05:11:26.494583 kernel: BTRFS info (device vda6): last unmount of filesystem e9d5eae2-c289-4bda-a378-1699d81be8dc Oct 13 05:11:26.513094 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 13 05:11:26.529626 ignition[1007]: INFO : Ignition 2.22.0 Oct 13 05:11:26.529626 ignition[1007]: INFO : Stage: mount Oct 13 05:11:26.532294 ignition[1007]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:26.532294 ignition[1007]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:26.532294 ignition[1007]: INFO : mount: mount passed Oct 13 05:11:26.532294 ignition[1007]: INFO : Ignition finished successfully Oct 13 05:11:26.532382 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 13 05:11:26.535394 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 13 05:11:26.910076 systemd-networkd[744]: eth0: Gained IPv6LL Oct 13 05:11:27.344499 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 13 05:11:27.374498 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1020) Oct 13 05:11:27.374539 kernel: BTRFS info (device vda6): first mount of filesystem e9d5eae2-c289-4bda-a378-1699d81be8dc Oct 13 05:11:27.374551 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 13 05:11:27.377362 kernel: BTRFS info (device vda6): turning on async discard Oct 13 05:11:27.377394 kernel: BTRFS info (device vda6): enabling free space tree Oct 13 05:11:27.378697 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 13 05:11:27.411415 ignition[1037]: INFO : Ignition 2.22.0 Oct 13 05:11:27.411415 ignition[1037]: INFO : Stage: files Oct 13 05:11:27.412976 ignition[1037]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:27.412976 ignition[1037]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:27.412976 ignition[1037]: DEBUG : files: compiled without relabeling support, skipping Oct 13 05:11:27.415433 ignition[1037]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 13 05:11:27.415433 ignition[1037]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 13 05:11:27.417514 ignition[1037]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 13 05:11:27.417514 ignition[1037]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 13 05:11:27.417514 ignition[1037]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 13 05:11:27.416766 unknown[1037]: wrote ssh authorized keys file for user: core Oct 13 05:11:27.421498 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Oct 13 05:11:27.421498 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Oct 13 05:11:27.428721 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 13 05:11:27.430462 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 13 05:11:27.430462 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Oct 13 05:11:27.430462 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Oct 13 05:11:27.430462 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Oct 13 05:11:27.430462 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-arm64.raw: attempt #1 Oct 13 05:11:27.736983 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Oct 13 05:11:28.014393 ignition[1037]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Oct 13 05:11:28.014393 ignition[1037]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Oct 13 05:11:28.016932 ignition[1037]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 13 05:11:28.020507 ignition[1037]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 13 05:11:28.020507 ignition[1037]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Oct 13 05:11:28.020507 ignition[1037]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Oct 13 05:11:28.042857 ignition[1037]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 13 05:11:28.046964 ignition[1037]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 13 05:11:28.046964 ignition[1037]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Oct 13 05:11:28.049801 ignition[1037]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 13 05:11:28.049801 ignition[1037]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 13 05:11:28.049801 ignition[1037]: INFO : files: files passed Oct 13 05:11:28.049801 ignition[1037]: INFO : Ignition finished successfully Oct 13 05:11:28.051063 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 13 05:11:28.053351 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 13 05:11:28.058210 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 13 05:11:28.070123 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 13 05:11:28.070972 initrd-setup-root-after-ignition[1065]: grep: /sysroot/oem/oem-release: No such file or directory Oct 13 05:11:28.071066 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 13 05:11:28.073672 initrd-setup-root-after-ignition[1068]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 13 05:11:28.073672 initrd-setup-root-after-ignition[1068]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 13 05:11:28.076005 initrd-setup-root-after-ignition[1072]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 13 05:11:28.077068 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 13 05:11:28.078350 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 13 05:11:28.080531 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 13 05:11:28.152228 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 13 05:11:28.152363 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 13 05:11:28.154120 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 13 05:11:28.155506 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 13 05:11:28.157044 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 13 05:11:28.159484 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 13 05:11:28.184917 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 13 05:11:28.187201 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 13 05:11:28.213485 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 13 05:11:28.213691 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 13 05:11:28.215250 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 13 05:11:28.216763 systemd[1]: Stopped target timers.target - Timer Units. Oct 13 05:11:28.218083 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 13 05:11:28.218218 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 13 05:11:28.220062 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 13 05:11:28.221617 systemd[1]: Stopped target basic.target - Basic System. Oct 13 05:11:28.222964 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 13 05:11:28.224310 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 13 05:11:28.225789 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 13 05:11:28.227264 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 13 05:11:28.228696 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 13 05:11:28.230078 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 13 05:11:28.231498 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 13 05:11:28.232897 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 13 05:11:28.234205 systemd[1]: Stopped target swap.target - Swaps. Oct 13 05:11:28.235346 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 13 05:11:28.235482 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 13 05:11:28.237190 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 13 05:11:28.238608 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 13 05:11:28.240020 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 13 05:11:28.241565 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 13 05:11:28.242556 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 13 05:11:28.242669 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 13 05:11:28.244832 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 13 05:11:28.244944 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 13 05:11:28.246653 systemd[1]: Stopped target paths.target - Path Units. Oct 13 05:11:28.247979 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 13 05:11:28.252003 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 13 05:11:28.252943 systemd[1]: Stopped target slices.target - Slice Units. Oct 13 05:11:28.254711 systemd[1]: Stopped target sockets.target - Socket Units. Oct 13 05:11:28.255969 systemd[1]: iscsid.socket: Deactivated successfully. Oct 13 05:11:28.256046 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 13 05:11:28.257284 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 13 05:11:28.257352 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 13 05:11:28.258889 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 13 05:11:28.259000 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 13 05:11:28.260675 systemd[1]: ignition-files.service: Deactivated successfully. Oct 13 05:11:28.260763 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 13 05:11:28.262770 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 13 05:11:28.265004 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 13 05:11:28.265679 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 13 05:11:28.265815 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 13 05:11:28.267257 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 13 05:11:28.267360 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 13 05:11:28.268680 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 13 05:11:28.268786 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 13 05:11:28.273604 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 13 05:11:28.274109 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 13 05:11:28.283540 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 13 05:11:28.288637 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 13 05:11:28.288758 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 13 05:11:28.296941 ignition[1093]: INFO : Ignition 2.22.0 Oct 13 05:11:28.297824 ignition[1093]: INFO : Stage: umount Oct 13 05:11:28.299344 ignition[1093]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 13 05:11:28.299344 ignition[1093]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 13 05:11:28.299344 ignition[1093]: INFO : umount: umount passed Oct 13 05:11:28.299344 ignition[1093]: INFO : Ignition finished successfully Oct 13 05:11:28.301499 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 13 05:11:28.301606 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 13 05:11:28.303158 systemd[1]: Stopped target network.target - Network. Oct 13 05:11:28.305612 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 13 05:11:28.305677 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 13 05:11:28.308941 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 13 05:11:28.309006 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 13 05:11:28.310472 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 13 05:11:28.310523 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 13 05:11:28.311900 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 13 05:11:28.311942 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 13 05:11:28.313502 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 13 05:11:28.313548 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 13 05:11:28.315119 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 13 05:11:28.316556 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 13 05:11:28.320199 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 13 05:11:28.320311 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 13 05:11:28.325094 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 13 05:11:28.325201 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 13 05:11:28.330796 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 13 05:11:28.332055 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 13 05:11:28.332090 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 13 05:11:28.334406 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 13 05:11:28.335913 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 13 05:11:28.335983 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 13 05:11:28.337866 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 13 05:11:28.337913 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 13 05:11:28.339501 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 13 05:11:28.339543 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 13 05:11:28.341366 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 13 05:11:28.355236 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 13 05:11:28.355379 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 13 05:11:28.358216 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 13 05:11:28.358287 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 13 05:11:28.360143 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 13 05:11:28.360176 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 13 05:11:28.361721 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 13 05:11:28.361783 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 13 05:11:28.363880 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 13 05:11:28.363927 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 13 05:11:28.366147 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 13 05:11:28.366195 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 13 05:11:28.376571 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 13 05:11:28.377681 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 13 05:11:28.377755 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 13 05:11:28.379715 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 13 05:11:28.379767 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 13 05:11:28.381531 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 13 05:11:28.381575 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 13 05:11:28.383643 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 13 05:11:28.383686 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 13 05:11:28.385467 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 13 05:11:28.385510 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 13 05:11:28.387997 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 13 05:11:28.388091 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 13 05:11:28.390137 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 13 05:11:28.390221 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 13 05:11:28.392316 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 13 05:11:28.394357 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 13 05:11:28.415057 systemd[1]: Switching root. Oct 13 05:11:28.457728 systemd-journald[343]: Journal stopped Oct 13 05:11:29.189819 systemd-journald[343]: Received SIGTERM from PID 1 (systemd). Oct 13 05:11:29.189873 kernel: SELinux: policy capability network_peer_controls=1 Oct 13 05:11:29.189889 kernel: SELinux: policy capability open_perms=1 Oct 13 05:11:29.189900 kernel: SELinux: policy capability extended_socket_class=1 Oct 13 05:11:29.189910 kernel: SELinux: policy capability always_check_network=0 Oct 13 05:11:29.189919 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 13 05:11:29.189929 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 13 05:11:29.189941 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 13 05:11:29.189976 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 13 05:11:29.189988 kernel: SELinux: policy capability userspace_initial_context=0 Oct 13 05:11:29.189999 kernel: audit: type=1403 audit(1760332288.632:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 13 05:11:29.190011 systemd[1]: Successfully loaded SELinux policy in 54.490ms. Oct 13 05:11:29.190027 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.699ms. Oct 13 05:11:29.190040 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 13 05:11:29.190055 systemd[1]: Detected virtualization kvm. Oct 13 05:11:29.190067 systemd[1]: Detected architecture arm64. Oct 13 05:11:29.190077 systemd[1]: Detected first boot. Oct 13 05:11:29.190088 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 13 05:11:29.190100 zram_generator::config[1138]: No configuration found. Oct 13 05:11:29.190110 kernel: NET: Registered PF_VSOCK protocol family Oct 13 05:11:29.190121 systemd[1]: Populated /etc with preset unit settings. Oct 13 05:11:29.190134 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 13 05:11:29.190144 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 13 05:11:29.190156 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 13 05:11:29.190168 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 13 05:11:29.190179 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 13 05:11:29.190191 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 13 05:11:29.190202 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 13 05:11:29.190214 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 13 05:11:29.190225 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 13 05:11:29.190237 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 13 05:11:29.190248 systemd[1]: Created slice user.slice - User and Session Slice. Oct 13 05:11:29.190260 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 13 05:11:29.190273 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 13 05:11:29.190285 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 13 05:11:29.190297 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 13 05:11:29.190308 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 13 05:11:29.190319 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 13 05:11:29.190330 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 13 05:11:29.190343 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 13 05:11:29.190354 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 13 05:11:29.190366 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 13 05:11:29.190377 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 13 05:11:29.190391 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 13 05:11:29.190402 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 13 05:11:29.190414 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 13 05:11:29.190425 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 13 05:11:29.190436 systemd[1]: Reached target slices.target - Slice Units. Oct 13 05:11:29.190447 systemd[1]: Reached target swap.target - Swaps. Oct 13 05:11:29.190458 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 13 05:11:29.190468 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 13 05:11:29.190479 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 13 05:11:29.190493 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 13 05:11:29.190506 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 13 05:11:29.190517 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 13 05:11:29.190528 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 13 05:11:29.190540 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 13 05:11:29.190550 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 13 05:11:29.190561 systemd[1]: Mounting media.mount - External Media Directory... Oct 13 05:11:29.190573 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 13 05:11:29.190586 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 13 05:11:29.190598 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 13 05:11:29.190609 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 13 05:11:29.190620 systemd[1]: Reached target machines.target - Containers. Oct 13 05:11:29.190631 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 13 05:11:29.190642 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 13 05:11:29.190653 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 13 05:11:29.190666 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 13 05:11:29.190677 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 13 05:11:29.190689 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 13 05:11:29.190701 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 13 05:11:29.190712 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 13 05:11:29.190723 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 13 05:11:29.190735 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 13 05:11:29.190746 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 13 05:11:29.190757 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 13 05:11:29.190768 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 13 05:11:29.190786 systemd[1]: Stopped systemd-fsck-usr.service. Oct 13 05:11:29.190799 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 13 05:11:29.190810 kernel: fuse: init (API version 7.41) Oct 13 05:11:29.190822 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 13 05:11:29.190833 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 13 05:11:29.190844 kernel: ACPI: bus type drm_connector registered Oct 13 05:11:29.190855 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 13 05:11:29.190867 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 13 05:11:29.190878 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 13 05:11:29.190888 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 13 05:11:29.190900 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 13 05:11:29.190911 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 13 05:11:29.190922 systemd[1]: Mounted media.mount - External Media Directory. Oct 13 05:11:29.190932 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 13 05:11:29.190944 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 13 05:11:29.190963 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 13 05:11:29.190995 systemd-journald[1212]: Collecting audit messages is disabled. Oct 13 05:11:29.191018 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 13 05:11:29.191029 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 13 05:11:29.191040 systemd-journald[1212]: Journal started Oct 13 05:11:29.191063 systemd-journald[1212]: Runtime Journal (/run/log/journal/52632218a21146ef898d13d8dbfa2127) is 6M, max 48.5M, 42.4M free. Oct 13 05:11:28.993854 systemd[1]: Queued start job for default target multi-user.target. Oct 13 05:11:29.008995 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 13 05:11:29.009436 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 13 05:11:29.194447 systemd[1]: Started systemd-journald.service - Journal Service. Oct 13 05:11:29.195557 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 13 05:11:29.196990 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 13 05:11:29.198153 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 13 05:11:29.198312 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 13 05:11:29.199490 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 13 05:11:29.199672 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 13 05:11:29.200871 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 13 05:11:29.201065 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 13 05:11:29.202169 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 13 05:11:29.202325 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 13 05:11:29.203414 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 13 05:11:29.203581 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 13 05:11:29.204797 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 13 05:11:29.206119 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 13 05:11:29.208127 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 13 05:11:29.209703 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 13 05:11:29.221980 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 13 05:11:29.223203 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 13 05:11:29.225272 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 13 05:11:29.227152 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 13 05:11:29.228006 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 13 05:11:29.228035 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 13 05:11:29.229662 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 13 05:11:29.230872 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 13 05:11:29.235844 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 13 05:11:29.237998 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 13 05:11:29.238991 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 13 05:11:29.240200 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 13 05:11:29.241180 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 13 05:11:29.244092 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 13 05:11:29.246789 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 13 05:11:29.249471 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 13 05:11:29.249647 systemd-journald[1212]: Time spent on flushing to /var/log/journal/52632218a21146ef898d13d8dbfa2127 is 23.145ms for 871 entries. Oct 13 05:11:29.249647 systemd-journald[1212]: System Journal (/var/log/journal/52632218a21146ef898d13d8dbfa2127) is 8M, max 163.5M, 155.5M free. Oct 13 05:11:29.282814 systemd-journald[1212]: Received client request to flush runtime journal. Oct 13 05:11:29.282885 kernel: loop1: detected capacity change from 0 to 119344 Oct 13 05:11:29.252576 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 13 05:11:29.256012 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 13 05:11:29.257271 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 13 05:11:29.258453 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 13 05:11:29.264348 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 13 05:11:29.269132 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 13 05:11:29.272530 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 13 05:11:29.286371 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 13 05:11:29.287000 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Oct 13 05:11:29.287015 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Oct 13 05:11:29.295092 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 13 05:11:29.297279 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 13 05:11:29.298966 kernel: loop2: detected capacity change from 0 to 100624 Oct 13 05:11:29.300761 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 13 05:11:29.321989 kernel: loop3: detected capacity change from 0 to 207008 Oct 13 05:11:29.339161 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 13 05:11:29.341749 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 13 05:11:29.343622 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 13 05:11:29.348988 kernel: loop4: detected capacity change from 0 to 119344 Oct 13 05:11:29.354977 kernel: loop5: detected capacity change from 0 to 100624 Oct 13 05:11:29.361763 kernel: loop6: detected capacity change from 0 to 207008 Oct 13 05:11:29.362001 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 13 05:11:29.366761 (sd-merge)[1277]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'kubernetes.raw'. Oct 13 05:11:29.369755 (sd-merge)[1277]: Merged extensions into '/usr'. Oct 13 05:11:29.370871 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Oct 13 05:11:29.370888 systemd-tmpfiles[1276]: ACLs are not supported, ignoring. Oct 13 05:11:29.379295 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 13 05:11:29.382298 systemd[1]: Reload requested from client PID 1254 ('systemd-sysext') (unit systemd-sysext.service)... Oct 13 05:11:29.382345 systemd[1]: Reloading... Oct 13 05:11:29.437123 zram_generator::config[1311]: No configuration found. Oct 13 05:11:29.488619 systemd-resolved[1275]: Positive Trust Anchors: Oct 13 05:11:29.488644 systemd-resolved[1275]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 13 05:11:29.488647 systemd-resolved[1275]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 13 05:11:29.488680 systemd-resolved[1275]: 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 13 05:11:29.496038 systemd-resolved[1275]: Defaulting to hostname 'linux'. Oct 13 05:11:29.576980 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 13 05:11:29.577238 systemd[1]: Reloading finished in 194 ms. Oct 13 05:11:29.615526 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 13 05:11:29.616628 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 13 05:11:29.617799 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 13 05:11:29.622591 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 13 05:11:29.644190 systemd[1]: Starting ensure-sysext.service... Oct 13 05:11:29.645874 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 13 05:11:29.658470 systemd[1]: Reload requested from client PID 1347 ('systemctl') (unit ensure-sysext.service)... Oct 13 05:11:29.658486 systemd[1]: Reloading... Oct 13 05:11:29.658919 systemd-tmpfiles[1348]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 13 05:11:29.658973 systemd-tmpfiles[1348]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 13 05:11:29.659179 systemd-tmpfiles[1348]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 13 05:11:29.659331 systemd-tmpfiles[1348]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 13 05:11:29.659878 systemd-tmpfiles[1348]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 13 05:11:29.660165 systemd-tmpfiles[1348]: ACLs are not supported, ignoring. Oct 13 05:11:29.660219 systemd-tmpfiles[1348]: ACLs are not supported, ignoring. Oct 13 05:11:29.663963 systemd-tmpfiles[1348]: Detected autofs mount point /boot during canonicalization of boot. Oct 13 05:11:29.663972 systemd-tmpfiles[1348]: Skipping /boot Oct 13 05:11:29.670165 systemd-tmpfiles[1348]: Detected autofs mount point /boot during canonicalization of boot. Oct 13 05:11:29.670185 systemd-tmpfiles[1348]: Skipping /boot Oct 13 05:11:29.709981 zram_generator::config[1378]: No configuration found. Oct 13 05:11:29.841821 systemd[1]: Reloading finished in 183 ms. Oct 13 05:11:29.865991 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 13 05:11:29.878982 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 13 05:11:29.894095 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 13 05:11:29.896097 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 13 05:11:29.897065 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 13 05:11:29.905313 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 13 05:11:29.907232 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 13 05:11:29.912175 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 13 05:11:29.914255 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 13 05:11:29.918520 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 13 05:11:29.919999 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 13 05:11:29.920115 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Oct 13 05:11:29.925986 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 13 05:11:29.928451 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 13 05:11:29.932812 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 13 05:11:29.935547 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 13 05:11:29.935725 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 13 05:11:29.938546 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 13 05:11:29.938685 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 13 05:11:29.943648 systemd[1]: Finished ensure-sysext.service. Oct 13 05:11:29.946104 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 13 05:11:29.946250 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 13 05:11:29.950379 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 13 05:11:29.950621 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 13 05:11:29.954519 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 13 05:11:29.954722 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 13 05:11:29.961674 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 13 05:11:29.963288 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 13 05:11:29.964726 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 13 05:11:29.967358 augenrules[1452]: No rules Oct 13 05:11:29.966434 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 13 05:11:29.967927 systemd[1]: audit-rules.service: Deactivated successfully. Oct 13 05:11:29.968216 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 13 05:11:29.972149 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 13 05:11:29.982512 systemd-udevd[1431]: Using default interface naming scheme 'v257'. Oct 13 05:11:29.998655 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 13 05:11:30.002063 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 13 05:11:30.021448 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 13 05:11:30.023373 systemd[1]: Reached target time-set.target - System Time Set. Oct 13 05:11:30.079695 systemd-networkd[1470]: lo: Link UP Oct 13 05:11:30.079703 systemd-networkd[1470]: lo: Gained carrier Oct 13 05:11:30.081387 systemd-networkd[1470]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 13 05:11:30.081399 systemd-networkd[1470]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 13 05:11:30.081486 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 13 05:11:30.082791 systemd[1]: Reached target network.target - Network. Oct 13 05:11:30.082812 systemd-networkd[1470]: eth0: Link UP Oct 13 05:11:30.082933 systemd-networkd[1470]: eth0: Gained carrier Oct 13 05:11:30.082945 systemd-networkd[1470]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 13 05:11:30.085548 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 13 05:11:30.088078 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 13 05:11:30.090195 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 13 05:11:30.099014 systemd-networkd[1470]: eth0: DHCPv4 address 10.0.0.124/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 13 05:11:30.100731 systemd-timesyncd[1450]: Network configuration changed, trying to establish connection. Oct 13 05:11:29.640490 systemd-resolved[1275]: Clock change detected. Flushing caches. Oct 13 05:11:29.646843 systemd-journald[1212]: Time jumped backwards, rotating. Oct 13 05:11:29.640571 systemd-timesyncd[1450]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 13 05:11:29.640620 systemd-timesyncd[1450]: Initial clock synchronization to Mon 2025-10-13 05:11:29.640439 UTC. Oct 13 05:11:29.655752 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 13 05:11:29.688802 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 13 05:11:29.691868 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 13 05:11:29.724298 ldconfig[1416]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 13 05:11:29.729253 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 13 05:11:29.733312 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 13 05:11:29.743989 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 13 05:11:29.745604 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 13 05:11:29.754467 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 13 05:11:29.787186 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 13 05:11:29.789294 systemd[1]: Reached target sysinit.target - System Initialization. Oct 13 05:11:29.790190 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 13 05:11:29.791076 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 13 05:11:29.792079 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 13 05:11:29.792964 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 13 05:11:29.793991 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 13 05:11:29.794935 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 13 05:11:29.794965 systemd[1]: Reached target paths.target - Path Units. Oct 13 05:11:29.795664 systemd[1]: Reached target timers.target - Timer Units. Oct 13 05:11:29.797073 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 13 05:11:29.799173 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 13 05:11:29.801616 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 13 05:11:29.802707 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 13 05:11:29.803643 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 13 05:11:29.810916 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 13 05:11:29.812215 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 13 05:11:29.813605 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 13 05:11:29.814490 systemd[1]: Reached target sockets.target - Socket Units. Oct 13 05:11:29.815187 systemd[1]: Reached target basic.target - Basic System. Oct 13 05:11:29.815879 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 13 05:11:29.815907 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 13 05:11:29.816815 systemd[1]: Starting containerd.service - containerd container runtime... Oct 13 05:11:29.818524 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 13 05:11:29.820223 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 13 05:11:29.821832 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 13 05:11:29.824125 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 13 05:11:29.825275 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 13 05:11:29.828027 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 13 05:11:29.829272 jq[1529]: false Oct 13 05:11:29.830133 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 13 05:11:29.833216 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 13 05:11:29.838080 extend-filesystems[1530]: Found /dev/vda6 Oct 13 05:11:29.836356 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 13 05:11:29.844340 extend-filesystems[1530]: Found /dev/vda9 Oct 13 05:11:29.844340 extend-filesystems[1530]: Checking size of /dev/vda9 Oct 13 05:11:29.837125 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 13 05:11:29.850990 extend-filesystems[1530]: Resized partition /dev/vda9 Oct 13 05:11:29.837581 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 13 05:11:29.857352 extend-filesystems[1554]: resize2fs 1.47.3 (8-Jul-2025) Oct 13 05:11:29.839182 systemd[1]: Starting update-engine.service - Update Engine... Oct 13 05:11:29.862401 jq[1547]: true Oct 13 05:11:29.841248 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 13 05:11:29.845935 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 13 05:11:29.849356 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 13 05:11:29.862734 jq[1556]: true Oct 13 05:11:29.849528 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 13 05:11:29.849767 systemd[1]: motdgen.service: Deactivated successfully. Oct 13 05:11:29.849937 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 13 05:11:29.852022 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 13 05:11:29.852366 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 13 05:11:29.864663 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Oct 13 05:11:29.870826 (ntainerd)[1559]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 13 05:11:29.877296 update_engine[1544]: I20251013 05:11:29.876760 1544 main.cc:92] Flatcar Update Engine starting Oct 13 05:11:29.901544 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Oct 13 05:11:29.920778 dbus-daemon[1527]: [system] SELinux support is enabled Oct 13 05:11:29.921265 extend-filesystems[1554]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 13 05:11:29.921265 extend-filesystems[1554]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 13 05:11:29.921265 extend-filesystems[1554]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Oct 13 05:11:29.931970 extend-filesystems[1530]: Resized filesystem in /dev/vda9 Oct 13 05:11:29.935081 update_engine[1544]: I20251013 05:11:29.930109 1544 update_check_scheduler.cc:74] Next update check in 10m18s Oct 13 05:11:29.923330 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 13 05:11:29.935183 bash[1588]: Updated "/home/core/.ssh/authorized_keys" Oct 13 05:11:29.928399 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 13 05:11:29.929094 systemd-logind[1540]: Watching system buttons on /dev/input/event0 (Power Button) Oct 13 05:11:29.930120 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 13 05:11:29.930669 systemd-logind[1540]: New seat seat0. Oct 13 05:11:29.934301 systemd[1]: Started systemd-logind.service - User Login Management. Oct 13 05:11:29.936174 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 13 05:11:29.941358 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 13 05:11:29.941460 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 13 05:11:29.941481 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 13 05:11:29.942835 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 13 05:11:29.942937 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 13 05:11:29.942975 dbus-daemon[1527]: [system] Successfully activated service 'org.freedesktop.systemd1' Oct 13 05:11:29.944207 systemd[1]: Started update-engine.service - Update Engine. Oct 13 05:11:29.947164 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 13 05:11:29.988042 locksmithd[1591]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 13 05:11:30.055135 containerd[1559]: time="2025-10-13T05:11:30Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 13 05:11:30.057081 containerd[1559]: time="2025-10-13T05:11:30.055745331Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 13 05:11:30.065137 containerd[1559]: time="2025-10-13T05:11:30.065095571Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.44µs" Oct 13 05:11:30.065248 containerd[1559]: time="2025-10-13T05:11:30.065231371Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 13 05:11:30.065300 containerd[1559]: time="2025-10-13T05:11:30.065286851Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 13 05:11:30.065494 containerd[1559]: time="2025-10-13T05:11:30.065474931Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 13 05:11:30.065556 containerd[1559]: time="2025-10-13T05:11:30.065541851Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 13 05:11:30.065620 containerd[1559]: time="2025-10-13T05:11:30.065606491Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 13 05:11:30.065736 containerd[1559]: time="2025-10-13T05:11:30.065718371Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 13 05:11:30.065787 containerd[1559]: time="2025-10-13T05:11:30.065773931Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066079 containerd[1559]: time="2025-10-13T05:11:30.066035331Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066144 containerd[1559]: time="2025-10-13T05:11:30.066129411Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066194 containerd[1559]: time="2025-10-13T05:11:30.066180291Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066257 containerd[1559]: time="2025-10-13T05:11:30.066244371Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066397 containerd[1559]: time="2025-10-13T05:11:30.066378811Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066642 containerd[1559]: time="2025-10-13T05:11:30.066620091Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066725 containerd[1559]: time="2025-10-13T05:11:30.066707651Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 13 05:11:30.066787 containerd[1559]: time="2025-10-13T05:11:30.066773011Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 13 05:11:30.066881 containerd[1559]: time="2025-10-13T05:11:30.066857771Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 13 05:11:30.067603 containerd[1559]: time="2025-10-13T05:11:30.067553131Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 13 05:11:30.067687 containerd[1559]: time="2025-10-13T05:11:30.067666091Z" level=info msg="metadata content store policy set" policy=shared Oct 13 05:11:30.071012 containerd[1559]: time="2025-10-13T05:11:30.070959731Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 13 05:11:30.071097 containerd[1559]: time="2025-10-13T05:11:30.071033011Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 13 05:11:30.071097 containerd[1559]: time="2025-10-13T05:11:30.071062411Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 13 05:11:30.071097 containerd[1559]: time="2025-10-13T05:11:30.071077531Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 13 05:11:30.071097 containerd[1559]: time="2025-10-13T05:11:30.071090971Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071101531Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071114971Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071127971Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071140451Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071151491Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 13 05:11:30.071168 containerd[1559]: time="2025-10-13T05:11:30.071160691Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 13 05:11:30.071263 containerd[1559]: time="2025-10-13T05:11:30.071173571Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 13 05:11:30.071331 containerd[1559]: time="2025-10-13T05:11:30.071302931Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 13 05:11:30.071355 containerd[1559]: time="2025-10-13T05:11:30.071341971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 13 05:11:30.071377 containerd[1559]: time="2025-10-13T05:11:30.071357971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 13 05:11:30.071377 containerd[1559]: time="2025-10-13T05:11:30.071370171Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 13 05:11:30.071435 containerd[1559]: time="2025-10-13T05:11:30.071380691Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 13 05:11:30.071435 containerd[1559]: time="2025-10-13T05:11:30.071392131Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 13 05:11:30.071435 containerd[1559]: time="2025-10-13T05:11:30.071406651Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 13 05:11:30.071435 containerd[1559]: time="2025-10-13T05:11:30.071416731Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 13 05:11:30.071435 containerd[1559]: time="2025-10-13T05:11:30.071433411Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 13 05:11:30.071515 containerd[1559]: time="2025-10-13T05:11:30.071445531Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 13 05:11:30.071515 containerd[1559]: time="2025-10-13T05:11:30.071456651Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 13 05:11:30.071671 containerd[1559]: time="2025-10-13T05:11:30.071637051Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 13 05:11:30.071671 containerd[1559]: time="2025-10-13T05:11:30.071657771Z" level=info msg="Start snapshots syncer" Oct 13 05:11:30.071712 containerd[1559]: time="2025-10-13T05:11:30.071683411Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 13 05:11:30.071946 containerd[1559]: time="2025-10-13T05:11:30.071899891Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 13 05:11:30.072030 containerd[1559]: time="2025-10-13T05:11:30.071956131Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 13 05:11:30.072049 containerd[1559]: time="2025-10-13T05:11:30.072029291Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 13 05:11:30.072184 containerd[1559]: time="2025-10-13T05:11:30.072161891Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 13 05:11:30.072211 containerd[1559]: time="2025-10-13T05:11:30.072196531Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 13 05:11:30.072228 containerd[1559]: time="2025-10-13T05:11:30.072209091Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 13 05:11:30.072228 containerd[1559]: time="2025-10-13T05:11:30.072220251Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 13 05:11:30.072259 containerd[1559]: time="2025-10-13T05:11:30.072238291Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 13 05:11:30.072259 containerd[1559]: time="2025-10-13T05:11:30.072249731Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 13 05:11:30.072295 containerd[1559]: time="2025-10-13T05:11:30.072260091Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 13 05:11:30.072295 containerd[1559]: time="2025-10-13T05:11:30.072285971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 13 05:11:30.072327 containerd[1559]: time="2025-10-13T05:11:30.072302331Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 13 05:11:30.072327 containerd[1559]: time="2025-10-13T05:11:30.072312891Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 13 05:11:30.072357 containerd[1559]: time="2025-10-13T05:11:30.072351091Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 13 05:11:30.072374 containerd[1559]: time="2025-10-13T05:11:30.072365891Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 13 05:11:30.072391 containerd[1559]: time="2025-10-13T05:11:30.072375371Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 13 05:11:30.072391 containerd[1559]: time="2025-10-13T05:11:30.072385131Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 13 05:11:30.072426 containerd[1559]: time="2025-10-13T05:11:30.072393331Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 13 05:11:30.072426 containerd[1559]: time="2025-10-13T05:11:30.072403051Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 13 05:11:30.072426 containerd[1559]: time="2025-10-13T05:11:30.072414651Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 13 05:11:30.072537 containerd[1559]: time="2025-10-13T05:11:30.072524851Z" level=info msg="runtime interface created" Oct 13 05:11:30.072537 containerd[1559]: time="2025-10-13T05:11:30.072533651Z" level=info msg="created NRI interface" Oct 13 05:11:30.072576 containerd[1559]: time="2025-10-13T05:11:30.072544771Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 13 05:11:30.072576 containerd[1559]: time="2025-10-13T05:11:30.072556171Z" level=info msg="Connect containerd service" Oct 13 05:11:30.072607 containerd[1559]: time="2025-10-13T05:11:30.072582011Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 13 05:11:30.073314 containerd[1559]: time="2025-10-13T05:11:30.073286931Z" 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 13 05:11:30.137333 containerd[1559]: time="2025-10-13T05:11:30.137268291Z" level=info msg="Start subscribing containerd event" Oct 13 05:11:30.137431 containerd[1559]: time="2025-10-13T05:11:30.137349571Z" level=info msg="Start recovering state" Oct 13 05:11:30.137451 containerd[1559]: time="2025-10-13T05:11:30.137437451Z" level=info msg="Start event monitor" Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137451571Z" level=info msg="Start cni network conf syncer for default" Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137458931Z" level=info msg="Start streaming server" Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137469011Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137475771Z" level=info msg="runtime interface starting up..." Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137481571Z" level=info msg="starting plugins..." Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137493851Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137563451Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137610131Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 13 05:11:30.137737 containerd[1559]: time="2025-10-13T05:11:30.137665411Z" level=info msg="containerd successfully booted in 0.082932s" Oct 13 05:11:30.138030 systemd[1]: Started containerd.service - containerd container runtime. Oct 13 05:11:30.580900 sshd_keygen[1570]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 13 05:11:30.600031 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 13 05:11:30.602482 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 13 05:11:30.628680 systemd[1]: issuegen.service: Deactivated successfully. Oct 13 05:11:30.628897 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 13 05:11:30.631457 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 13 05:11:30.663912 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 13 05:11:30.668295 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 13 05:11:30.670094 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 13 05:11:30.671047 systemd[1]: Reached target getty.target - Login Prompts. Oct 13 05:11:31.441177 systemd-networkd[1470]: eth0: Gained IPv6LL Oct 13 05:11:31.445161 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 13 05:11:31.447744 systemd[1]: Reached target network-online.target - Network is Online. Oct 13 05:11:31.450621 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 13 05:11:31.453185 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 13 05:11:31.465613 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 13 05:11:31.481354 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 13 05:11:31.481558 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 13 05:11:31.483549 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 13 05:11:31.485143 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 13 05:11:32.018095 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 13 05:11:32.019485 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 13 05:11:32.021284 systemd[1]: Startup finished in 1.135s (kernel) + 4.532s (initrd) + 3.904s (userspace) = 9.572s. Oct 13 05:11:32.022360 (kubelet)[1656]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Oct 13 05:11:32.358283 kubelet[1656]: E1013 05:11:32.358171 1656 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 13 05:11:32.360558 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Oct 13 05:11:32.360685 systemd[1]: kubelet.service: Failed with result 'exit-code'. Oct 13 05:11:32.361267 systemd[1]: kubelet.service: Consumed 749ms CPU time, 257.3M memory peak. Oct 13 05:11:34.781420 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 13 05:11:34.782578 systemd[1]: Started sshd@0-10.0.0.124:22-10.0.0.1:50562.service - OpenSSH per-connection server daemon (10.0.0.1:50562). Oct 13 05:11:34.848292 sshd[1669]: Accepted publickey for core from 10.0.0.1 port 50562 ssh2: RSA SHA256:hda7tEZiENufrVU/Fi4L6jJcDJNGwI829sWbBxYIz5c Oct 13 05:11:34.850174 sshd-session[1669]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 13 05:11:34.856228 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 13 05:11:34.857169 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 13 05:11:34.862335 systemd-logind[1540]: New session 1 of user core. Oct 13 05:11:34.881733 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 13 05:11:34.885345 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 13 05:11:34.909222 (systemd)[1674]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 13 05:11:34.911457 systemd-logind[1540]: New session c1 of user core. Oct 13 05:11:35.021687 systemd[1674]: Queued start job for default target default.target. Oct 13 05:11:35.045066 systemd[1674]: Created slice app.slice - User Application Slice. Oct 13 05:11:35.045099 systemd[1674]: Reached target paths.target - Paths. Oct 13 05:11:35.045142 systemd[1674]: Reached target timers.target - Timers. Oct 13 05:11:35.046261 systemd[1674]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 13 05:11:35.055435 systemd[1674]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 13 05:11:35.055497 systemd[1674]: Reached target sockets.target - Sockets. Oct 13 05:11:35.055536 systemd[1674]: Reached target basic.target - Basic System. Oct 13 05:11:35.055564 systemd[1674]: Reached target default.target - Main User Target. Oct 13 05:11:35.055588 systemd[1674]: Startup finished in 138ms. Oct 13 05:11:35.055792 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 13 05:11:35.057129 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 13 05:11:35.124330 systemd[1]: Started sshd@1-10.0.0.124:22-10.0.0.1:50568.service - OpenSSH per-connection server daemon (10.0.0.1:50568). Oct 13 05:11:35.180954 sshd[1685]: Accepted publickey for core from 10.0.0.1 port 50568 ssh2: RSA SHA256:hda7tEZiENufrVU/Fi4L6jJcDJNGwI829sWbBxYIz5c Oct 13 05:11:35.182279 sshd-session[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 13 05:11:35.186921 systemd-logind[1540]: New session 2 of user core. Oct 13 05:11:35.202249 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 13 05:11:35.254108 sshd[1688]: Connection closed by 10.0.0.1 port 50568 Oct 13 05:11:35.254574 sshd-session[1685]: pam_unix(sshd:session): session closed for user core Oct 13 05:11:35.265151 systemd[1]: sshd@1-10.0.0.124:22-10.0.0.1:50568.service: Deactivated successfully. Oct 13 05:11:35.266611 systemd[1]: session-2.scope: Deactivated successfully. Oct 13 05:11:35.267314 systemd-logind[1540]: Session 2 logged out. Waiting for processes to exit. Oct 13 05:11:35.269436 systemd[1]: Started sshd@2-10.0.0.124:22-10.0.0.1:50578.service - OpenSSH per-connection server daemon (10.0.0.1:50578). Oct 13 05:11:35.269873 systemd-logind[1540]: Removed session 2. Oct 13 05:11:35.328872 sshd[1694]: Accepted publickey for core from 10.0.0.1 port 50578 ssh2: RSA SHA256:hda7tEZiENufrVU/Fi4L6jJcDJNGwI829sWbBxYIz5c Oct 13 05:11:35.330189 sshd-session[1694]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 13 05:11:35.334041 systemd-logind[1540]: New session 3 of user core. Oct 13 05:11:35.343202 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 13 05:11:35.390541 sshd[1697]: Connection closed by 10.0.0.1 port 50578 Oct 13 05:11:35.390862 sshd-session[1694]: pam_unix(sshd:session): session closed for user core Oct 13 05:11:35.399986 systemd[1]: sshd@2-10.0.0.124:22-10.0.0.1:50578.service: Deactivated successfully. Oct 13 05:11:35.401512 systemd[1]: session-3.scope: Deactivated successfully. Oct 13 05:11:35.402411 systemd-logind[1540]: Session 3 logged out. Waiting for processes to exit. Oct 13 05:11:35.405441 systemd[1]: Started sshd@3-10.0.0.124:22-10.0.0.1:50582.service - OpenSSH per-connection server daemon (10.0.0.1:50582). Oct 13 05:11:35.406068 systemd-logind[1540]: Removed session 3. Oct 13 05:11:35.455260 sshd[1703]: Accepted publickey for core from 10.0.0.1 port 50582 ssh2: RSA SHA256:hda7tEZiENufrVU/Fi4L6jJcDJNGwI829sWbBxYIz5c Oct 13 05:11:35.456466 sshd-session[1703]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 13 05:11:35.460916 systemd-logind[1540]: New session 4 of user core. Oct 13 05:11:35.472207 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 13 05:11:35.523804 sshd[1706]: Connection closed by 10.0.0.1 port 50582 Oct 13 05:11:35.524144 sshd-session[1703]: pam_unix(sshd:session): session closed for user core Oct 13 05:11:35.538241 systemd[1]: sshd@3-10.0.0.124:22-10.0.0.1:50582.service: Deactivated successfully. Oct 13 05:11:35.539801 systemd[1]: session-4.scope: Deactivated successfully. Oct 13 05:11:35.541128 systemd-logind[1540]: Session 4 logged out. Waiting for processes to exit. Oct 13 05:11:35.542488 systemd[1]: Started sshd@4-10.0.0.124:22-10.0.0.1:56504.service - OpenSSH per-connection server daemon (10.0.0.1:56504). Oct 13 05:11:35.543592 systemd-logind[1540]: Removed session 4. Oct 13 05:11:35.596420 sshd[1712]: Accepted publickey for core from 10.0.0.1 port 56504 ssh2: RSA SHA256:hda7tEZiENufrVU/Fi4L6jJcDJNGwI829sWbBxYIz5c Oct 13 05:11:35.598035 sshd-session[1712]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 13 05:11:35.602110 systemd-logind[1540]: New session 5 of user core. Oct 13 05:11:35.613223 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 13 05:11:35.669192 sudo[1716]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Oct 13 05:11:35.669439 sudo[1716]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 13 05:11:35.679651 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 13 05:11:35.732164 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 13 05:11:35.732404 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 13 05:11:36.110821 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 13 05:11:36.110969 systemd[1]: kubelet.service: Consumed 749ms CPU time, 257.3M memory peak. Oct 13 05:11:36.112713 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 13 05:11:36.131612 systemd[1]: Reload requested from client PID 1757 ('systemctl') (unit session-5.scope)... Oct 13 05:11:36.131625 systemd[1]: Reloading... Oct 13 05:11:36.206075 zram_generator::config[1799]: No configuration found. Oct 13 05:11:36.383388 systemd[1]: Reloading finished in 251 ms. Oct 13 05:11:36.442486 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Oct 13 05:11:36.442561 systemd[1]: kubelet.service: Failed with result 'signal'. Oct 13 05:11:36.442788 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 13 05:11:36.442831 systemd[1]: kubelet.service: Consumed 93ms CPU time, 95.1M memory peak. Oct 13 05:11:36.446231 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 13 05:11:36.551046 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 13 05:11:36.555005 (kubelet)[1844]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Oct 13 05:11:36.587977 kubelet[1844]: Flag --container-runtime-endpoint 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 13 05:11:36.587977 kubelet[1844]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Oct 13 05:11:36.587977 kubelet[1844]: 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 13 05:11:36.588310 kubelet[1844]: I1013 05:11:36.588028 1844 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Oct 13 05:11:37.712796 kubelet[1844]: I1013 05:11:37.712743 1844 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Oct 13 05:11:37.712796 kubelet[1844]: I1013 05:11:37.712780 1844 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Oct 13 05:11:37.713293 kubelet[1844]: I1013 05:11:37.713244 1844 server.go:954] "Client rotation is on, will bootstrap in background" Oct 13 05:11:37.740395 kubelet[1844]: I1013 05:11:37.740354 1844 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Oct 13 05:11:37.747790 kubelet[1844]: I1013 05:11:37.747769 1844 server.go:1444] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Oct 13 05:11:37.750744 kubelet[1844]: I1013 05:11:37.750715 1844 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Oct 13 05:11:37.751388 kubelet[1844]: I1013 05:11:37.751341 1844 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Oct 13 05:11:37.751548 kubelet[1844]: I1013 05:11:37.751380 1844 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.124","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"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,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Oct 13 05:11:37.751646 kubelet[1844]: I1013 05:11:37.751608 1844 topology_manager.go:138] "Creating topology manager with none policy" Oct 13 05:11:37.751646 kubelet[1844]: I1013 05:11:37.751617 1844 container_manager_linux.go:304] "Creating device plugin manager" Oct 13 05:11:37.751946 kubelet[1844]: I1013 05:11:37.751914 1844 state_mem.go:36] "Initialized new in-memory state store" Oct 13 05:11:37.754830 kubelet[1844]: I1013 05:11:37.754798 1844 kubelet.go:446] "Attempting to sync node with API server" Oct 13 05:11:37.754830 kubelet[1844]: I1013 05:11:37.754822 1844 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Oct 13 05:11:37.755341 kubelet[1844]: I1013 05:11:37.755087 1844 kubelet.go:352] "Adding apiserver pod source" Oct 13 05:11:37.755341 kubelet[1844]: I1013 05:11:37.755103 1844 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Oct 13 05:11:37.755341 kubelet[1844]: E1013 05:11:37.755142 1844 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:37.755341 kubelet[1844]: E1013 05:11:37.755193 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:37.758326 kubelet[1844]: I1013 05:11:37.758307 1844 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v2.0.5" apiVersion="v1" Oct 13 05:11:37.758940 kubelet[1844]: I1013 05:11:37.758925 1844 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Oct 13 05:11:37.759064 kubelet[1844]: W1013 05:11:37.759039 1844 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Oct 13 05:11:37.759889 kubelet[1844]: I1013 05:11:37.759860 1844 watchdog_linux.go:99] "Systemd watchdog is not enabled" Oct 13 05:11:37.759932 kubelet[1844]: I1013 05:11:37.759903 1844 server.go:1287] "Started kubelet" Oct 13 05:11:37.760022 kubelet[1844]: I1013 05:11:37.759990 1844 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Oct 13 05:11:37.762440 kubelet[1844]: I1013 05:11:37.762418 1844 server.go:479] "Adding debug handlers to kubelet server" Oct 13 05:11:37.763460 kubelet[1844]: I1013 05:11:37.763395 1844 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Oct 13 05:11:37.763711 kubelet[1844]: I1013 05:11:37.763690 1844 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Oct 13 05:11:37.765565 kubelet[1844]: I1013 05:11:37.765535 1844 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Oct 13 05:11:37.767902 kubelet[1844]: E1013 05:11:37.767422 1844 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.186df4e5ee9fe76b default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-10-13 05:11:37.759876971 +0000 UTC m=+1.201856121,LastTimestamp:2025-10-13 05:11:37.759876971 +0000 UTC m=+1.201856121,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Oct 13 05:11:37.768002 kubelet[1844]: W1013 05:11:37.767946 1844 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Oct 13 05:11:37.768002 kubelet[1844]: E1013 05:11:37.767971 1844 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Oct 13 05:11:37.768112 kubelet[1844]: I1013 05:11:37.768068 1844 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 13 05:11:37.768169 kubelet[1844]: W1013 05:11:37.768149 1844 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.124" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Oct 13 05:11:37.768300 kubelet[1844]: E1013 05:11:37.768249 1844 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.124\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Oct 13 05:11:37.768555 kubelet[1844]: E1013 05:11:37.768529 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:37.768626 kubelet[1844]: I1013 05:11:37.768610 1844 volume_manager.go:297] "Starting Kubelet Volume Manager" Oct 13 05:11:37.769160 kubelet[1844]: I1013 05:11:37.769142 1844 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Oct 13 05:11:37.770384 kubelet[1844]: I1013 05:11:37.769214 1844 reconciler.go:26] "Reconciler: start to sync state" Oct 13 05:11:37.770384 kubelet[1844]: E1013 05:11:37.770007 1844 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Oct 13 05:11:37.770384 kubelet[1844]: I1013 05:11:37.770132 1844 factory.go:221] Registration of the systemd container factory successfully Oct 13 05:11:37.770384 kubelet[1844]: I1013 05:11:37.770248 1844 factory.go:219] 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 13 05:11:37.770606 kubelet[1844]: E1013 05:11:37.770584 1844 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.124\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Oct 13 05:11:37.771001 kubelet[1844]: W1013 05:11:37.770982 1844 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Oct 13 05:11:37.771074 kubelet[1844]: E1013 05:11:37.771012 1844 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Oct 13 05:11:37.771617 kubelet[1844]: I1013 05:11:37.771597 1844 factory.go:221] Registration of the containerd container factory successfully Oct 13 05:11:37.779693 kubelet[1844]: I1013 05:11:37.779673 1844 cpu_manager.go:221] "Starting CPU manager" policy="none" Oct 13 05:11:37.779693 kubelet[1844]: I1013 05:11:37.779691 1844 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Oct 13 05:11:37.779772 kubelet[1844]: I1013 05:11:37.779710 1844 state_mem.go:36] "Initialized new in-memory state store" Oct 13 05:11:37.869711 kubelet[1844]: E1013 05:11:37.869665 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:37.969990 kubelet[1844]: E1013 05:11:37.969914 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:37.974782 kubelet[1844]: E1013 05:11:37.974733 1844 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.124\" not found" node="10.0.0.124" Oct 13 05:11:38.011362 kubelet[1844]: I1013 05:11:38.011045 1844 policy_none.go:49] "None policy: Start" Oct 13 05:11:38.011362 kubelet[1844]: I1013 05:11:38.011080 1844 memory_manager.go:186] "Starting memorymanager" policy="None" Oct 13 05:11:38.011362 kubelet[1844]: I1013 05:11:38.011099 1844 state_mem.go:35] "Initializing new in-memory state store" Oct 13 05:11:38.018712 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Oct 13 05:11:38.029162 kubelet[1844]: I1013 05:11:38.029122 1844 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Oct 13 05:11:38.030509 kubelet[1844]: I1013 05:11:38.030091 1844 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Oct 13 05:11:38.030509 kubelet[1844]: I1013 05:11:38.030118 1844 status_manager.go:227] "Starting to sync pod status with apiserver" Oct 13 05:11:38.030509 kubelet[1844]: I1013 05:11:38.030136 1844 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Oct 13 05:11:38.030509 kubelet[1844]: I1013 05:11:38.030143 1844 kubelet.go:2382] "Starting kubelet main sync loop" Oct 13 05:11:38.030509 kubelet[1844]: E1013 05:11:38.030183 1844 kubelet.go:2406] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Oct 13 05:11:38.030347 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Oct 13 05:11:38.035575 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Oct 13 05:11:38.044847 kubelet[1844]: I1013 05:11:38.044800 1844 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Oct 13 05:11:38.045028 kubelet[1844]: I1013 05:11:38.045004 1844 eviction_manager.go:189] "Eviction manager: starting control loop" Oct 13 05:11:38.045093 kubelet[1844]: I1013 05:11:38.045021 1844 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Oct 13 05:11:38.045422 kubelet[1844]: I1013 05:11:38.045398 1844 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Oct 13 05:11:38.046995 kubelet[1844]: E1013 05:11:38.046527 1844 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Oct 13 05:11:38.046995 kubelet[1844]: E1013 05:11:38.046564 1844 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.124\" not found" Oct 13 05:11:38.146400 kubelet[1844]: I1013 05:11:38.146359 1844 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.124" Oct 13 05:11:38.152080 kubelet[1844]: I1013 05:11:38.152011 1844 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.124" Oct 13 05:11:38.152322 kubelet[1844]: E1013 05:11:38.152044 1844 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.124\": node \"10.0.0.124\" not found" Oct 13 05:11:38.161596 kubelet[1844]: E1013 05:11:38.161553 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.261920 kubelet[1844]: E1013 05:11:38.261777 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.362245 kubelet[1844]: E1013 05:11:38.362201 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.462812 kubelet[1844]: E1013 05:11:38.462777 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.563498 kubelet[1844]: E1013 05:11:38.563393 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.574504 sudo[1716]: pam_unix(sudo:session): session closed for user root Oct 13 05:11:38.576491 sshd[1715]: Connection closed by 10.0.0.1 port 56504 Oct 13 05:11:38.576350 sshd-session[1712]: pam_unix(sshd:session): session closed for user core Oct 13 05:11:38.579962 systemd[1]: sshd@4-10.0.0.124:22-10.0.0.1:56504.service: Deactivated successfully. Oct 13 05:11:38.581612 systemd[1]: session-5.scope: Deactivated successfully. Oct 13 05:11:38.581779 systemd[1]: session-5.scope: Consumed 391ms CPU time, 75.9M memory peak. Oct 13 05:11:38.582680 systemd-logind[1540]: Session 5 logged out. Waiting for processes to exit. Oct 13 05:11:38.583695 systemd-logind[1540]: Removed session 5. Oct 13 05:11:38.664279 kubelet[1844]: E1013 05:11:38.664219 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.715850 kubelet[1844]: I1013 05:11:38.715785 1844 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Oct 13 05:11:38.716190 kubelet[1844]: W1013 05:11:38.715972 1844 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Oct 13 05:11:38.755361 kubelet[1844]: E1013 05:11:38.755309 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:38.764851 kubelet[1844]: E1013 05:11:38.764804 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.865636 kubelet[1844]: E1013 05:11:38.865536 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:38.966025 kubelet[1844]: E1013 05:11:38.965987 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:39.066465 kubelet[1844]: E1013 05:11:39.066431 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:39.167063 kubelet[1844]: E1013 05:11:39.166960 1844 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Oct 13 05:11:39.273171 kubelet[1844]: I1013 05:11:39.273147 1844 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Oct 13 05:11:39.273511 containerd[1559]: time="2025-10-13T05:11:39.273438891Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Oct 13 05:11:39.273945 kubelet[1844]: I1013 05:11:39.273926 1844 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Oct 13 05:11:39.756077 kubelet[1844]: E1013 05:11:39.756004 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:39.756077 kubelet[1844]: I1013 05:11:39.756043 1844 apiserver.go:52] "Watching apiserver" Oct 13 05:11:39.766524 systemd[1]: Created slice kubepods-burstable-pode48c98e3_3228_4972_96e3_799d347a25ce.slice - libcontainer container kubepods-burstable-pode48c98e3_3228_4972_96e3_799d347a25ce.slice. Oct 13 05:11:39.769747 kubelet[1844]: I1013 05:11:39.769697 1844 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Oct 13 05:11:39.779609 kubelet[1844]: I1013 05:11:39.779569 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/86efd3e5-fcab-42f1-ad5b-d99a446b84b8-kube-proxy\") pod \"kube-proxy-qpv5t\" (UID: \"86efd3e5-fcab-42f1-ad5b-d99a446b84b8\") " pod="kube-system/kube-proxy-qpv5t" Oct 13 05:11:39.779609 kubelet[1844]: I1013 05:11:39.779605 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/86efd3e5-fcab-42f1-ad5b-d99a446b84b8-xtables-lock\") pod \"kube-proxy-qpv5t\" (UID: \"86efd3e5-fcab-42f1-ad5b-d99a446b84b8\") " pod="kube-system/kube-proxy-qpv5t" Oct 13 05:11:39.779720 kubelet[1844]: I1013 05:11:39.779653 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5hdw7\" (UniqueName: \"kubernetes.io/projected/86efd3e5-fcab-42f1-ad5b-d99a446b84b8-kube-api-access-5hdw7\") pod \"kube-proxy-qpv5t\" (UID: \"86efd3e5-fcab-42f1-ad5b-d99a446b84b8\") " pod="kube-system/kube-proxy-qpv5t" Oct 13 05:11:39.779743 kubelet[1844]: I1013 05:11:39.779724 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/e48c98e3-3228-4972-96e3-799d347a25ce-flannel-cfg\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.779774 kubelet[1844]: I1013 05:11:39.779751 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/e48c98e3-3228-4972-96e3-799d347a25ce-xtables-lock\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.779774 kubelet[1844]: I1013 05:11:39.779769 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/e48c98e3-3228-4972-96e3-799d347a25ce-cni\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.779816 kubelet[1844]: I1013 05:11:39.779785 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zrqll\" (UniqueName: \"kubernetes.io/projected/e48c98e3-3228-4972-96e3-799d347a25ce-kube-api-access-zrqll\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.779816 kubelet[1844]: I1013 05:11:39.779805 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/86efd3e5-fcab-42f1-ad5b-d99a446b84b8-lib-modules\") pod \"kube-proxy-qpv5t\" (UID: \"86efd3e5-fcab-42f1-ad5b-d99a446b84b8\") " pod="kube-system/kube-proxy-qpv5t" Oct 13 05:11:39.779870 kubelet[1844]: I1013 05:11:39.779818 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/e48c98e3-3228-4972-96e3-799d347a25ce-run\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.779870 kubelet[1844]: I1013 05:11:39.779839 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/e48c98e3-3228-4972-96e3-799d347a25ce-cni-plugin\") pod \"kube-flannel-ds-482c6\" (UID: \"e48c98e3-3228-4972-96e3-799d347a25ce\") " pod="kube-flannel/kube-flannel-ds-482c6" Oct 13 05:11:39.787412 systemd[1]: Created slice kubepods-besteffort-pod86efd3e5_fcab_42f1_ad5b_d99a446b84b8.slice - libcontainer container kubepods-besteffort-pod86efd3e5_fcab_42f1_ad5b_d99a446b84b8.slice. Oct 13 05:11:40.084851 kubelet[1844]: E1013 05:11:40.084745 1844 dns.go:153] "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 13 05:11:40.085799 containerd[1559]: time="2025-10-13T05:11:40.085688651Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-482c6,Uid:e48c98e3-3228-4972-96e3-799d347a25ce,Namespace:kube-flannel,Attempt:0,}" Oct 13 05:11:40.110038 kubelet[1844]: E1013 05:11:40.109968 1844 dns.go:153] "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 13 05:11:40.121454 containerd[1559]: time="2025-10-13T05:11:40.121257451Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-qpv5t,Uid:86efd3e5-fcab-42f1-ad5b-d99a446b84b8,Namespace:kube-system,Attempt:0,}" Oct 13 05:11:40.563045 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount360646897.mount: Deactivated successfully. Oct 13 05:11:40.569857 containerd[1559]: time="2025-10-13T05:11:40.569806171Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 13 05:11:40.571816 containerd[1559]: time="2025-10-13T05:11:40.571782891Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=268705" Oct 13 05:11:40.573074 containerd[1559]: time="2025-10-13T05:11:40.573029851Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 13 05:11:40.574268 containerd[1559]: time="2025-10-13T05:11:40.574244931Z" level=info msg="ImageCreate event name:\"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 13 05:11:40.574316 containerd[1559]: time="2025-10-13T05:11:40.574277891Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Oct 13 05:11:40.580002 containerd[1559]: time="2025-10-13T05:11:40.579941531Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 13 05:11:40.581170 containerd[1559]: time="2025-10-13T05:11:40.581143491Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 487.48116ms" Oct 13 05:11:40.582426 containerd[1559]: time="2025-10-13T05:11:40.582400891Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 454.54616ms" Oct 13 05:11:40.598440 containerd[1559]: time="2025-10-13T05:11:40.598222291Z" level=info msg="connecting to shim eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3" address="unix:///run/containerd/s/cd8a72fed25d67506215281d2dd0f53050e6e24003e781e8bcb13a4eb11a75f5" namespace=k8s.io protocol=ttrpc version=3 Oct 13 05:11:40.598875 containerd[1559]: time="2025-10-13T05:11:40.598756251Z" level=info msg="connecting to shim 59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384" address="unix:///run/containerd/s/1693860e7e7ef1682e9dcaeb4fe8c457d4a9c252f287422b9142727164070be2" namespace=k8s.io protocol=ttrpc version=3 Oct 13 05:11:40.627213 systemd[1]: Started cri-containerd-59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384.scope - libcontainer container 59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384. Oct 13 05:11:40.628454 systemd[1]: Started cri-containerd-eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3.scope - libcontainer container eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3. Oct 13 05:11:40.657240 containerd[1559]: time="2025-10-13T05:11:40.657200331Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-qpv5t,Uid:86efd3e5-fcab-42f1-ad5b-d99a446b84b8,Namespace:kube-system,Attempt:0,} returns sandbox id \"eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3\"" Oct 13 05:11:40.658294 kubelet[1844]: E1013 05:11:40.658222 1844 dns.go:153] "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 13 05:11:40.659389 containerd[1559]: time="2025-10-13T05:11:40.659362491Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\"" Oct 13 05:11:40.664064 containerd[1559]: time="2025-10-13T05:11:40.664019531Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-482c6,Uid:e48c98e3-3228-4972-96e3-799d347a25ce,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\"" Oct 13 05:11:40.664555 kubelet[1844]: E1013 05:11:40.664538 1844 dns.go:153] "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 13 05:11:40.756500 kubelet[1844]: E1013 05:11:40.756460 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:41.601651 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3056944435.mount: Deactivated successfully. Oct 13 05:11:41.756601 kubelet[1844]: E1013 05:11:41.756562 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:41.820556 containerd[1559]: time="2025-10-13T05:11:41.820505091Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:41.821192 containerd[1559]: time="2025-10-13T05:11:41.821168411Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.9: active requests=0, bytes read=27417819" Oct 13 05:11:41.821781 containerd[1559]: time="2025-10-13T05:11:41.821744291Z" level=info msg="ImageCreate event name:\"sha256:72b57ec14d31e8422925ef4c3eff44822cdc04a11fd30d13824f1897d83a16d4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:41.823687 containerd[1559]: time="2025-10-13T05:11:41.823650211Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:41.824263 containerd[1559]: time="2025-10-13T05:11:41.824229091Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.32.9\" with image id \"sha256:72b57ec14d31e8422925ef4c3eff44822cdc04a11fd30d13824f1897d83a16d4\", repo tag \"registry.k8s.io/kube-proxy:v1.32.9\", repo digest \"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\", size \"27416836\" in 1.16483136s" Oct 13 05:11:41.824263 containerd[1559]: time="2025-10-13T05:11:41.824260851Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\" returns image reference \"sha256:72b57ec14d31e8422925ef4c3eff44822cdc04a11fd30d13824f1897d83a16d4\"" Oct 13 05:11:41.825680 containerd[1559]: time="2025-10-13T05:11:41.825487691Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Oct 13 05:11:41.826381 containerd[1559]: time="2025-10-13T05:11:41.826349971Z" level=info msg="CreateContainer within sandbox \"eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Oct 13 05:11:41.835613 containerd[1559]: time="2025-10-13T05:11:41.835575211Z" level=info msg="Container a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:41.842924 containerd[1559]: time="2025-10-13T05:11:41.842770371Z" level=info msg="CreateContainer within sandbox \"eda2e6712a36c408187eb8aa210a9e8e29d3c26062bd1a5721018481fa4ec3e3\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83\"" Oct 13 05:11:41.844075 containerd[1559]: time="2025-10-13T05:11:41.843610011Z" level=info msg="StartContainer for \"a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83\"" Oct 13 05:11:41.845493 containerd[1559]: time="2025-10-13T05:11:41.845466731Z" level=info msg="connecting to shim a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83" address="unix:///run/containerd/s/cd8a72fed25d67506215281d2dd0f53050e6e24003e781e8bcb13a4eb11a75f5" protocol=ttrpc version=3 Oct 13 05:11:41.865222 systemd[1]: Started cri-containerd-a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83.scope - libcontainer container a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83. Oct 13 05:11:41.896776 containerd[1559]: time="2025-10-13T05:11:41.896737211Z" level=info msg="StartContainer for \"a42304564bf3f576b42dfefc4cde88c0af568f3392543afcd429bba5c2d22c83\" returns successfully" Oct 13 05:11:42.042100 kubelet[1844]: E1013 05:11:42.042069 1844 dns.go:153] "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 13 05:11:42.051265 kubelet[1844]: I1013 05:11:42.051121 1844 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-qpv5t" podStartSLOduration=2.884778651 podStartE2EDuration="4.051042931s" podCreationTimestamp="2025-10-13 05:11:38 +0000 UTC" firstStartedPulling="2025-10-13 05:11:40.658990611 +0000 UTC m=+4.100969721" lastFinishedPulling="2025-10-13 05:11:41.825254851 +0000 UTC m=+5.267234001" observedRunningTime="2025-10-13 05:11:42.050402891 +0000 UTC m=+5.492382041" watchObservedRunningTime="2025-10-13 05:11:42.051042931 +0000 UTC m=+5.493022081" Oct 13 05:11:42.756870 kubelet[1844]: E1013 05:11:42.756805 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:42.877130 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2241206385.mount: Deactivated successfully. Oct 13 05:11:42.920425 containerd[1559]: time="2025-10-13T05:11:42.920380691Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:42.921293 containerd[1559]: time="2025-10-13T05:11:42.921108611Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532" Oct 13 05:11:42.922128 containerd[1559]: time="2025-10-13T05:11:42.922098411Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:42.923929 containerd[1559]: time="2025-10-13T05:11:42.923897011Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:42.924889 containerd[1559]: time="2025-10-13T05:11:42.924757131Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3662650\" in 1.09923824s" Oct 13 05:11:42.924889 containerd[1559]: time="2025-10-13T05:11:42.924790691Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Oct 13 05:11:42.927082 containerd[1559]: time="2025-10-13T05:11:42.926678451Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Oct 13 05:11:42.935165 containerd[1559]: time="2025-10-13T05:11:42.935126171Z" level=info msg="Container 6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:42.940596 containerd[1559]: time="2025-10-13T05:11:42.940563931Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\"" Oct 13 05:11:42.941028 containerd[1559]: time="2025-10-13T05:11:42.941011411Z" level=info msg="StartContainer for \"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\"" Oct 13 05:11:42.941713 containerd[1559]: time="2025-10-13T05:11:42.941669211Z" level=info msg="connecting to shim 6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427" address="unix:///run/containerd/s/1693860e7e7ef1682e9dcaeb4fe8c457d4a9c252f287422b9142727164070be2" protocol=ttrpc version=3 Oct 13 05:11:42.967244 systemd[1]: Started cri-containerd-6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427.scope - libcontainer container 6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427. Oct 13 05:11:42.989025 containerd[1559]: time="2025-10-13T05:11:42.988986011Z" level=info msg="StartContainer for \"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\" returns successfully" Oct 13 05:11:42.989330 systemd[1]: cri-containerd-6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427.scope: Deactivated successfully. Oct 13 05:11:42.992733 containerd[1559]: time="2025-10-13T05:11:42.992686731Z" level=info msg="received exit event container_id:\"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\" id:\"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\" pid:2183 exited_at:{seconds:1760332302 nanos:992236491}" Oct 13 05:11:42.992992 containerd[1559]: time="2025-10-13T05:11:42.992949611Z" level=info msg="TaskExit event in podsandbox handler container_id:\"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\" id:\"6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427\" pid:2183 exited_at:{seconds:1760332302 nanos:992236491}" Oct 13 05:11:43.008495 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-6a3a0de471e91d69af429af828ca76b6e2b8d3e44bfa660afd25b07c09f21427-rootfs.mount: Deactivated successfully. Oct 13 05:11:43.045252 kubelet[1844]: E1013 05:11:43.045212 1844 dns.go:153] "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 13 05:11:43.045467 kubelet[1844]: E1013 05:11:43.045385 1844 dns.go:153] "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 13 05:11:43.757074 kubelet[1844]: E1013 05:11:43.757010 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:44.048172 kubelet[1844]: E1013 05:11:44.048067 1844 dns.go:153] "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 13 05:11:44.048726 containerd[1559]: time="2025-10-13T05:11:44.048681771Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Oct 13 05:11:44.757996 kubelet[1844]: E1013 05:11:44.757954 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:45.314981 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3787326999.mount: Deactivated successfully. Oct 13 05:11:45.759155 kubelet[1844]: E1013 05:11:45.758913 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:45.770820 containerd[1559]: time="2025-10-13T05:11:45.770771131Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:45.771679 containerd[1559]: time="2025-10-13T05:11:45.771444651Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261" Oct 13 05:11:45.772422 containerd[1559]: time="2025-10-13T05:11:45.772387011Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:45.774985 containerd[1559]: time="2025-10-13T05:11:45.774958971Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:45.776132 containerd[1559]: time="2025-10-13T05:11:45.776009771Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26863435\" in 1.72729064s" Oct 13 05:11:45.776132 containerd[1559]: time="2025-10-13T05:11:45.776041331Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Oct 13 05:11:45.778113 containerd[1559]: time="2025-10-13T05:11:45.778029611Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Oct 13 05:11:45.784082 containerd[1559]: time="2025-10-13T05:11:45.783947891Z" level=info msg="Container 6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:45.790561 containerd[1559]: time="2025-10-13T05:11:45.790511371Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\"" Oct 13 05:11:45.791225 containerd[1559]: time="2025-10-13T05:11:45.791201011Z" level=info msg="StartContainer for \"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\"" Oct 13 05:11:45.791955 containerd[1559]: time="2025-10-13T05:11:45.791932411Z" level=info msg="connecting to shim 6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb" address="unix:///run/containerd/s/1693860e7e7ef1682e9dcaeb4fe8c457d4a9c252f287422b9142727164070be2" protocol=ttrpc version=3 Oct 13 05:11:45.815222 systemd[1]: Started cri-containerd-6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb.scope - libcontainer container 6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb. Oct 13 05:11:45.838907 systemd[1]: cri-containerd-6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb.scope: Deactivated successfully. Oct 13 05:11:45.839561 containerd[1559]: time="2025-10-13T05:11:45.839491211Z" level=info msg="TaskExit event in podsandbox handler container_id:\"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\" id:\"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\" pid:2257 exited_at:{seconds:1760332305 nanos:839166851}" Oct 13 05:11:45.840763 containerd[1559]: time="2025-10-13T05:11:45.840661091Z" level=info msg="received exit event container_id:\"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\" id:\"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\" pid:2257 exited_at:{seconds:1760332305 nanos:839166851}" Oct 13 05:11:45.841886 containerd[1559]: time="2025-10-13T05:11:45.841854651Z" level=info msg="StartContainer for \"6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb\" returns successfully" Oct 13 05:11:45.920596 kubelet[1844]: I1013 05:11:45.920379 1844 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Oct 13 05:11:46.052901 kubelet[1844]: E1013 05:11:46.052463 1844 dns.go:153] "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 13 05:11:46.054705 containerd[1559]: time="2025-10-13T05:11:46.054671891Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Oct 13 05:11:46.062007 containerd[1559]: time="2025-10-13T05:11:46.061431811Z" level=info msg="Container 3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:46.068694 containerd[1559]: time="2025-10-13T05:11:46.068655371Z" level=info msg="CreateContainer within sandbox \"59d572576f564205ce0ae4079bfa37f25f02ed4cc90b3e5e79137f917fa42384\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206\"" Oct 13 05:11:46.069348 containerd[1559]: time="2025-10-13T05:11:46.069255651Z" level=info msg="StartContainer for \"3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206\"" Oct 13 05:11:46.070312 containerd[1559]: time="2025-10-13T05:11:46.070286091Z" level=info msg="connecting to shim 3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206" address="unix:///run/containerd/s/1693860e7e7ef1682e9dcaeb4fe8c457d4a9c252f287422b9142727164070be2" protocol=ttrpc version=3 Oct 13 05:11:46.093267 systemd[1]: Started cri-containerd-3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206.scope - libcontainer container 3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206. Oct 13 05:11:46.119030 containerd[1559]: time="2025-10-13T05:11:46.118969731Z" level=info msg="StartContainer for \"3433c2ae54938d7be73a13ebee0a515ea551430baa79261feea22493aa5a1206\" returns successfully" Oct 13 05:11:46.220740 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-6ac2132c206d740941263e537757990f0d9f3027cab6ed63cd30ad6c73bb90eb-rootfs.mount: Deactivated successfully. Oct 13 05:11:46.759435 kubelet[1844]: E1013 05:11:46.759389 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:47.056771 kubelet[1844]: E1013 05:11:47.056563 1844 dns.go:153] "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 13 05:11:47.070438 kubelet[1844]: I1013 05:11:47.070391 1844 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-482c6" podStartSLOduration=3.958923971 podStartE2EDuration="9.070373451s" podCreationTimestamp="2025-10-13 05:11:38 +0000 UTC" firstStartedPulling="2025-10-13 05:11:40.665340611 +0000 UTC m=+4.107319761" lastFinishedPulling="2025-10-13 05:11:45.776790091 +0000 UTC m=+9.218769241" observedRunningTime="2025-10-13 05:11:47.070081891 +0000 UTC m=+10.512061041" watchObservedRunningTime="2025-10-13 05:11:47.070373451 +0000 UTC m=+10.512352601" Oct 13 05:11:47.175671 systemd-networkd[1470]: flannel.1: Link UP Oct 13 05:11:47.175677 systemd-networkd[1470]: flannel.1: Gained carrier Oct 13 05:11:47.759599 kubelet[1844]: E1013 05:11:47.759548 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:48.057938 kubelet[1844]: E1013 05:11:48.057854 1844 dns.go:153] "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 13 05:11:48.465323 systemd-networkd[1470]: flannel.1: Gained IPv6LL Oct 13 05:11:48.759908 kubelet[1844]: E1013 05:11:48.759692 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:49.553604 systemd[1]: Created slice kubepods-besteffort-podb20f44ab_3a99_4375_8c23_0d049aaa93a8.slice - libcontainer container kubepods-besteffort-podb20f44ab_3a99_4375_8c23_0d049aaa93a8.slice. Oct 13 05:11:49.646195 kubelet[1844]: I1013 05:11:49.646139 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-24kw7\" (UniqueName: \"kubernetes.io/projected/b20f44ab-3a99-4375-8c23-0d049aaa93a8-kube-api-access-24kw7\") pod \"nginx-deployment-7fcdb87857-gzrg5\" (UID: \"b20f44ab-3a99-4375-8c23-0d049aaa93a8\") " pod="default/nginx-deployment-7fcdb87857-gzrg5" Oct 13 05:11:49.760397 kubelet[1844]: E1013 05:11:49.760352 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:49.859168 containerd[1559]: time="2025-10-13T05:11:49.858850171Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-gzrg5,Uid:b20f44ab-3a99-4375-8c23-0d049aaa93a8,Namespace:default,Attempt:0,}" Oct 13 05:11:49.868858 systemd-networkd[1470]: cni0: Link UP Oct 13 05:11:49.868865 systemd-networkd[1470]: cni0: Gained carrier Oct 13 05:11:49.869438 systemd-networkd[1470]: cni0: Lost carrier Oct 13 05:11:49.873547 systemd-networkd[1470]: veth3acd247e: Link UP Oct 13 05:11:49.876574 kernel: cni0: port 1(veth3acd247e) entered blocking state Oct 13 05:11:49.876628 kernel: cni0: port 1(veth3acd247e) entered disabled state Oct 13 05:11:49.876650 kernel: veth3acd247e: entered allmulticast mode Oct 13 05:11:49.876665 kernel: veth3acd247e: entered promiscuous mode Oct 13 05:11:49.884137 kernel: cni0: port 1(veth3acd247e) entered blocking state Oct 13 05:11:49.884198 kernel: cni0: port 1(veth3acd247e) entered forwarding state Oct 13 05:11:49.884108 systemd-networkd[1470]: veth3acd247e: Gained carrier Oct 13 05:11:49.884558 systemd-networkd[1470]: cni0: Gained carrier Oct 13 05:11:49.886215 containerd[1559]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000014938), "name":"cbr0", "type":"bridge"} Oct 13 05:11:49.886215 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Oct 13 05:11:49.910897 containerd[1559]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-10-13T05:11:49.910569531Z" level=info msg="connecting to shim 4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42" address="unix:///run/containerd/s/f1c5a93bdb30b0852c63755d5b4e84d54c6278371d567e7dafa27b608cb473be" namespace=k8s.io protocol=ttrpc version=3 Oct 13 05:11:49.933196 systemd[1]: Started cri-containerd-4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42.scope - libcontainer container 4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42. Oct 13 05:11:49.942900 systemd-resolved[1275]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 13 05:11:49.961631 containerd[1559]: time="2025-10-13T05:11:49.961593891Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-gzrg5,Uid:b20f44ab-3a99-4375-8c23-0d049aaa93a8,Namespace:default,Attempt:0,} returns sandbox id \"4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42\"" Oct 13 05:11:49.962958 containerd[1559]: time="2025-10-13T05:11:49.962930931Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 13 05:11:50.761096 kubelet[1844]: E1013 05:11:50.761027 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:51.026232 systemd-networkd[1470]: veth3acd247e: Gained IPv6LL Oct 13 05:11:51.218191 systemd-networkd[1470]: cni0: Gained IPv6LL Oct 13 05:11:51.647425 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount268020607.mount: Deactivated successfully. Oct 13 05:11:51.761925 kubelet[1844]: E1013 05:11:51.761883 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:52.333667 containerd[1559]: time="2025-10-13T05:11:52.333620051Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:52.334754 containerd[1559]: time="2025-10-13T05:11:52.334034531Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=70015687" Oct 13 05:11:52.335127 containerd[1559]: time="2025-10-13T05:11:52.335087851Z" level=info msg="ImageCreate event name:\"sha256:e1e3942d93b7c9e68a5e902395859d4f53de5aa9a187cba800c72cee6f9cb03f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:52.337589 containerd[1559]: time="2025-10-13T05:11:52.337564331Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:0c4ba30a5f6a65d2bbdf93f2eff51d5304fd8c7f92cfc83a135a226aa2cd96af\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:52.339401 containerd[1559]: time="2025-10-13T05:11:52.339311131Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e1e3942d93b7c9e68a5e902395859d4f53de5aa9a187cba800c72cee6f9cb03f\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0c4ba30a5f6a65d2bbdf93f2eff51d5304fd8c7f92cfc83a135a226aa2cd96af\", size \"70015565\" in 2.3762862s" Oct 13 05:11:52.339401 containerd[1559]: time="2025-10-13T05:11:52.339348971Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e1e3942d93b7c9e68a5e902395859d4f53de5aa9a187cba800c72cee6f9cb03f\"" Oct 13 05:11:52.341157 containerd[1559]: time="2025-10-13T05:11:52.341128011Z" level=info msg="CreateContainer within sandbox \"4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Oct 13 05:11:52.352187 containerd[1559]: time="2025-10-13T05:11:52.352066971Z" level=info msg="Container 8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:52.359267 containerd[1559]: time="2025-10-13T05:11:52.359186771Z" level=info msg="CreateContainer within sandbox \"4fef5eaff82075c1d4e391d33cfcdebade26487edef9c83bb3c0e03ae1284b42\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7\"" Oct 13 05:11:52.360180 containerd[1559]: time="2025-10-13T05:11:52.359776051Z" level=info msg="StartContainer for \"8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7\"" Oct 13 05:11:52.360896 containerd[1559]: time="2025-10-13T05:11:52.360871091Z" level=info msg="connecting to shim 8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7" address="unix:///run/containerd/s/f1c5a93bdb30b0852c63755d5b4e84d54c6278371d567e7dafa27b608cb473be" protocol=ttrpc version=3 Oct 13 05:11:52.388257 systemd[1]: Started cri-containerd-8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7.scope - libcontainer container 8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7. Oct 13 05:11:52.411829 containerd[1559]: time="2025-10-13T05:11:52.411767611Z" level=info msg="StartContainer for \"8cc401e51a78e2f491ac4968487e68792670f62d0b3080fc50c2bcf2fd0a79b7\" returns successfully" Oct 13 05:11:52.762920 kubelet[1844]: E1013 05:11:52.762803 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:53.763959 kubelet[1844]: E1013 05:11:53.763913 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:54.764828 kubelet[1844]: E1013 05:11:54.764757 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:55.765166 kubelet[1844]: E1013 05:11:55.765099 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:55.825428 kubelet[1844]: I1013 05:11:55.825371 1844 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-gzrg5" podStartSLOduration=4.447848211 podStartE2EDuration="6.825352771s" podCreationTimestamp="2025-10-13 05:11:49 +0000 UTC" firstStartedPulling="2025-10-13 05:11:49.962486891 +0000 UTC m=+13.404466041" lastFinishedPulling="2025-10-13 05:11:52.339991451 +0000 UTC m=+15.781970601" observedRunningTime="2025-10-13 05:11:53.076886131 +0000 UTC m=+16.518865281" watchObservedRunningTime="2025-10-13 05:11:55.825352771 +0000 UTC m=+19.267331921" Oct 13 05:11:55.831200 systemd[1]: Created slice kubepods-besteffort-pod68289a3c_e3eb_4313_aba3_24dc643fe5a4.slice - libcontainer container kubepods-besteffort-pod68289a3c_e3eb_4313_aba3_24dc643fe5a4.slice. Oct 13 05:11:55.881474 kubelet[1844]: I1013 05:11:55.881411 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/68289a3c-e3eb-4313-aba3-24dc643fe5a4-data\") pod \"nfs-server-provisioner-0\" (UID: \"68289a3c-e3eb-4313-aba3-24dc643fe5a4\") " pod="default/nfs-server-provisioner-0" Oct 13 05:11:55.881474 kubelet[1844]: I1013 05:11:55.881457 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hx67g\" (UniqueName: \"kubernetes.io/projected/68289a3c-e3eb-4313-aba3-24dc643fe5a4-kube-api-access-hx67g\") pod \"nfs-server-provisioner-0\" (UID: \"68289a3c-e3eb-4313-aba3-24dc643fe5a4\") " pod="default/nfs-server-provisioner-0" Oct 13 05:11:56.135765 containerd[1559]: time="2025-10-13T05:11:56.135467611Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:68289a3c-e3eb-4313-aba3-24dc643fe5a4,Namespace:default,Attempt:0,}" Oct 13 05:11:56.144598 systemd-networkd[1470]: veth9d813d1f: Link UP Oct 13 05:11:56.148132 kernel: cni0: port 2(veth9d813d1f) entered blocking state Oct 13 05:11:56.148194 kernel: cni0: port 2(veth9d813d1f) entered disabled state Oct 13 05:11:56.148209 kernel: veth9d813d1f: entered allmulticast mode Oct 13 05:11:56.149083 kernel: veth9d813d1f: entered promiscuous mode Oct 13 05:11:56.155106 kernel: cni0: port 2(veth9d813d1f) entered blocking state Oct 13 05:11:56.155314 kernel: cni0: port 2(veth9d813d1f) entered forwarding state Oct 13 05:11:56.155149 systemd-networkd[1470]: veth9d813d1f: Gained carrier Oct 13 05:11:56.157028 containerd[1559]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000014938), "name":"cbr0", "type":"bridge"} Oct 13 05:11:56.157028 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Oct 13 05:11:56.177524 containerd[1559]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-10-13T05:11:56.177474171Z" level=info msg="connecting to shim eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49" address="unix:///run/containerd/s/e14b04c675a43c37cf804bd13b61ce1b0c654f480445c1f39ceb2aad60402c74" namespace=k8s.io protocol=ttrpc version=3 Oct 13 05:11:56.202238 systemd[1]: Started cri-containerd-eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49.scope - libcontainer container eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49. Oct 13 05:11:56.217173 systemd-resolved[1275]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 13 05:11:56.242235 containerd[1559]: time="2025-10-13T05:11:56.242191931Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:68289a3c-e3eb-4313-aba3-24dc643fe5a4,Namespace:default,Attempt:0,} returns sandbox id \"eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49\"" Oct 13 05:11:56.243784 containerd[1559]: time="2025-10-13T05:11:56.243732531Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Oct 13 05:11:56.766267 kubelet[1844]: E1013 05:11:56.766219 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:57.755952 kubelet[1844]: E1013 05:11:57.755658 1844 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:57.767201 kubelet[1844]: E1013 05:11:57.767135 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:57.900141 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount210848369.mount: Deactivated successfully. Oct 13 05:11:57.937244 systemd-networkd[1470]: veth9d813d1f: Gained IPv6LL Oct 13 05:11:58.767490 kubelet[1844]: E1013 05:11:58.767455 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:11:59.416779 containerd[1559]: time="2025-10-13T05:11:59.416712051Z" 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 13 05:11:59.417228 containerd[1559]: time="2025-10-13T05:11:59.417180371Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625" Oct 13 05:11:59.418100 containerd[1559]: time="2025-10-13T05:11:59.418048851Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:59.421186 containerd[1559]: time="2025-10-13T05:11:59.421144971Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:11:59.422421 containerd[1559]: time="2025-10-13T05:11:59.422383491Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 3.17861788s" Oct 13 05:11:59.422421 containerd[1559]: time="2025-10-13T05:11:59.422416051Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Oct 13 05:11:59.424279 containerd[1559]: time="2025-10-13T05:11:59.424248411Z" level=info msg="CreateContainer within sandbox \"eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Oct 13 05:11:59.432603 containerd[1559]: time="2025-10-13T05:11:59.432557611Z" level=info msg="Container 235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:11:59.443764 containerd[1559]: time="2025-10-13T05:11:59.443717091Z" level=info msg="CreateContainer within sandbox \"eaca8714e7362c380b5c957e91b33b76fb8e4739f870f75d361b01c186fa3d49\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228\"" Oct 13 05:11:59.444296 containerd[1559]: time="2025-10-13T05:11:59.444271651Z" level=info msg="StartContainer for \"235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228\"" Oct 13 05:11:59.445258 containerd[1559]: time="2025-10-13T05:11:59.445232531Z" level=info msg="connecting to shim 235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228" address="unix:///run/containerd/s/e14b04c675a43c37cf804bd13b61ce1b0c654f480445c1f39ceb2aad60402c74" protocol=ttrpc version=3 Oct 13 05:11:59.472226 systemd[1]: Started cri-containerd-235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228.scope - libcontainer container 235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228. Oct 13 05:11:59.495982 containerd[1559]: time="2025-10-13T05:11:59.495921371Z" level=info msg="StartContainer for \"235789e3f00d1ddf83d99f68e318a7ab124137bf753eb8be9852d507f07bb228\" returns successfully" Oct 13 05:11:59.768619 kubelet[1844]: E1013 05:11:59.768501 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:00.769496 kubelet[1844]: E1013 05:12:00.769451 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:01.770372 kubelet[1844]: E1013 05:12:01.770320 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:02.770727 kubelet[1844]: E1013 05:12:02.770685 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:03.771285 kubelet[1844]: E1013 05:12:03.771232 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:04.772044 kubelet[1844]: E1013 05:12:04.771991 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:05.773174 kubelet[1844]: E1013 05:12:05.773122 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:06.773690 kubelet[1844]: E1013 05:12:06.773650 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:07.775105 kubelet[1844]: E1013 05:12:07.775038 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:08.776068 kubelet[1844]: E1013 05:12:08.775977 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:09.499164 kubelet[1844]: I1013 05:12:09.499026 1844 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=11.319385724 podStartE2EDuration="14.499006404s" podCreationTimestamp="2025-10-13 05:11:55 +0000 UTC" firstStartedPulling="2025-10-13 05:11:56.243474811 +0000 UTC m=+19.685453961" lastFinishedPulling="2025-10-13 05:11:59.423095531 +0000 UTC m=+22.865074641" observedRunningTime="2025-10-13 05:12:00.106024851 +0000 UTC m=+23.548004001" watchObservedRunningTime="2025-10-13 05:12:09.499006404 +0000 UTC m=+32.940985514" Oct 13 05:12:09.505929 systemd[1]: Created slice kubepods-besteffort-pod02b84ba9_6a76_4da5_b7cf_b7679eed263e.slice - libcontainer container kubepods-besteffort-pod02b84ba9_6a76_4da5_b7cf_b7679eed263e.slice. Oct 13 05:12:09.561515 kubelet[1844]: I1013 05:12:09.561435 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-jkwjw\" (UniqueName: \"kubernetes.io/projected/02b84ba9-6a76-4da5-b7cf-b7679eed263e-kube-api-access-jkwjw\") pod \"test-pod-1\" (UID: \"02b84ba9-6a76-4da5-b7cf-b7679eed263e\") " pod="default/test-pod-1" Oct 13 05:12:09.561515 kubelet[1844]: I1013 05:12:09.561480 1844 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-a8d3fdf4-23dd-4c61-9151-fab21021018f\" (UniqueName: \"kubernetes.io/nfs/02b84ba9-6a76-4da5-b7cf-b7679eed263e-pvc-a8d3fdf4-23dd-4c61-9151-fab21021018f\") pod \"test-pod-1\" (UID: \"02b84ba9-6a76-4da5-b7cf-b7679eed263e\") " pod="default/test-pod-1" Oct 13 05:12:09.682113 kernel: netfs: FS-Cache loaded Oct 13 05:12:09.707511 kernel: RPC: Registered named UNIX socket transport module. Oct 13 05:12:09.707622 kernel: RPC: Registered udp transport module. Oct 13 05:12:09.707639 kernel: RPC: Registered tcp transport module. Oct 13 05:12:09.707655 kernel: RPC: Registered tcp-with-tls transport module. Oct 13 05:12:09.707670 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 13 05:12:09.777043 kubelet[1844]: E1013 05:12:09.776539 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:09.886583 kernel: NFS: Registering the id_resolver key type Oct 13 05:12:09.886709 kernel: Key type id_resolver registered Oct 13 05:12:09.886754 kernel: Key type id_legacy registered Oct 13 05:12:09.905625 nfsidmap[2865]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Oct 13 05:12:09.906341 nfsidmap[2865]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 13 05:12:09.909464 nfsidmap[2868]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Oct 13 05:12:09.909628 nfsidmap[2868]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 13 05:12:09.920494 nfsrahead[2872]: setting /var/lib/kubelet/pods/02b84ba9-6a76-4da5-b7cf-b7679eed263e/volumes/kubernetes.io~nfs/pvc-a8d3fdf4-23dd-4c61-9151-fab21021018f readahead to 128 Oct 13 05:12:10.115112 containerd[1559]: time="2025-10-13T05:12:10.114475019Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:02b84ba9-6a76-4da5-b7cf-b7679eed263e,Namespace:default,Attempt:0,}" Oct 13 05:12:10.122250 systemd-networkd[1470]: veth373688b0: Link UP Oct 13 05:12:10.123486 kernel: cni0: port 3(veth373688b0) entered blocking state Oct 13 05:12:10.123525 kernel: cni0: port 3(veth373688b0) entered disabled state Oct 13 05:12:10.124076 kernel: veth373688b0: entered allmulticast mode Oct 13 05:12:10.125071 kernel: veth373688b0: entered promiscuous mode Oct 13 05:12:10.128879 systemd-networkd[1470]: veth373688b0: Gained carrier Oct 13 05:12:10.129120 kernel: cni0: port 3(veth373688b0) entered blocking state Oct 13 05:12:10.129138 kernel: cni0: port 3(veth373688b0) entered forwarding state Oct 13 05:12:10.130610 containerd[1559]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400001c938), "name":"cbr0", "type":"bridge"} Oct 13 05:12:10.130610 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Oct 13 05:12:10.152983 containerd[1559]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-10-13T05:12:10.152936040Z" level=info msg="connecting to shim 64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40" address="unix:///run/containerd/s/a5b5cf028b7bfd50585ce0921af7d34aebcd8638768c092b009faa154187b04d" namespace=k8s.io protocol=ttrpc version=3 Oct 13 05:12:10.178210 systemd[1]: Started cri-containerd-64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40.scope - libcontainer container 64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40. Oct 13 05:12:10.189090 systemd-resolved[1275]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 13 05:12:10.207150 containerd[1559]: time="2025-10-13T05:12:10.207111398Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:02b84ba9-6a76-4da5-b7cf-b7679eed263e,Namespace:default,Attempt:0,} returns sandbox id \"64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40\"" Oct 13 05:12:10.208420 containerd[1559]: time="2025-10-13T05:12:10.208376562Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 13 05:12:10.511289 containerd[1559]: time="2025-10-13T05:12:10.511236229Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 13 05:12:10.512870 containerd[1559]: time="2025-10-13T05:12:10.512839075Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Oct 13 05:12:10.522199 containerd[1559]: time="2025-10-13T05:12:10.522092989Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e1e3942d93b7c9e68a5e902395859d4f53de5aa9a187cba800c72cee6f9cb03f\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0c4ba30a5f6a65d2bbdf93f2eff51d5304fd8c7f92cfc83a135a226aa2cd96af\", size \"70015565\" in 313.677947ms" Oct 13 05:12:10.522199 containerd[1559]: time="2025-10-13T05:12:10.522127189Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e1e3942d93b7c9e68a5e902395859d4f53de5aa9a187cba800c72cee6f9cb03f\"" Oct 13 05:12:10.526443 containerd[1559]: time="2025-10-13T05:12:10.526410764Z" level=info msg="CreateContainer within sandbox \"64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40\" for container &ContainerMetadata{Name:test,Attempt:0,}" Oct 13 05:12:10.532568 containerd[1559]: time="2025-10-13T05:12:10.532531387Z" level=info msg="Container 0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2: CDI devices from CRI Config.CDIDevices: []" Oct 13 05:12:10.538111 containerd[1559]: time="2025-10-13T05:12:10.538072087Z" level=info msg="CreateContainer within sandbox \"64a52171e68d1befda07ce3a9d24854b16433e3596cee8f00724b52a3c4d3c40\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2\"" Oct 13 05:12:10.538668 containerd[1559]: time="2025-10-13T05:12:10.538644809Z" level=info msg="StartContainer for \"0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2\"" Oct 13 05:12:10.539510 containerd[1559]: time="2025-10-13T05:12:10.539483772Z" level=info msg="connecting to shim 0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2" address="unix:///run/containerd/s/a5b5cf028b7bfd50585ce0921af7d34aebcd8638768c092b009faa154187b04d" protocol=ttrpc version=3 Oct 13 05:12:10.571245 systemd[1]: Started cri-containerd-0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2.scope - libcontainer container 0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2. Oct 13 05:12:10.598204 containerd[1559]: time="2025-10-13T05:12:10.598132547Z" level=info msg="StartContainer for \"0b6fb246256bb9e7661f7ea3c0b711360b4be89f332891f8f74e5f28a865bda2\" returns successfully" Oct 13 05:12:10.777596 kubelet[1844]: E1013 05:12:10.777479 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:11.761216 systemd-networkd[1470]: veth373688b0: Gained IPv6LL Oct 13 05:12:11.777598 kubelet[1844]: E1013 05:12:11.777555 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:12.777827 kubelet[1844]: E1013 05:12:12.777781 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 13 05:12:13.778462 kubelet[1844]: E1013 05:12:13.778402 1844 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"