Jun 21 02:24:45.808112 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jun 21 02:24:45.808132 kernel: Linux version 6.12.34-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Sat Jun 21 00:00:47 -00 2025 Jun 21 02:24:45.808142 kernel: KASLR enabled Jun 21 02:24:45.808148 kernel: efi: EFI v2.7 by EDK II Jun 21 02:24:45.808154 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb21fd18 Jun 21 02:24:45.808159 kernel: random: crng init done Jun 21 02:24:45.808166 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Jun 21 02:24:45.808172 kernel: secureboot: Secure boot enabled Jun 21 02:24:45.808178 kernel: ACPI: Early table checksum verification disabled Jun 21 02:24:45.808185 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Jun 21 02:24:45.808191 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jun 21 02:24:45.808196 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808202 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808208 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808215 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808223 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808229 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808235 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808241 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808248 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 02:24:45.808254 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jun 21 02:24:45.808260 kernel: ACPI: Use ACPI SPCR as default console: Yes Jun 21 02:24:45.808266 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jun 21 02:24:45.808272 kernel: NODE_DATA(0) allocated [mem 0xdc736a00-0xdc73dfff] Jun 21 02:24:45.808278 kernel: Zone ranges: Jun 21 02:24:45.808286 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jun 21 02:24:45.808292 kernel: DMA32 empty Jun 21 02:24:45.808298 kernel: Normal empty Jun 21 02:24:45.808303 kernel: Device empty Jun 21 02:24:45.808309 kernel: Movable zone start for each node Jun 21 02:24:45.808315 kernel: Early memory node ranges Jun 21 02:24:45.808322 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Jun 21 02:24:45.808328 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Jun 21 02:24:45.808334 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Jun 21 02:24:45.808340 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Jun 21 02:24:45.808346 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Jun 21 02:24:45.808352 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Jun 21 02:24:45.808359 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Jun 21 02:24:45.808365 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Jun 21 02:24:45.808372 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jun 21 02:24:45.808380 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jun 21 02:24:45.808387 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jun 21 02:24:45.808393 kernel: cma: Reserved 16 MiB at 0x00000000d7a00000 on node -1 Jun 21 02:24:45.808400 kernel: psci: probing for conduit method from ACPI. Jun 21 02:24:45.808407 kernel: psci: PSCIv1.1 detected in firmware. Jun 21 02:24:45.808414 kernel: psci: Using standard PSCI v0.2 function IDs Jun 21 02:24:45.808420 kernel: psci: Trusted OS migration not required Jun 21 02:24:45.808426 kernel: psci: SMC Calling Convention v1.1 Jun 21 02:24:45.808433 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jun 21 02:24:45.808439 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jun 21 02:24:45.808446 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jun 21 02:24:45.808452 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jun 21 02:24:45.808459 kernel: Detected PIPT I-cache on CPU0 Jun 21 02:24:45.808466 kernel: CPU features: detected: GIC system register CPU interface Jun 21 02:24:45.808473 kernel: CPU features: detected: Spectre-v4 Jun 21 02:24:45.808479 kernel: CPU features: detected: Spectre-BHB Jun 21 02:24:45.808486 kernel: CPU features: kernel page table isolation forced ON by KASLR Jun 21 02:24:45.808492 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jun 21 02:24:45.808499 kernel: CPU features: detected: ARM erratum 1418040 Jun 21 02:24:45.808505 kernel: CPU features: detected: SSBS not fully self-synchronizing Jun 21 02:24:45.808511 kernel: alternatives: applying boot alternatives Jun 21 02:24:45.808519 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=cb99487be08e9decec94bac26681ba79a4365c210ec86e0c6fe47991cb7f77db Jun 21 02:24:45.808526 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jun 21 02:24:45.808532 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 21 02:24:45.808541 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 21 02:24:45.808548 kernel: Fallback order for Node 0: 0 Jun 21 02:24:45.808554 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Jun 21 02:24:45.808561 kernel: Policy zone: DMA Jun 21 02:24:45.808567 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 21 02:24:45.808573 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Jun 21 02:24:45.808580 kernel: software IO TLB: area num 4. Jun 21 02:24:45.808586 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Jun 21 02:24:45.808593 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Jun 21 02:24:45.808600 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 21 02:24:45.808606 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 21 02:24:45.808613 kernel: rcu: RCU event tracing is enabled. Jun 21 02:24:45.808621 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jun 21 02:24:45.808628 kernel: Trampoline variant of Tasks RCU enabled. Jun 21 02:24:45.808635 kernel: Tracing variant of Tasks RCU enabled. Jun 21 02:24:45.808649 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 21 02:24:45.808665 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 21 02:24:45.808672 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 02:24:45.808679 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 02:24:45.808685 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jun 21 02:24:45.808691 kernel: GICv3: 256 SPIs implemented Jun 21 02:24:45.808698 kernel: GICv3: 0 Extended SPIs implemented Jun 21 02:24:45.808704 kernel: Root IRQ handler: gic_handle_irq Jun 21 02:24:45.808713 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jun 21 02:24:45.808719 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Jun 21 02:24:45.808726 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jun 21 02:24:45.808736 kernel: ITS [mem 0x08080000-0x0809ffff] Jun 21 02:24:45.808743 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Jun 21 02:24:45.808750 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Jun 21 02:24:45.808756 kernel: GICv3: using LPI property table @0x00000000400f0000 Jun 21 02:24:45.808763 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040110000 Jun 21 02:24:45.808770 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 21 02:24:45.808776 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jun 21 02:24:45.808783 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jun 21 02:24:45.808789 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jun 21 02:24:45.808798 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jun 21 02:24:45.808805 kernel: arm-pv: using stolen time PV Jun 21 02:24:45.808812 kernel: Console: colour dummy device 80x25 Jun 21 02:24:45.808818 kernel: ACPI: Core revision 20240827 Jun 21 02:24:45.808825 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jun 21 02:24:45.808832 kernel: pid_max: default: 32768 minimum: 301 Jun 21 02:24:45.808839 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jun 21 02:24:45.808846 kernel: landlock: Up and running. Jun 21 02:24:45.808853 kernel: SELinux: Initializing. Jun 21 02:24:45.808861 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 02:24:45.808870 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 02:24:45.808877 kernel: rcu: Hierarchical SRCU implementation. Jun 21 02:24:45.808884 kernel: rcu: Max phase no-delay instances is 400. Jun 21 02:24:45.808891 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jun 21 02:24:45.808897 kernel: Remapping and enabling EFI services. Jun 21 02:24:45.808904 kernel: smp: Bringing up secondary CPUs ... Jun 21 02:24:45.808911 kernel: Detected PIPT I-cache on CPU1 Jun 21 02:24:45.808917 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jun 21 02:24:45.808924 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040120000 Jun 21 02:24:45.808937 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jun 21 02:24:45.808944 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jun 21 02:24:45.808952 kernel: Detected PIPT I-cache on CPU2 Jun 21 02:24:45.808959 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jun 21 02:24:45.808966 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040130000 Jun 21 02:24:45.808973 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jun 21 02:24:45.808980 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jun 21 02:24:45.808987 kernel: Detected PIPT I-cache on CPU3 Jun 21 02:24:45.808996 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jun 21 02:24:45.809003 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040140000 Jun 21 02:24:45.809010 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jun 21 02:24:45.809017 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jun 21 02:24:45.809024 kernel: smp: Brought up 1 node, 4 CPUs Jun 21 02:24:45.809031 kernel: SMP: Total of 4 processors activated. Jun 21 02:24:45.809038 kernel: CPU: All CPU(s) started at EL1 Jun 21 02:24:45.809045 kernel: CPU features: detected: 32-bit EL0 Support Jun 21 02:24:45.809052 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jun 21 02:24:45.809061 kernel: CPU features: detected: Common not Private translations Jun 21 02:24:45.809068 kernel: CPU features: detected: CRC32 instructions Jun 21 02:24:45.809075 kernel: CPU features: detected: Enhanced Virtualization Traps Jun 21 02:24:45.809082 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jun 21 02:24:45.809089 kernel: CPU features: detected: LSE atomic instructions Jun 21 02:24:45.809096 kernel: CPU features: detected: Privileged Access Never Jun 21 02:24:45.809103 kernel: CPU features: detected: RAS Extension Support Jun 21 02:24:45.809110 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jun 21 02:24:45.809118 kernel: alternatives: applying system-wide alternatives Jun 21 02:24:45.809126 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Jun 21 02:24:45.809134 kernel: Memory: 2422296K/2572288K available (11136K kernel code, 2284K rwdata, 8980K rodata, 39488K init, 1037K bss, 127840K reserved, 16384K cma-reserved) Jun 21 02:24:45.809141 kernel: devtmpfs: initialized Jun 21 02:24:45.809148 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 21 02:24:45.809155 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 21 02:24:45.809162 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jun 21 02:24:45.809169 kernel: 0 pages in range for non-PLT usage Jun 21 02:24:45.809176 kernel: 508496 pages in range for PLT usage Jun 21 02:24:45.809183 kernel: pinctrl core: initialized pinctrl subsystem Jun 21 02:24:45.809191 kernel: SMBIOS 3.0.0 present. Jun 21 02:24:45.809198 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jun 21 02:24:45.809205 kernel: DMI: Memory slots populated: 1/1 Jun 21 02:24:45.809212 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 21 02:24:45.809219 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jun 21 02:24:45.809226 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jun 21 02:24:45.809233 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jun 21 02:24:45.809241 kernel: audit: initializing netlink subsys (disabled) Jun 21 02:24:45.809248 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Jun 21 02:24:45.809256 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 21 02:24:45.809263 kernel: cpuidle: using governor menu Jun 21 02:24:45.809270 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jun 21 02:24:45.809277 kernel: ASID allocator initialised with 32768 entries Jun 21 02:24:45.809284 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 21 02:24:45.809291 kernel: Serial: AMBA PL011 UART driver Jun 21 02:24:45.809298 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 21 02:24:45.809305 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jun 21 02:24:45.809312 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jun 21 02:24:45.809321 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jun 21 02:24:45.809327 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 21 02:24:45.809335 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jun 21 02:24:45.809342 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jun 21 02:24:45.809348 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jun 21 02:24:45.809355 kernel: ACPI: Added _OSI(Module Device) Jun 21 02:24:45.809362 kernel: ACPI: Added _OSI(Processor Device) Jun 21 02:24:45.809369 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 21 02:24:45.809376 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 21 02:24:45.809384 kernel: ACPI: Interpreter enabled Jun 21 02:24:45.809391 kernel: ACPI: Using GIC for interrupt routing Jun 21 02:24:45.809398 kernel: ACPI: MCFG table detected, 1 entries Jun 21 02:24:45.809405 kernel: ACPI: CPU0 has been hot-added Jun 21 02:24:45.809412 kernel: ACPI: CPU1 has been hot-added Jun 21 02:24:45.809419 kernel: ACPI: CPU2 has been hot-added Jun 21 02:24:45.809425 kernel: ACPI: CPU3 has been hot-added Jun 21 02:24:45.809433 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jun 21 02:24:45.809439 kernel: printk: legacy console [ttyAMA0] enabled Jun 21 02:24:45.809448 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 21 02:24:45.809590 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 21 02:24:45.809679 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jun 21 02:24:45.809743 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jun 21 02:24:45.809802 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jun 21 02:24:45.809860 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jun 21 02:24:45.809870 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jun 21 02:24:45.809880 kernel: PCI host bridge to bus 0000:00 Jun 21 02:24:45.809946 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jun 21 02:24:45.810001 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jun 21 02:24:45.810054 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jun 21 02:24:45.810106 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 21 02:24:45.810187 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Jun 21 02:24:45.810258 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jun 21 02:24:45.810322 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Jun 21 02:24:45.810383 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Jun 21 02:24:45.810443 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Jun 21 02:24:45.810502 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Jun 21 02:24:45.810562 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Jun 21 02:24:45.810653 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Jun 21 02:24:45.810785 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jun 21 02:24:45.810842 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jun 21 02:24:45.810894 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jun 21 02:24:45.810903 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jun 21 02:24:45.810910 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jun 21 02:24:45.810917 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jun 21 02:24:45.810930 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jun 21 02:24:45.810937 kernel: iommu: Default domain type: Translated Jun 21 02:24:45.810944 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jun 21 02:24:45.810953 kernel: efivars: Registered efivars operations Jun 21 02:24:45.810960 kernel: vgaarb: loaded Jun 21 02:24:45.810966 kernel: clocksource: Switched to clocksource arch_sys_counter Jun 21 02:24:45.810973 kernel: VFS: Disk quotas dquot_6.6.0 Jun 21 02:24:45.810980 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 21 02:24:45.810987 kernel: pnp: PnP ACPI init Jun 21 02:24:45.811054 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jun 21 02:24:45.811065 kernel: pnp: PnP ACPI: found 1 devices Jun 21 02:24:45.811074 kernel: NET: Registered PF_INET protocol family Jun 21 02:24:45.811082 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 21 02:24:45.811089 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 21 02:24:45.811096 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 21 02:24:45.811103 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 21 02:24:45.811110 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jun 21 02:24:45.811118 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 21 02:24:45.811125 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 02:24:45.811132 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 02:24:45.811140 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 21 02:24:45.811148 kernel: PCI: CLS 0 bytes, default 64 Jun 21 02:24:45.811155 kernel: kvm [1]: HYP mode not available Jun 21 02:24:45.811161 kernel: Initialise system trusted keyrings Jun 21 02:24:45.811168 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jun 21 02:24:45.811175 kernel: Key type asymmetric registered Jun 21 02:24:45.811182 kernel: Asymmetric key parser 'x509' registered Jun 21 02:24:45.811190 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jun 21 02:24:45.811197 kernel: io scheduler mq-deadline registered Jun 21 02:24:45.811205 kernel: io scheduler kyber registered Jun 21 02:24:45.811212 kernel: io scheduler bfq registered Jun 21 02:24:45.811219 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jun 21 02:24:45.811226 kernel: ACPI: button: Power Button [PWRB] Jun 21 02:24:45.811234 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jun 21 02:24:45.811293 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jun 21 02:24:45.811302 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 21 02:24:45.811309 kernel: thunder_xcv, ver 1.0 Jun 21 02:24:45.811316 kernel: thunder_bgx, ver 1.0 Jun 21 02:24:45.811325 kernel: nicpf, ver 1.0 Jun 21 02:24:45.811331 kernel: nicvf, ver 1.0 Jun 21 02:24:45.811415 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jun 21 02:24:45.811496 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-06-21T02:24:45 UTC (1750472685) Jun 21 02:24:45.811506 kernel: hid: raw HID events driver (C) Jiri Kosina Jun 21 02:24:45.811514 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Jun 21 02:24:45.811521 kernel: watchdog: NMI not fully supported Jun 21 02:24:45.811528 kernel: watchdog: Hard watchdog permanently disabled Jun 21 02:24:45.811537 kernel: NET: Registered PF_INET6 protocol family Jun 21 02:24:45.811544 kernel: Segment Routing with IPv6 Jun 21 02:24:45.811551 kernel: In-situ OAM (IOAM) with IPv6 Jun 21 02:24:45.811558 kernel: NET: Registered PF_PACKET protocol family Jun 21 02:24:45.811565 kernel: Key type dns_resolver registered Jun 21 02:24:45.811572 kernel: registered taskstats version 1 Jun 21 02:24:45.811579 kernel: Loading compiled-in X.509 certificates Jun 21 02:24:45.811586 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.34-flatcar: 0d4b619b81572779adc2f9dd5f1325c23c2a41ec' Jun 21 02:24:45.811592 kernel: Demotion targets for Node 0: null Jun 21 02:24:45.811601 kernel: Key type .fscrypt registered Jun 21 02:24:45.811608 kernel: Key type fscrypt-provisioning registered Jun 21 02:24:45.811615 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 21 02:24:45.811621 kernel: ima: Allocated hash algorithm: sha1 Jun 21 02:24:45.811628 kernel: ima: No architecture policies found Jun 21 02:24:45.811635 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jun 21 02:24:45.811650 kernel: clk: Disabling unused clocks Jun 21 02:24:45.811666 kernel: PM: genpd: Disabling unused power domains Jun 21 02:24:45.811673 kernel: Warning: unable to open an initial console. Jun 21 02:24:45.811692 kernel: Freeing unused kernel memory: 39488K Jun 21 02:24:45.811699 kernel: Run /init as init process Jun 21 02:24:45.811706 kernel: with arguments: Jun 21 02:24:45.811713 kernel: /init Jun 21 02:24:45.811720 kernel: with environment: Jun 21 02:24:45.811727 kernel: HOME=/ Jun 21 02:24:45.811733 kernel: TERM=linux Jun 21 02:24:45.811744 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jun 21 02:24:45.811751 systemd[1]: Successfully made /usr/ read-only. Jun 21 02:24:45.811763 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jun 21 02:24:45.811771 systemd[1]: Detected virtualization kvm. Jun 21 02:24:45.811778 systemd[1]: Detected architecture arm64. Jun 21 02:24:45.811785 systemd[1]: Running in initrd. Jun 21 02:24:45.811793 systemd[1]: No hostname configured, using default hostname. Jun 21 02:24:45.811800 systemd[1]: Hostname set to . Jun 21 02:24:45.811808 systemd[1]: Initializing machine ID from VM UUID. Jun 21 02:24:45.811816 systemd[1]: Queued start job for default target initrd.target. Jun 21 02:24:45.811824 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 02:24:45.811831 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 02:24:45.811840 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 21 02:24:45.811848 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 02:24:45.811865 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 21 02:24:45.811873 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 21 02:24:45.811883 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 21 02:24:45.811891 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 21 02:24:45.811898 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 02:24:45.811916 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 02:24:45.811923 systemd[1]: Reached target paths.target - Path Units. Jun 21 02:24:45.811931 systemd[1]: Reached target slices.target - Slice Units. Jun 21 02:24:45.811938 systemd[1]: Reached target swap.target - Swaps. Jun 21 02:24:45.811946 systemd[1]: Reached target timers.target - Timer Units. Jun 21 02:24:45.811955 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 02:24:45.811963 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 02:24:45.811971 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 21 02:24:45.811979 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jun 21 02:24:45.811986 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 02:24:45.811994 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 02:24:45.812001 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 02:24:45.812008 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 02:24:45.812016 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 21 02:24:45.812025 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 02:24:45.812033 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 21 02:24:45.812040 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). Jun 21 02:24:45.812048 systemd[1]: Starting systemd-fsck-usr.service... Jun 21 02:24:45.812055 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 02:24:45.812063 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 02:24:45.812070 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 02:24:45.812078 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 21 02:24:45.812087 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 02:24:45.812095 systemd[1]: Finished systemd-fsck-usr.service. Jun 21 02:24:45.812103 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 02:24:45.812131 systemd-journald[245]: Collecting audit messages is disabled. Jun 21 02:24:45.812152 systemd-journald[245]: Journal started Jun 21 02:24:45.812171 systemd-journald[245]: Runtime Journal (/run/log/journal/583eca5317fe4948ac205e49f6de1912) is 6M, max 48.5M, 42.4M free. Jun 21 02:24:45.806136 systemd-modules-load[246]: Inserted module 'overlay' Jun 21 02:24:45.815345 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 02:24:45.817866 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 02:24:45.820244 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 21 02:24:45.821780 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 02:24:45.824707 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 02:24:45.826637 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 21 02:24:45.827166 systemd-modules-load[246]: Inserted module 'br_netfilter' Jun 21 02:24:45.827877 kernel: Bridge firewalling registered Jun 21 02:24:45.832366 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 02:24:45.834226 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 02:24:45.836740 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 02:24:45.837060 systemd-tmpfiles[263]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jun 21 02:24:45.840189 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 02:24:45.844032 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 02:24:45.849359 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 02:24:45.851940 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 02:24:45.853810 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 02:24:45.856232 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 21 02:24:45.878425 dracut-cmdline[288]: 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=cb99487be08e9decec94bac26681ba79a4365c210ec86e0c6fe47991cb7f77db Jun 21 02:24:45.891521 systemd-resolved[284]: Positive Trust Anchors: Jun 21 02:24:45.891544 systemd-resolved[284]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 02:24:45.891576 systemd-resolved[284]: 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 Jun 21 02:24:45.896743 systemd-resolved[284]: Defaulting to hostname 'linux'. Jun 21 02:24:45.897745 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 02:24:45.899104 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 02:24:45.956693 kernel: SCSI subsystem initialized Jun 21 02:24:45.961676 kernel: Loading iSCSI transport class v2.0-870. Jun 21 02:24:45.969690 kernel: iscsi: registered transport (tcp) Jun 21 02:24:45.983750 kernel: iscsi: registered transport (qla4xxx) Jun 21 02:24:45.983787 kernel: QLogic iSCSI HBA Driver Jun 21 02:24:46.004199 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 02:24:46.021447 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 02:24:46.022824 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 02:24:46.077093 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 21 02:24:46.079196 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 21 02:24:46.141689 kernel: raid6: neonx8 gen() 15783 MB/s Jun 21 02:24:46.158677 kernel: raid6: neonx4 gen() 15807 MB/s Jun 21 02:24:46.175671 kernel: raid6: neonx2 gen() 13229 MB/s Jun 21 02:24:46.192673 kernel: raid6: neonx1 gen() 10425 MB/s Jun 21 02:24:46.209683 kernel: raid6: int64x8 gen() 6896 MB/s Jun 21 02:24:46.226669 kernel: raid6: int64x4 gen() 7352 MB/s Jun 21 02:24:46.243681 kernel: raid6: int64x2 gen() 6099 MB/s Jun 21 02:24:46.260671 kernel: raid6: int64x1 gen() 5041 MB/s Jun 21 02:24:46.260684 kernel: raid6: using algorithm neonx4 gen() 15807 MB/s Jun 21 02:24:46.277678 kernel: raid6: .... xor() 12334 MB/s, rmw enabled Jun 21 02:24:46.277690 kernel: raid6: using neon recovery algorithm Jun 21 02:24:46.282679 kernel: xor: measuring software checksum speed Jun 21 02:24:46.282720 kernel: 8regs : 18834 MB/sec Jun 21 02:24:46.285300 kernel: 32regs : 21710 MB/sec Jun 21 02:24:46.286679 kernel: arm64_neon : 1766 MB/sec Jun 21 02:24:46.286696 kernel: xor: using function: 32regs (21710 MB/sec) Jun 21 02:24:46.339706 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 21 02:24:46.346730 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 21 02:24:46.349297 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 02:24:46.376190 systemd-udevd[498]: Using default interface naming scheme 'v255'. Jun 21 02:24:46.380358 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 02:24:46.382023 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 21 02:24:46.410090 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Jun 21 02:24:46.434341 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 02:24:46.436394 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 02:24:46.497923 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 02:24:46.500376 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 21 02:24:46.552531 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 02:24:46.558800 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jun 21 02:24:46.558983 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jun 21 02:24:46.552685 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 02:24:46.565543 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 02:24:46.567216 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 02:24:46.571675 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jun 21 02:24:46.571718 kernel: GPT:9289727 != 19775487 Jun 21 02:24:46.571729 kernel: GPT:Alternate GPT header not at the end of the disk. Jun 21 02:24:46.571737 kernel: GPT:9289727 != 19775487 Jun 21 02:24:46.571745 kernel: GPT: Use GNU Parted to correct GPT errors. Jun 21 02:24:46.571763 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 02:24:46.599764 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jun 21 02:24:46.600890 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 02:24:46.615322 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jun 21 02:24:46.616463 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 21 02:24:46.623549 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jun 21 02:24:46.624579 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jun 21 02:24:46.634779 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 02:24:46.635891 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 02:24:46.637362 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 02:24:46.638853 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 02:24:46.641198 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 21 02:24:46.642824 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 21 02:24:46.658716 disk-uuid[591]: Primary Header is updated. Jun 21 02:24:46.658716 disk-uuid[591]: Secondary Entries is updated. Jun 21 02:24:46.658716 disk-uuid[591]: Secondary Header is updated. Jun 21 02:24:46.661693 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 02:24:46.662045 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 21 02:24:47.672580 disk-uuid[596]: The operation has completed successfully. Jun 21 02:24:47.673603 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 02:24:47.697002 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 21 02:24:47.697104 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 21 02:24:47.729411 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 21 02:24:47.752546 sh[610]: Success Jun 21 02:24:47.773190 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 21 02:24:47.773241 kernel: device-mapper: uevent: version 1.0.3 Jun 21 02:24:47.776686 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jun 21 02:24:47.782701 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jun 21 02:24:47.812180 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 21 02:24:47.813817 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 21 02:24:47.826094 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 21 02:24:47.831971 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jun 21 02:24:47.832035 kernel: BTRFS: device fsid 750e5bb7-0e5c-4b2e-87f6-233588ea3c64 devid 1 transid 51 /dev/mapper/usr (253:0) scanned by mount (622) Jun 21 02:24:47.833182 kernel: BTRFS info (device dm-0): first mount of filesystem 750e5bb7-0e5c-4b2e-87f6-233588ea3c64 Jun 21 02:24:47.833224 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jun 21 02:24:47.833924 kernel: BTRFS info (device dm-0): using free-space-tree Jun 21 02:24:47.838124 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 21 02:24:47.839203 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jun 21 02:24:47.840185 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 21 02:24:47.841020 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 21 02:24:47.842745 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 21 02:24:47.862676 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (651) Jun 21 02:24:47.864692 kernel: BTRFS info (device vda6): first mount of filesystem 3419b9f8-2562-4f16-b892-4960d53a6e77 Jun 21 02:24:47.864739 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jun 21 02:24:47.864750 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 02:24:47.870687 kernel: BTRFS info (device vda6): last unmount of filesystem 3419b9f8-2562-4f16-b892-4960d53a6e77 Jun 21 02:24:47.872722 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 21 02:24:47.874809 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 21 02:24:47.950573 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 02:24:47.953979 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 02:24:48.003473 systemd-networkd[795]: lo: Link UP Jun 21 02:24:48.003485 systemd-networkd[795]: lo: Gained carrier Jun 21 02:24:48.004229 systemd-networkd[795]: Enumeration completed Jun 21 02:24:48.004357 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 02:24:48.005104 systemd-networkd[795]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 02:24:48.005108 systemd-networkd[795]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 02:24:48.005494 systemd-networkd[795]: eth0: Link UP Jun 21 02:24:48.005498 systemd-networkd[795]: eth0: Gained carrier Jun 21 02:24:48.005506 systemd-networkd[795]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 02:24:48.005866 systemd[1]: Reached target network.target - Network. Jun 21 02:24:48.032713 systemd-networkd[795]: eth0: DHCPv4 address 10.0.0.94/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 02:24:48.040923 ignition[696]: Ignition 2.21.0 Jun 21 02:24:48.040938 ignition[696]: Stage: fetch-offline Jun 21 02:24:48.040969 ignition[696]: no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:48.040977 ignition[696]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:48.041165 ignition[696]: parsed url from cmdline: "" Jun 21 02:24:48.041168 ignition[696]: no config URL provided Jun 21 02:24:48.041172 ignition[696]: reading system config file "/usr/lib/ignition/user.ign" Jun 21 02:24:48.041179 ignition[696]: no config at "/usr/lib/ignition/user.ign" Jun 21 02:24:48.041199 ignition[696]: op(1): [started] loading QEMU firmware config module Jun 21 02:24:48.041203 ignition[696]: op(1): executing: "modprobe" "qemu_fw_cfg" Jun 21 02:24:48.052741 ignition[696]: op(1): [finished] loading QEMU firmware config module Jun 21 02:24:48.058532 ignition[696]: parsing config with SHA512: 1f71f48196e72eda80b24861ef01c5a1dff5579037d059472e0e2dd15b1740dbe3b1ea376bfd76311d3f6c5d75c942474471ecdd491a5fb94097896cb32bbf17 Jun 21 02:24:48.061381 unknown[696]: fetched base config from "system" Jun 21 02:24:48.061401 unknown[696]: fetched user config from "qemu" Jun 21 02:24:48.061677 ignition[696]: fetch-offline: fetch-offline passed Jun 21 02:24:48.061730 ignition[696]: Ignition finished successfully Jun 21 02:24:48.063515 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 02:24:48.065030 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jun 21 02:24:48.065783 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 21 02:24:48.100746 ignition[809]: Ignition 2.21.0 Jun 21 02:24:48.100760 ignition[809]: Stage: kargs Jun 21 02:24:48.100897 ignition[809]: no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:48.100906 ignition[809]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:48.103719 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 21 02:24:48.101481 ignition[809]: kargs: kargs passed Jun 21 02:24:48.101525 ignition[809]: Ignition finished successfully Jun 21 02:24:48.106204 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 21 02:24:48.127865 ignition[817]: Ignition 2.21.0 Jun 21 02:24:48.127878 ignition[817]: Stage: disks Jun 21 02:24:48.128018 ignition[817]: no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:48.128027 ignition[817]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:48.129309 ignition[817]: disks: disks passed Jun 21 02:24:48.129420 ignition[817]: Ignition finished successfully Jun 21 02:24:48.132205 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 21 02:24:48.133270 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 21 02:24:48.134524 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 21 02:24:48.136159 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 02:24:48.137669 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 02:24:48.139054 systemd[1]: Reached target basic.target - Basic System. Jun 21 02:24:48.141445 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 21 02:24:48.168093 systemd-resolved[284]: Detected conflict on linux IN A 10.0.0.94 Jun 21 02:24:48.168108 systemd-resolved[284]: Hostname conflict, changing published hostname from 'linux' to 'linux8'. Jun 21 02:24:48.170345 systemd-fsck[827]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jun 21 02:24:48.174389 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 21 02:24:48.179714 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 21 02:24:48.251683 kernel: EXT4-fs (vda9): mounted filesystem 9ad072e4-7680-4e5b-adc0-72c770c20c86 r/w with ordered data mode. Quota mode: none. Jun 21 02:24:48.251979 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 21 02:24:48.253034 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 21 02:24:48.255120 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 02:24:48.256741 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 21 02:24:48.257562 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jun 21 02:24:48.257606 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 21 02:24:48.257641 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 02:24:48.267389 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 21 02:24:48.269859 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 21 02:24:48.272291 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (836) Jun 21 02:24:48.273980 kernel: BTRFS info (device vda6): first mount of filesystem 3419b9f8-2562-4f16-b892-4960d53a6e77 Jun 21 02:24:48.274011 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jun 21 02:24:48.274708 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 02:24:48.277695 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 02:24:48.322398 initrd-setup-root[860]: cut: /sysroot/etc/passwd: No such file or directory Jun 21 02:24:48.326699 initrd-setup-root[867]: cut: /sysroot/etc/group: No such file or directory Jun 21 02:24:48.330916 initrd-setup-root[874]: cut: /sysroot/etc/shadow: No such file or directory Jun 21 02:24:48.334854 initrd-setup-root[881]: cut: /sysroot/etc/gshadow: No such file or directory Jun 21 02:24:48.415235 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 21 02:24:48.417122 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 21 02:24:48.418613 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 21 02:24:48.434939 kernel: BTRFS info (device vda6): last unmount of filesystem 3419b9f8-2562-4f16-b892-4960d53a6e77 Jun 21 02:24:48.446460 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 21 02:24:48.459193 ignition[949]: INFO : Ignition 2.21.0 Jun 21 02:24:48.459193 ignition[949]: INFO : Stage: mount Jun 21 02:24:48.461322 ignition[949]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:48.461322 ignition[949]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:48.462964 ignition[949]: INFO : mount: mount passed Jun 21 02:24:48.462964 ignition[949]: INFO : Ignition finished successfully Jun 21 02:24:48.463596 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 21 02:24:48.467460 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 21 02:24:48.831560 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 21 02:24:48.835368 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 02:24:48.858755 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (962) Jun 21 02:24:48.858794 kernel: BTRFS info (device vda6): first mount of filesystem 3419b9f8-2562-4f16-b892-4960d53a6e77 Jun 21 02:24:48.860622 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jun 21 02:24:48.860651 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 02:24:48.863927 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 02:24:48.897077 ignition[978]: INFO : Ignition 2.21.0 Jun 21 02:24:48.897077 ignition[978]: INFO : Stage: files Jun 21 02:24:48.898393 ignition[978]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:48.898393 ignition[978]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:48.898393 ignition[978]: DEBUG : files: compiled without relabeling support, skipping Jun 21 02:24:48.900999 ignition[978]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 21 02:24:48.900999 ignition[978]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 21 02:24:48.903325 ignition[978]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 21 02:24:48.903325 ignition[978]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 21 02:24:48.903325 ignition[978]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 21 02:24:48.903149 unknown[978]: wrote ssh authorized keys file for user: core Jun 21 02:24:48.907687 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jun 21 02:24:48.907687 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jun 21 02:24:48.907687 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 02:24:48.907687 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 02:24:48.907687 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.0-arm64.raw" Jun 21 02:24:48.915043 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.0-arm64.raw" Jun 21 02:24:48.915043 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.0-arm64.raw" Jun 21 02:24:48.915043 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.33.0-arm64.raw: attempt #1 Jun 21 02:24:49.121816 systemd-networkd[795]: eth0: Gained IPv6LL Jun 21 02:24:49.429968 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jun 21 02:24:49.909499 ignition[978]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.0-arm64.raw" Jun 21 02:24:49.909499 ignition[978]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jun 21 02:24:49.912707 ignition[978]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 02:24:49.912707 ignition[978]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 02:24:49.912707 ignition[978]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jun 21 02:24:49.912707 ignition[978]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jun 21 02:24:49.929778 ignition[978]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 02:24:49.933259 ignition[978]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 02:24:49.934602 ignition[978]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jun 21 02:24:49.934602 ignition[978]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 21 02:24:49.934602 ignition[978]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 21 02:24:49.934602 ignition[978]: INFO : files: files passed Jun 21 02:24:49.934602 ignition[978]: INFO : Ignition finished successfully Jun 21 02:24:49.935488 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 21 02:24:49.937764 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 21 02:24:49.940802 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 21 02:24:49.958782 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 21 02:24:49.958880 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 21 02:24:49.961355 initrd-setup-root-after-ignition[1007]: grep: /sysroot/oem/oem-release: No such file or directory Jun 21 02:24:49.963419 initrd-setup-root-after-ignition[1010]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 02:24:49.963419 initrd-setup-root-after-ignition[1010]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 21 02:24:49.965962 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 02:24:49.966840 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 02:24:49.968134 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 21 02:24:49.970282 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 21 02:24:50.008711 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 21 02:24:50.008825 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 21 02:24:50.010583 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 21 02:24:50.011867 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 21 02:24:50.013302 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 21 02:24:50.014192 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 21 02:24:50.029137 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 02:24:50.031566 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 21 02:24:50.053322 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 21 02:24:50.054338 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 02:24:50.055972 systemd[1]: Stopped target timers.target - Timer Units. Jun 21 02:24:50.057507 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 21 02:24:50.057646 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 02:24:50.059777 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 21 02:24:50.061224 systemd[1]: Stopped target basic.target - Basic System. Jun 21 02:24:50.062644 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 21 02:24:50.063936 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 02:24:50.065718 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 21 02:24:50.067282 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jun 21 02:24:50.069575 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 21 02:24:50.071212 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 02:24:50.072900 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 21 02:24:50.075111 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 21 02:24:50.076492 systemd[1]: Stopped target swap.target - Swaps. Jun 21 02:24:50.077684 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 21 02:24:50.077824 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 21 02:24:50.079690 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 21 02:24:50.081252 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 02:24:50.082585 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 21 02:24:50.082783 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 02:24:50.084551 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 21 02:24:50.084698 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 21 02:24:50.087464 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 21 02:24:50.087583 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 02:24:50.089616 systemd[1]: Stopped target paths.target - Path Units. Jun 21 02:24:50.091066 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 21 02:24:50.091185 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 02:24:50.092879 systemd[1]: Stopped target slices.target - Slice Units. Jun 21 02:24:50.094481 systemd[1]: Stopped target sockets.target - Socket Units. Jun 21 02:24:50.095906 systemd[1]: iscsid.socket: Deactivated successfully. Jun 21 02:24:50.096007 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 02:24:50.097792 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 21 02:24:50.097877 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 02:24:50.099956 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 21 02:24:50.100078 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 02:24:50.101707 systemd[1]: ignition-files.service: Deactivated successfully. Jun 21 02:24:50.101809 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 21 02:24:50.103929 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 21 02:24:50.104591 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 21 02:24:50.104741 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 02:24:50.107088 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 21 02:24:50.107988 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 21 02:24:50.108113 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 02:24:50.109812 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 21 02:24:50.109916 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 02:24:50.116377 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 21 02:24:50.116463 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 21 02:24:50.124876 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 21 02:24:50.133229 ignition[1034]: INFO : Ignition 2.21.0 Jun 21 02:24:50.133229 ignition[1034]: INFO : Stage: umount Jun 21 02:24:50.134583 ignition[1034]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 02:24:50.134583 ignition[1034]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 02:24:50.134583 ignition[1034]: INFO : umount: umount passed Jun 21 02:24:50.134583 ignition[1034]: INFO : Ignition finished successfully Jun 21 02:24:50.136147 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 21 02:24:50.137688 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 21 02:24:50.139298 systemd[1]: Stopped target network.target - Network. Jun 21 02:24:50.140411 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 21 02:24:50.140480 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 21 02:24:50.141845 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 21 02:24:50.141891 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 21 02:24:50.143110 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 21 02:24:50.143751 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 21 02:24:50.144714 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 21 02:24:50.144760 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 21 02:24:50.146423 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 21 02:24:50.147714 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 21 02:24:50.155963 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 21 02:24:50.156102 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 21 02:24:50.159937 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jun 21 02:24:50.160252 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 21 02:24:50.160292 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 02:24:50.165771 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jun 21 02:24:50.166037 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 21 02:24:50.166146 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 21 02:24:50.169957 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jun 21 02:24:50.170413 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jun 21 02:24:50.171401 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 21 02:24:50.171451 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 21 02:24:50.173937 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 21 02:24:50.174955 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 21 02:24:50.175024 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 02:24:50.176564 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 21 02:24:50.176604 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 21 02:24:50.178831 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 21 02:24:50.178879 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 21 02:24:50.181065 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 02:24:50.183914 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jun 21 02:24:50.189908 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 21 02:24:50.190030 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 21 02:24:50.191830 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 21 02:24:50.191885 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 21 02:24:50.205567 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 21 02:24:50.206501 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 21 02:24:50.208417 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 21 02:24:50.208584 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 02:24:50.211781 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 21 02:24:50.211846 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 21 02:24:50.212986 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 21 02:24:50.213036 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 02:24:50.214478 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 21 02:24:50.214527 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 21 02:24:50.216862 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 21 02:24:50.216915 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 21 02:24:50.219298 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 21 02:24:50.219360 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 02:24:50.222745 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 21 02:24:50.224248 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jun 21 02:24:50.224311 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 02:24:50.227077 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 21 02:24:50.227120 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 02:24:50.229866 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 02:24:50.229916 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 02:24:50.243074 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 21 02:24:50.243208 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 21 02:24:50.245078 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 21 02:24:50.248237 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 21 02:24:50.275768 systemd[1]: Switching root. Jun 21 02:24:50.300900 systemd-journald[245]: Journal stopped Jun 21 02:24:51.084153 systemd-journald[245]: Received SIGTERM from PID 1 (systemd). Jun 21 02:24:51.084201 kernel: SELinux: policy capability network_peer_controls=1 Jun 21 02:24:51.084219 kernel: SELinux: policy capability open_perms=1 Jun 21 02:24:51.084228 kernel: SELinux: policy capability extended_socket_class=1 Jun 21 02:24:51.084237 kernel: SELinux: policy capability always_check_network=0 Jun 21 02:24:51.084249 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 21 02:24:51.084259 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 21 02:24:51.084268 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 21 02:24:51.084279 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 21 02:24:51.084289 kernel: SELinux: policy capability userspace_initial_context=0 Jun 21 02:24:51.084299 kernel: audit: type=1403 audit(1750472690.468:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 21 02:24:51.084316 systemd[1]: Successfully loaded SELinux policy in 55.388ms. Jun 21 02:24:51.084334 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.806ms. Jun 21 02:24:51.084347 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jun 21 02:24:51.084358 systemd[1]: Detected virtualization kvm. Jun 21 02:24:51.084368 systemd[1]: Detected architecture arm64. Jun 21 02:24:51.084377 systemd[1]: Detected first boot. Jun 21 02:24:51.084389 systemd[1]: Initializing machine ID from VM UUID. Jun 21 02:24:51.084399 zram_generator::config[1080]: No configuration found. Jun 21 02:24:51.084411 kernel: NET: Registered PF_VSOCK protocol family Jun 21 02:24:51.084421 systemd[1]: Populated /etc with preset unit settings. Jun 21 02:24:51.084434 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jun 21 02:24:51.084444 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 21 02:24:51.084454 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 21 02:24:51.084464 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 21 02:24:51.084475 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 21 02:24:51.084485 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 21 02:24:51.084495 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 21 02:24:51.084505 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 21 02:24:51.084515 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 21 02:24:51.084527 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 21 02:24:51.084537 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 21 02:24:51.084548 systemd[1]: Created slice user.slice - User and Session Slice. Jun 21 02:24:51.084558 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 02:24:51.084569 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 02:24:51.084580 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 21 02:24:51.084590 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 21 02:24:51.084600 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 21 02:24:51.084611 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 02:24:51.084633 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jun 21 02:24:51.084646 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 02:24:51.084684 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 02:24:51.084697 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 21 02:24:51.084707 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 21 02:24:51.084718 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 21 02:24:51.084728 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 21 02:24:51.084741 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 02:24:51.084751 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 02:24:51.084761 systemd[1]: Reached target slices.target - Slice Units. Jun 21 02:24:51.084771 systemd[1]: Reached target swap.target - Swaps. Jun 21 02:24:51.084781 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 21 02:24:51.084791 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 21 02:24:51.084802 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jun 21 02:24:51.084811 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 02:24:51.084821 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 02:24:51.084833 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 02:24:51.084843 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 21 02:24:51.084853 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 21 02:24:51.084863 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 21 02:24:51.084873 systemd[1]: Mounting media.mount - External Media Directory... Jun 21 02:24:51.084883 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 21 02:24:51.084892 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 21 02:24:51.084902 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 21 02:24:51.084912 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). Jun 21 02:24:51.084924 systemd[1]: Reached target machines.target - Containers. Jun 21 02:24:51.084934 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 21 02:24:51.084944 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 02:24:51.084955 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 02:24:51.084965 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 21 02:24:51.084975 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 02:24:51.084985 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 02:24:51.084996 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 02:24:51.085006 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 21 02:24:51.085019 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 02:24:51.085029 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 21 02:24:51.085039 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 21 02:24:51.085049 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 21 02:24:51.085059 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 21 02:24:51.085069 systemd[1]: Stopped systemd-fsck-usr.service. Jun 21 02:24:51.085079 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). Jun 21 02:24:51.085090 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 02:24:51.085101 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 02:24:51.085111 kernel: fuse: init (API version 7.41) Jun 21 02:24:51.085120 kernel: loop: module loaded Jun 21 02:24:51.085130 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 02:24:51.085141 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 21 02:24:51.085151 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jun 21 02:24:51.085161 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 02:24:51.085173 kernel: ACPI: bus type drm_connector registered Jun 21 02:24:51.085182 systemd[1]: verity-setup.service: Deactivated successfully. Jun 21 02:24:51.085192 systemd[1]: Stopped verity-setup.service. Jun 21 02:24:51.085202 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 21 02:24:51.085212 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 21 02:24:51.085223 systemd[1]: Mounted media.mount - External Media Directory. Jun 21 02:24:51.085233 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 21 02:24:51.085244 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 21 02:24:51.085254 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 21 02:24:51.085264 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 02:24:51.085275 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 21 02:24:51.085311 systemd-journald[1153]: Collecting audit messages is disabled. Jun 21 02:24:51.085337 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 21 02:24:51.085347 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 21 02:24:51.085357 systemd-journald[1153]: Journal started Jun 21 02:24:51.085378 systemd-journald[1153]: Runtime Journal (/run/log/journal/583eca5317fe4948ac205e49f6de1912) is 6M, max 48.5M, 42.4M free. Jun 21 02:24:50.865615 systemd[1]: Queued start job for default target multi-user.target. Jun 21 02:24:50.880792 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jun 21 02:24:50.881185 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 21 02:24:51.088158 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 02:24:51.089122 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 02:24:51.089316 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 02:24:51.090411 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 02:24:51.090579 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 02:24:51.091820 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 02:24:51.091981 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 02:24:51.093120 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 21 02:24:51.093280 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 21 02:24:51.094375 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 02:24:51.094558 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 02:24:51.095786 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 02:24:51.097003 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 02:24:51.098221 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 21 02:24:51.099670 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jun 21 02:24:51.113240 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 02:24:51.115533 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 21 02:24:51.117537 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 21 02:24:51.118489 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 21 02:24:51.118531 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 02:24:51.120311 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jun 21 02:24:51.126212 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 21 02:24:51.127165 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 02:24:51.128708 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 21 02:24:51.130697 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 21 02:24:51.131757 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 02:24:51.132987 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 21 02:24:51.133830 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 02:24:51.135108 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 02:24:51.138800 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 21 02:24:51.147803 systemd-journald[1153]: Time spent on flushing to /var/log/journal/583eca5317fe4948ac205e49f6de1912 is 26.298ms for 864 entries. Jun 21 02:24:51.147803 systemd-journald[1153]: System Journal (/var/log/journal/583eca5317fe4948ac205e49f6de1912) is 8M, max 195.6M, 187.6M free. Jun 21 02:24:51.192789 systemd-journald[1153]: Received client request to flush runtime journal. Jun 21 02:24:51.192828 kernel: loop0: detected capacity change from 0 to 107312 Jun 21 02:24:51.194257 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 21 02:24:51.141801 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 21 02:24:51.144417 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 02:24:51.149442 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 21 02:24:51.150693 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 21 02:24:51.153673 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 21 02:24:51.159477 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 21 02:24:51.163236 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jun 21 02:24:51.173362 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 02:24:51.177581 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 21 02:24:51.184378 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 02:24:51.198325 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 21 02:24:51.206838 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jun 21 02:24:51.216274 kernel: loop1: detected capacity change from 0 to 211168 Jun 21 02:24:51.219816 systemd-tmpfiles[1209]: ACLs are not supported, ignoring. Jun 21 02:24:51.220197 systemd-tmpfiles[1209]: ACLs are not supported, ignoring. Jun 21 02:24:51.224992 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 02:24:51.253725 kernel: loop2: detected capacity change from 0 to 138376 Jun 21 02:24:51.288700 kernel: loop3: detected capacity change from 0 to 107312 Jun 21 02:24:51.294684 kernel: loop4: detected capacity change from 0 to 211168 Jun 21 02:24:51.300033 kernel: loop5: detected capacity change from 0 to 138376 Jun 21 02:24:51.305118 (sd-merge)[1219]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jun 21 02:24:51.305507 (sd-merge)[1219]: Merged extensions into '/usr'. Jun 21 02:24:51.309622 systemd[1]: Reload requested from client PID 1197 ('systemd-sysext') (unit systemd-sysext.service)... Jun 21 02:24:51.309639 systemd[1]: Reloading... Jun 21 02:24:51.355805 zram_generator::config[1247]: No configuration found. Jun 21 02:24:51.419724 ldconfig[1192]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 21 02:24:51.441613 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jun 21 02:24:51.504021 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 21 02:24:51.504094 systemd[1]: Reloading finished in 194 ms. Jun 21 02:24:51.520692 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 21 02:24:51.521819 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 21 02:24:51.540922 systemd[1]: Starting ensure-sysext.service... Jun 21 02:24:51.542576 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 02:24:51.554107 systemd[1]: Reload requested from client PID 1282 ('systemctl') (unit ensure-sysext.service)... Jun 21 02:24:51.554120 systemd[1]: Reloading... Jun 21 02:24:51.559761 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jun 21 02:24:51.560072 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jun 21 02:24:51.560365 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 21 02:24:51.560651 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 21 02:24:51.561342 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 21 02:24:51.561691 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Jun 21 02:24:51.561806 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Jun 21 02:24:51.564258 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 02:24:51.564357 systemd-tmpfiles[1283]: Skipping /boot Jun 21 02:24:51.574379 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 02:24:51.574482 systemd-tmpfiles[1283]: Skipping /boot Jun 21 02:24:51.592687 zram_generator::config[1310]: No configuration found. Jun 21 02:24:51.666622 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jun 21 02:24:51.728397 systemd[1]: Reloading finished in 174 ms. Jun 21 02:24:51.752479 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 21 02:24:51.758725 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 02:24:51.764335 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 02:24:51.766644 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 21 02:24:51.769079 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 21 02:24:51.772045 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 02:24:51.777039 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 02:24:51.780857 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 21 02:24:51.786912 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 02:24:51.788256 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 02:24:51.791925 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 02:24:51.804972 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 02:24:51.806215 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 02:24:51.806364 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). Jun 21 02:24:51.808985 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 21 02:24:51.811035 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 02:24:51.811293 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 02:24:51.814640 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 02:24:51.814899 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 02:24:51.816626 systemd-udevd[1351]: Using default interface naming scheme 'v255'. Jun 21 02:24:51.819138 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 02:24:51.819305 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 02:24:51.824233 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 02:24:51.825969 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 02:24:51.829898 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 02:24:51.836421 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 02:24:51.837730 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 02:24:51.837917 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). Jun 21 02:24:51.839264 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 21 02:24:51.842369 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 21 02:24:51.844678 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 02:24:51.847566 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 21 02:24:51.849080 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 21 02:24:51.852787 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 02:24:51.852978 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 02:24:51.855827 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 02:24:51.855996 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 02:24:51.857475 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 21 02:24:51.859471 augenrules[1406]: No rules Jun 21 02:24:51.862437 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 02:24:51.864070 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 02:24:51.891921 systemd[1]: Finished ensure-sysext.service. Jun 21 02:24:51.903864 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 02:24:51.906851 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 02:24:51.907936 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 02:24:51.912023 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 02:24:51.918669 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 02:24:51.921864 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 02:24:51.921916 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). Jun 21 02:24:51.924269 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 02:24:51.926964 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jun 21 02:24:51.927870 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). Jun 21 02:24:51.928502 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 21 02:24:51.930031 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 02:24:51.931692 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 02:24:51.933419 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 02:24:51.933566 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 02:24:51.935189 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 02:24:51.935498 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 02:24:51.937038 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 02:24:51.937195 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 02:24:51.944478 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 02:24:51.944543 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 02:24:51.949978 augenrules[1426]: /sbin/augenrules: No change Jun 21 02:24:51.960785 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jun 21 02:24:51.960988 augenrules[1459]: No rules Jun 21 02:24:51.963105 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 02:24:51.964769 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 02:24:51.988852 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 02:24:51.991246 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jun 21 02:24:52.020742 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 21 02:24:52.063207 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jun 21 02:24:52.064340 systemd[1]: Reached target time-set.target - System Time Set. Jun 21 02:24:52.070241 systemd-networkd[1435]: lo: Link UP Jun 21 02:24:52.070523 systemd-networkd[1435]: lo: Gained carrier Jun 21 02:24:52.071437 systemd-networkd[1435]: Enumeration completed Jun 21 02:24:52.071605 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 02:24:52.072173 systemd-networkd[1435]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 02:24:52.072262 systemd-networkd[1435]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 02:24:52.072847 systemd-networkd[1435]: eth0: Link UP Jun 21 02:24:52.073064 systemd-networkd[1435]: eth0: Gained carrier Jun 21 02:24:52.073148 systemd-networkd[1435]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 02:24:52.073911 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jun 21 02:24:52.076164 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 21 02:24:52.082964 systemd-resolved[1350]: Positive Trust Anchors: Jun 21 02:24:52.082979 systemd-resolved[1350]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 02:24:52.083011 systemd-resolved[1350]: 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 Jun 21 02:24:52.086771 systemd-networkd[1435]: eth0: DHCPv4 address 10.0.0.94/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 02:24:52.088595 systemd-timesyncd[1441]: Network configuration changed, trying to establish connection. Jun 21 02:24:52.090162 systemd-timesyncd[1441]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jun 21 02:24:52.090218 systemd-timesyncd[1441]: Initial clock synchronization to Sat 2025-06-21 02:24:52.248971 UTC. Jun 21 02:24:52.092053 systemd-resolved[1350]: Defaulting to hostname 'linux'. Jun 21 02:24:52.099772 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 02:24:52.100697 systemd[1]: Reached target network.target - Network. Jun 21 02:24:52.102741 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 02:24:52.103602 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 02:24:52.104484 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 21 02:24:52.105413 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 21 02:24:52.106534 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 21 02:24:52.107423 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 21 02:24:52.108328 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 21 02:24:52.109212 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 21 02:24:52.109244 systemd[1]: Reached target paths.target - Path Units. Jun 21 02:24:52.109880 systemd[1]: Reached target timers.target - Timer Units. Jun 21 02:24:52.111349 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 21 02:24:52.113496 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 02:24:52.118508 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jun 21 02:24:52.119686 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jun 21 02:24:52.120568 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jun 21 02:24:52.126846 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 21 02:24:52.128217 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jun 21 02:24:52.129888 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jun 21 02:24:52.132929 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 02:24:52.135098 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 02:24:52.137603 systemd[1]: Reached target basic.target - Basic System. Jun 21 02:24:52.138441 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 21 02:24:52.138474 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 21 02:24:52.140078 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 02:24:52.142955 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 21 02:24:52.148030 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 21 02:24:52.150827 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 21 02:24:52.158070 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 21 02:24:52.158933 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). Jun 21 02:24:52.160082 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 21 02:24:52.163803 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 21 02:24:52.165759 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 21 02:24:52.169560 jq[1495]: false Jun 21 02:24:52.170431 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 21 02:24:52.172202 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 21 02:24:52.172752 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 21 02:24:52.173302 systemd[1]: Starting update-engine.service - Update Engine... Jun 21 02:24:52.176839 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 21 02:24:52.179198 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 21 02:24:52.181166 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 21 02:24:52.181361 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 21 02:24:52.184943 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 21 02:24:52.192007 extend-filesystems[1496]: Found /dev/vda6 Jun 21 02:24:52.192939 extend-filesystems[1496]: Found /dev/vda9 Jun 21 02:24:52.194187 extend-filesystems[1496]: Checking size of /dev/vda9 Jun 21 02:24:52.197959 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 21 02:24:52.199479 systemd[1]: motdgen.service: Deactivated successfully. Jun 21 02:24:52.199704 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 21 02:24:52.200010 jq[1507]: true Jun 21 02:24:52.208253 (ntainerd)[1521]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 02:24:52.209869 extend-filesystems[1496]: Resized partition /dev/vda9 Jun 21 02:24:52.219407 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 02:24:52.220743 extend-filesystems[1531]: resize2fs 1.47.2 (1-Jan-2025) Jun 21 02:24:52.229798 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jun 21 02:24:52.236470 jq[1520]: true Jun 21 02:24:52.245725 update_engine[1505]: I20250621 02:24:52.245188 1505 main.cc:92] Flatcar Update Engine starting Jun 21 02:24:52.256247 dbus-daemon[1493]: [system] SELinux support is enabled Jun 21 02:24:52.257484 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 21 02:24:52.259195 update_engine[1505]: I20250621 02:24:52.259145 1505 update_check_scheduler.cc:74] Next update check in 2m8s Jun 21 02:24:52.263221 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). Jun 21 02:24:52.263252 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 21 02:24:52.264908 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). Jun 21 02:24:52.288755 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jun 21 02:24:52.264927 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 21 02:24:52.266296 systemd[1]: Started update-engine.service - Update Engine. Jun 21 02:24:52.273425 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 21 02:24:52.297058 extend-filesystems[1531]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jun 21 02:24:52.297058 extend-filesystems[1531]: old_desc_blocks = 1, new_desc_blocks = 1 Jun 21 02:24:52.297058 extend-filesystems[1531]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jun 21 02:24:52.303832 extend-filesystems[1496]: Resized filesystem in /dev/vda9 Jun 21 02:24:52.297401 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 21 02:24:52.297846 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 21 02:24:52.314641 systemd-logind[1503]: Watching system buttons on /dev/input/event0 (Power Button) Jun 21 02:24:52.314847 systemd-logind[1503]: New seat seat0. Jun 21 02:24:52.331671 bash[1555]: Updated "/home/core/.ssh/authorized_keys" Jun 21 02:24:52.339841 systemd[1]: Started systemd-logind.service - User Login Management. Jun 21 02:24:52.341057 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 21 02:24:52.344001 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 02:24:52.363597 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jun 21 02:24:52.395674 locksmithd[1538]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 21 02:24:52.472181 containerd[1521]: time="2025-06-21T02:24:52Z" 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 Jun 21 02:24:52.473907 containerd[1521]: time="2025-06-21T02:24:52.473853000Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 02:24:52.482673 containerd[1521]: time="2025-06-21T02:24:52.482563680Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.88µs" Jun 21 02:24:52.482673 containerd[1521]: time="2025-06-21T02:24:52.482609800Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 02:24:52.482673 containerd[1521]: time="2025-06-21T02:24:52.482637720Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 02:24:52.483011 containerd[1521]: time="2025-06-21T02:24:52.482986280Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 02:24:52.483080 containerd[1521]: time="2025-06-21T02:24:52.483067840Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 02:24:52.483146 containerd[1521]: time="2025-06-21T02:24:52.483131960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483257 containerd[1521]: time="2025-06-21T02:24:52.483238240Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483309 containerd[1521]: time="2025-06-21T02:24:52.483295640Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483633 containerd[1521]: time="2025-06-21T02:24:52.483589920Z" 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 Jun 21 02:24:52.483721 containerd[1521]: time="2025-06-21T02:24:52.483705040Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483774 containerd[1521]: time="2025-06-21T02:24:52.483759760Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483819 containerd[1521]: time="2025-06-21T02:24:52.483807000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 02:24:52.483961 containerd[1521]: time="2025-06-21T02:24:52.483943160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 02:24:52.484215 containerd[1521]: time="2025-06-21T02:24:52.484191680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 02:24:52.484297 containerd[1521]: time="2025-06-21T02:24:52.484281280Z" 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 Jun 21 02:24:52.484345 containerd[1521]: time="2025-06-21T02:24:52.484333600Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 02:24:52.484988 containerd[1521]: time="2025-06-21T02:24:52.484962840Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 02:24:52.485379 containerd[1521]: time="2025-06-21T02:24:52.485360720Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 02:24:52.485509 containerd[1521]: time="2025-06-21T02:24:52.485492520Z" level=info msg="metadata content store policy set" policy=shared Jun 21 02:24:52.488678 containerd[1521]: time="2025-06-21T02:24:52.488628320Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 02:24:52.488793 containerd[1521]: time="2025-06-21T02:24:52.488775960Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 02:24:52.488852 containerd[1521]: time="2025-06-21T02:24:52.488833680Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 02:24:52.488923 containerd[1521]: time="2025-06-21T02:24:52.488910840Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 02:24:52.488973 containerd[1521]: time="2025-06-21T02:24:52.488961840Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 02:24:52.489056 containerd[1521]: time="2025-06-21T02:24:52.489040760Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 02:24:52.489127 containerd[1521]: time="2025-06-21T02:24:52.489113960Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 02:24:52.489184 containerd[1521]: time="2025-06-21T02:24:52.489171720Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 02:24:52.489241 containerd[1521]: time="2025-06-21T02:24:52.489229600Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 02:24:52.489298 containerd[1521]: time="2025-06-21T02:24:52.489284720Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 02:24:52.489345 containerd[1521]: time="2025-06-21T02:24:52.489334200Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 02:24:52.489405 containerd[1521]: time="2025-06-21T02:24:52.489392960Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 02:24:52.489580 containerd[1521]: time="2025-06-21T02:24:52.489559920Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 02:24:52.489686 containerd[1521]: time="2025-06-21T02:24:52.489651880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 02:24:52.489745 containerd[1521]: time="2025-06-21T02:24:52.489732600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 02:24:52.489794 containerd[1521]: time="2025-06-21T02:24:52.489782960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 02:24:52.489842 containerd[1521]: time="2025-06-21T02:24:52.489830280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 02:24:52.489909 containerd[1521]: time="2025-06-21T02:24:52.489895840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 02:24:52.489973 containerd[1521]: time="2025-06-21T02:24:52.489959720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 02:24:52.490029 containerd[1521]: time="2025-06-21T02:24:52.490016960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 02:24:52.490089 containerd[1521]: time="2025-06-21T02:24:52.490077360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 02:24:52.490138 containerd[1521]: time="2025-06-21T02:24:52.490126360Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 02:24:52.490188 containerd[1521]: time="2025-06-21T02:24:52.490176360Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 02:24:52.490447 containerd[1521]: time="2025-06-21T02:24:52.490429280Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 02:24:52.490517 containerd[1521]: time="2025-06-21T02:24:52.490492440Z" level=info msg="Start snapshots syncer" Jun 21 02:24:52.490645 containerd[1521]: time="2025-06-21T02:24:52.490589360Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 02:24:52.491046 containerd[1521]: time="2025-06-21T02:24:52.491003440Z" 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\"}" Jun 21 02:24:52.491199 containerd[1521]: time="2025-06-21T02:24:52.491182480Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 02:24:52.491349 containerd[1521]: time="2025-06-21T02:24:52.491317640Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 02:24:52.491560 containerd[1521]: time="2025-06-21T02:24:52.491540840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 02:24:52.491681 containerd[1521]: time="2025-06-21T02:24:52.491652000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 02:24:52.491738 containerd[1521]: time="2025-06-21T02:24:52.491725640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 02:24:52.491793 containerd[1521]: time="2025-06-21T02:24:52.491780400Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 02:24:52.491859 containerd[1521]: time="2025-06-21T02:24:52.491829960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 02:24:52.491925 containerd[1521]: time="2025-06-21T02:24:52.491912280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 02:24:52.491977 containerd[1521]: time="2025-06-21T02:24:52.491965280Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 02:24:52.492061 containerd[1521]: time="2025-06-21T02:24:52.492046560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 02:24:52.492129 containerd[1521]: time="2025-06-21T02:24:52.492115840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 02:24:52.492182 containerd[1521]: time="2025-06-21T02:24:52.492170120Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 02:24:52.492275 containerd[1521]: time="2025-06-21T02:24:52.492260480Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 02:24:52.492333 containerd[1521]: time="2025-06-21T02:24:52.492319240Z" 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 Jun 21 02:24:52.492379 containerd[1521]: time="2025-06-21T02:24:52.492366760Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 02:24:52.492431 containerd[1521]: time="2025-06-21T02:24:52.492417960Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 02:24:52.492485 containerd[1521]: time="2025-06-21T02:24:52.492472720Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 02:24:52.492535 containerd[1521]: time="2025-06-21T02:24:52.492523280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 02:24:52.492583 containerd[1521]: time="2025-06-21T02:24:52.492571160Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 02:24:52.493443 containerd[1521]: time="2025-06-21T02:24:52.492729640Z" level=info msg="runtime interface created" Jun 21 02:24:52.493443 containerd[1521]: time="2025-06-21T02:24:52.492740760Z" level=info msg="created NRI interface" Jun 21 02:24:52.493443 containerd[1521]: time="2025-06-21T02:24:52.492751040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 02:24:52.493443 containerd[1521]: time="2025-06-21T02:24:52.492767080Z" level=info msg="Connect containerd service" Jun 21 02:24:52.493443 containerd[1521]: time="2025-06-21T02:24:52.492801000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 02:24:52.494924 containerd[1521]: time="2025-06-21T02:24:52.494891840Z" 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" Jun 21 02:24:52.599515 containerd[1521]: time="2025-06-21T02:24:52.599420520Z" level=info msg="Start subscribing containerd event" Jun 21 02:24:52.599698 containerd[1521]: time="2025-06-21T02:24:52.599671280Z" level=info msg="Start recovering state" Jun 21 02:24:52.599861 containerd[1521]: time="2025-06-21T02:24:52.599844640Z" level=info msg="Start event monitor" Jun 21 02:24:52.599940 containerd[1521]: time="2025-06-21T02:24:52.599928800Z" level=info msg="Start cni network conf syncer for default" Jun 21 02:24:52.600038 containerd[1521]: time="2025-06-21T02:24:52.600025960Z" level=info msg="Start streaming server" Jun 21 02:24:52.600114 containerd[1521]: time="2025-06-21T02:24:52.599483320Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 02:24:52.600262 containerd[1521]: time="2025-06-21T02:24:52.600247440Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 02:24:52.600421 containerd[1521]: time="2025-06-21T02:24:52.600311200Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 02:24:52.600493 containerd[1521]: time="2025-06-21T02:24:52.600481080Z" level=info msg="runtime interface starting up..." Jun 21 02:24:52.600567 containerd[1521]: time="2025-06-21T02:24:52.600556800Z" level=info msg="starting plugins..." Jun 21 02:24:52.600751 containerd[1521]: time="2025-06-21T02:24:52.600648760Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 02:24:52.601147 containerd[1521]: time="2025-06-21T02:24:52.601132560Z" level=info msg="containerd successfully booted in 0.129237s" Jun 21 02:24:52.601149 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 02:24:53.307707 sshd_keygen[1511]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 21 02:24:53.328733 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 21 02:24:53.331274 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 21 02:24:53.358226 systemd[1]: issuegen.service: Deactivated successfully. Jun 21 02:24:53.358449 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 21 02:24:53.360878 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 21 02:24:53.390851 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 21 02:24:53.393398 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 21 02:24:53.395375 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jun 21 02:24:53.396532 systemd[1]: Reached target getty.target - Login Prompts. Jun 21 02:24:53.730489 systemd-networkd[1435]: eth0: Gained IPv6LL Jun 21 02:24:53.733778 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 21 02:24:53.736158 systemd[1]: Reached target network-online.target - Network is Online. Jun 21 02:24:53.739077 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 21 02:24:53.741599 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 02:24:53.752931 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 21 02:24:53.768406 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 21 02:24:53.768636 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 21 02:24:53.770012 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 21 02:24:53.776641 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 21 02:24:54.304866 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 02:24:54.306196 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 21 02:24:54.307145 systemd[1]: Startup finished in 2.113s (kernel) + 4.838s (initrd) + 3.896s (userspace) = 10.848s. Jun 21 02:24:54.308925 (kubelet)[1626]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jun 21 02:24:54.741226 kubelet[1626]: E0621 02:24:54.741147 1626 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" Jun 21 02:24:54.743598 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jun 21 02:24:54.743766 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jun 21 02:24:54.744180 systemd[1]: kubelet.service: Consumed 823ms CPU time, 259.3M memory peak. Jun 21 02:24:58.967247 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 21 02:24:58.968719 systemd[1]: Started sshd@0-10.0.0.94:22-10.0.0.1:54992.service - OpenSSH per-connection server daemon (10.0.0.1:54992). Jun 21 02:24:59.047029 sshd[1639]: Accepted publickey for core from 10.0.0.1 port 54992 ssh2: RSA SHA256:cK5ARV3AJBHTmh81JhwZP4PCHdHkiRblNCYNaKoXxA8 Jun 21 02:24:59.049047 sshd-session[1639]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 02:24:59.055076 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 21 02:24:59.056089 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 21 02:24:59.062743 systemd-logind[1503]: New session 1 of user core. Jun 21 02:24:59.080292 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 21 02:24:59.083572 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 21 02:24:59.100823 (systemd)[1643]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 21 02:24:59.103474 systemd-logind[1503]: New session c1 of user core. Jun 21 02:24:59.219048 systemd[1643]: Queued start job for default target default.target. Jun 21 02:24:59.228635 systemd[1643]: Created slice app.slice - User Application Slice. Jun 21 02:24:59.228689 systemd[1643]: Reached target paths.target - Paths. Jun 21 02:24:59.228730 systemd[1643]: Reached target timers.target - Timers. Jun 21 02:24:59.230038 systemd[1643]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 02:24:59.239350 systemd[1643]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 02:24:59.239419 systemd[1643]: Reached target sockets.target - Sockets. Jun 21 02:24:59.239461 systemd[1643]: Reached target basic.target - Basic System. Jun 21 02:24:59.239490 systemd[1643]: Reached target default.target - Main User Target. Jun 21 02:24:59.239520 systemd[1643]: Startup finished in 130ms. Jun 21 02:24:59.239758 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 21 02:24:59.241586 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 21 02:24:59.300978 systemd[1]: Started sshd@1-10.0.0.94:22-10.0.0.1:54994.service - OpenSSH per-connection server daemon (10.0.0.1:54994). Jun 21 02:24:59.347116 sshd[1654]: Accepted publickey for core from 10.0.0.1 port 54994 ssh2: RSA SHA256:cK5ARV3AJBHTmh81JhwZP4PCHdHkiRblNCYNaKoXxA8 Jun 21 02:24:59.348492 sshd-session[1654]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 02:24:59.353691 systemd-logind[1503]: New session 2 of user core. Jun 21 02:24:59.367849 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 21 02:24:59.420522 sshd[1656]: Connection closed by 10.0.0.1 port 54994 Jun 21 02:24:59.421023 sshd-session[1654]: pam_unix(sshd:session): session closed for user core Jun 21 02:24:59.438876 systemd[1]: sshd@1-10.0.0.94:22-10.0.0.1:54994.service: Deactivated successfully. Jun 21 02:24:59.441101 systemd[1]: session-2.scope: Deactivated successfully. Jun 21 02:24:59.442734 systemd-logind[1503]: Session 2 logged out. Waiting for processes to exit. Jun 21 02:24:59.444422 systemd[1]: Started sshd@2-10.0.0.94:22-10.0.0.1:55008.service - OpenSSH per-connection server daemon (10.0.0.1:55008). Jun 21 02:24:59.445489 systemd-logind[1503]: Removed session 2. Jun 21 02:24:59.498908 sshd[1662]: Accepted publickey for core from 10.0.0.1 port 55008 ssh2: RSA SHA256:cK5ARV3AJBHTmh81JhwZP4PCHdHkiRblNCYNaKoXxA8 Jun 21 02:24:59.500211 sshd-session[1662]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 02:24:59.505216 systemd-logind[1503]: New session 3 of user core. Jun 21 02:24:59.512877 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 21 02:24:59.561390 sshd[1664]: Connection closed by 10.0.0.1 port 55008 Jun 21 02:24:59.561725 sshd-session[1662]: pam_unix(sshd:session): session closed for user core Jun 21 02:24:59.573178 systemd[1]: sshd@2-10.0.0.94:22-10.0.0.1:55008.service: Deactivated successfully. Jun 21 02:24:59.574820 systemd[1]: session-3.scope: Deactivated successfully. Jun 21 02:24:59.575559 systemd-logind[1503]: Session 3 logged out. Waiting for processes to exit. Jun 21 02:24:59.578407 systemd[1]: Started sshd@3-10.0.0.94:22-10.0.0.1:55012.service - OpenSSH per-connection server daemon (10.0.0.1:55012). Jun 21 02:24:59.579250 systemd-logind[1503]: Removed session 3. Jun 21 02:24:59.639563 sshd[1670]: Accepted publickey for core from 10.0.0.1 port 55012 ssh2: RSA SHA256:cK5ARV3AJBHTmh81JhwZP4PCHdHkiRblNCYNaKoXxA8 Jun 21 02:24:59.640924 sshd-session[1670]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 02:24:59.645077 systemd-logind[1503]: New session 4 of user core. Jun 21 02:24:59.655869 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 21 02:24:59.708476 sshd[1673]: Connection closed by 10.0.0.1 port 55012 Jun 21 02:24:59.708810 sshd-session[1670]: pam_unix(sshd:session): session closed for user core Jun 21 02:24:59.721924 systemd[1]: sshd@3-10.0.0.94:22-10.0.0.1:55012.service: Deactivated successfully. Jun 21 02:24:59.724104 systemd[1]: session-4.scope: Deactivated successfully. Jun 21 02:24:59.725638 systemd-logind[1503]: Session 4 logged out. Waiting for processes to exit. Jun 21 02:24:59.727148 systemd[1]: Started sshd@4-10.0.0.94:22-10.0.0.1:55026.service - OpenSSH per-connection server daemon (10.0.0.1:55026). Jun 21 02:24:59.728037 systemd-logind[1503]: Removed session 4. Jun 21 02:24:59.783566 sshd[1679]: Accepted publickey for core from 10.0.0.1 port 55026 ssh2: RSA SHA256:cK5ARV3AJBHTmh81JhwZP4PCHdHkiRblNCYNaKoXxA8 Jun 21 02:24:59.785107 sshd-session[1679]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 02:24:59.789618 systemd-logind[1503]: New session 5 of user core. Jun 21 02:24:59.797866 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 21 02:24:59.858579 sudo[1682]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jun 21 02:24:59.858866 sudo[1682]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 02:24:59.868811 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 21 02:24:59.894208 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 21 02:24:59.894444 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 21 02:25:00.343576 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 02:25:00.343749 systemd[1]: kubelet.service: Consumed 823ms CPU time, 259.3M memory peak. Jun 21 02:25:00.345895 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 02:25:00.373177 systemd[1]: Reload requested from client PID 1726 ('systemctl') (unit session-5.scope)... Jun 21 02:25:00.373195 systemd[1]: Reloading... Jun 21 02:25:00.444710 zram_generator::config[1767]: No configuration found. Jun 21 02:25:00.620709 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jun 21 02:25:00.706302 systemd[1]: Reloading finished in 332 ms. Jun 21 02:25:00.776192 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jun 21 02:25:00.776280 systemd[1]: kubelet.service: Failed with result 'signal'. Jun 21 02:25:00.777686 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 02:25:00.777738 systemd[1]: kubelet.service: Consumed 97ms CPU time, 95M memory peak. Jun 21 02:25:00.779380 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 02:25:00.900852 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 02:25:00.909061 (kubelet)[1813]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jun 21 02:25:00.945747 kubelet[1813]: 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. Jun 21 02:25:00.945747 kubelet[1813]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Jun 21 02:25:00.945747 kubelet[1813]: 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. Jun 21 02:25:00.946097 kubelet[1813]: I0621 02:25:00.945793 1813 server.go:212] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jun 21 02:25:01.823966 kubelet[1813]: I0621 02:25:01.823911 1813 server.go:530] "Kubelet version" kubeletVersion="v1.33.0" Jun 21 02:25:01.823966 kubelet[1813]: I0621 02:25:01.823943 1813 server.go:532] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jun 21 02:25:01.824225 kubelet[1813]: I0621 02:25:01.824192 1813 server.go:956] "Client rotation is on, will bootstrap in background" Jun 21 02:25:01.855009 kubelet[1813]: I0621 02:25:01.854969 1813 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jun 21 02:25:01.870010 kubelet[1813]: I0621 02:25:01.869984 1813 server.go:1446] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Jun 21 02:25:01.872605 kubelet[1813]: I0621 02:25:01.872568 1813 server.go:782] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jun 21 02:25:01.874377 kubelet[1813]: I0621 02:25:01.874327 1813 container_manager_linux.go:267] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jun 21 02:25:01.874559 kubelet[1813]: I0621 02:25:01.874377 1813 container_manager_linux.go:272] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.94","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Jun 21 02:25:01.874678 kubelet[1813]: I0621 02:25:01.874612 1813 topology_manager.go:138] "Creating topology manager with none policy" Jun 21 02:25:01.874678 kubelet[1813]: I0621 02:25:01.874621 1813 container_manager_linux.go:303] "Creating device plugin manager" Jun 21 02:25:01.875826 kubelet[1813]: I0621 02:25:01.875475 1813 state_mem.go:36] "Initialized new in-memory state store" Jun 21 02:25:01.878935 kubelet[1813]: I0621 02:25:01.878909 1813 kubelet.go:480] "Attempting to sync node with API server" Jun 21 02:25:01.878996 kubelet[1813]: I0621 02:25:01.878939 1813 kubelet.go:375] "Adding static pod path" path="/etc/kubernetes/manifests" Jun 21 02:25:01.880626 kubelet[1813]: I0621 02:25:01.880596 1813 kubelet.go:386] "Adding apiserver pod source" Jun 21 02:25:01.881708 kubelet[1813]: I0621 02:25:01.881683 1813 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jun 21 02:25:01.881755 kubelet[1813]: E0621 02:25:01.881729 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:01.881755 kubelet[1813]: E0621 02:25:01.881685 1813 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:01.882942 kubelet[1813]: I0621 02:25:01.882914 1813 kuberuntime_manager.go:279] "Container runtime initialized" containerRuntime="containerd" version="v2.0.4" apiVersion="v1" Jun 21 02:25:01.883773 kubelet[1813]: I0621 02:25:01.883751 1813 kubelet.go:935] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Jun 21 02:25:01.883908 kubelet[1813]: W0621 02:25:01.883880 1813 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jun 21 02:25:01.887774 kubelet[1813]: I0621 02:25:01.887745 1813 watchdog_linux.go:99] "Systemd watchdog is not enabled" Jun 21 02:25:01.887870 kubelet[1813]: I0621 02:25:01.887830 1813 server.go:1289] "Started kubelet" Jun 21 02:25:01.890730 kubelet[1813]: I0621 02:25:01.890643 1813 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jun 21 02:25:01.891128 kubelet[1813]: I0621 02:25:01.891090 1813 server.go:255] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jun 21 02:25:01.891128 kubelet[1813]: I0621 02:25:01.891110 1813 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Jun 21 02:25:01.892257 kubelet[1813]: I0621 02:25:01.892141 1813 server.go:317] "Adding debug handlers to kubelet server" Jun 21 02:25:01.893737 kubelet[1813]: I0621 02:25:01.892929 1813 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jun 21 02:25:01.898336 kubelet[1813]: I0621 02:25:01.896161 1813 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jun 21 02:25:01.898336 kubelet[1813]: E0621 02:25:01.896904 1813 kubelet.go:1600] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jun 21 02:25:01.898336 kubelet[1813]: E0621 02:25:01.896946 1813 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.94\" not found" Jun 21 02:25:01.898336 kubelet[1813]: I0621 02:25:01.896964 1813 volume_manager.go:297] "Starting Kubelet Volume Manager" Jun 21 02:25:01.898336 kubelet[1813]: I0621 02:25:01.897178 1813 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Jun 21 02:25:01.898336 kubelet[1813]: I0621 02:25:01.897226 1813 reconciler.go:26] "Reconciler: start to sync state" Jun 21 02:25:01.899206 kubelet[1813]: I0621 02:25:01.899165 1813 factory.go:223] Registration of the systemd container factory successfully Jun 21 02:25:01.899320 kubelet[1813]: I0621 02:25:01.899295 1813 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Jun 21 02:25:01.900775 kubelet[1813]: I0621 02:25:01.900739 1813 factory.go:223] Registration of the containerd container factory successfully Jun 21 02:25:01.909609 kubelet[1813]: E0621 02:25:01.909562 1813 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.94\" not found" node="10.0.0.94" Jun 21 02:25:01.911287 kubelet[1813]: I0621 02:25:01.911264 1813 cpu_manager.go:221] "Starting CPU manager" policy="none" Jun 21 02:25:01.911440 kubelet[1813]: I0621 02:25:01.911327 1813 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Jun 21 02:25:01.911440 kubelet[1813]: I0621 02:25:01.911366 1813 state_mem.go:36] "Initialized new in-memory state store" Jun 21 02:25:01.997679 kubelet[1813]: E0621 02:25:01.997621 1813 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.94\" not found" Jun 21 02:25:02.010766 kubelet[1813]: I0621 02:25:02.010705 1813 policy_none.go:49] "None policy: Start" Jun 21 02:25:02.010766 kubelet[1813]: I0621 02:25:02.010731 1813 memory_manager.go:186] "Starting memorymanager" policy="None" Jun 21 02:25:02.010766 kubelet[1813]: I0621 02:25:02.010745 1813 state_mem.go:35] "Initializing new in-memory state store" Jun 21 02:25:02.016674 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jun 21 02:25:02.029136 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jun 21 02:25:02.032611 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jun 21 02:25:02.042334 kubelet[1813]: I0621 02:25:02.042289 1813 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv4" Jun 21 02:25:02.043054 kubelet[1813]: E0621 02:25:02.042961 1813 manager.go:517] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Jun 21 02:25:02.043616 kubelet[1813]: I0621 02:25:02.043592 1813 eviction_manager.go:189] "Eviction manager: starting control loop" Jun 21 02:25:02.043731 kubelet[1813]: I0621 02:25:02.043700 1813 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jun 21 02:25:02.044380 kubelet[1813]: I0621 02:25:02.044103 1813 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv6" Jun 21 02:25:02.044380 kubelet[1813]: I0621 02:25:02.044140 1813 status_manager.go:230] "Starting to sync pod status with apiserver" Jun 21 02:25:02.044380 kubelet[1813]: I0621 02:25:02.044159 1813 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jun 21 02:25:02.044380 kubelet[1813]: I0621 02:25:02.044164 1813 kubelet.go:2436] "Starting kubelet main sync loop" Jun 21 02:25:02.044380 kubelet[1813]: E0621 02:25:02.044209 1813 kubelet.go:2460] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jun 21 02:25:02.044746 kubelet[1813]: I0621 02:25:02.044679 1813 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jun 21 02:25:02.046192 kubelet[1813]: E0621 02:25:02.046160 1813 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jun 21 02:25:02.046265 kubelet[1813]: E0621 02:25:02.046204 1813 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.94\" not found" Jun 21 02:25:02.144927 kubelet[1813]: I0621 02:25:02.144809 1813 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.94" Jun 21 02:25:02.158301 kubelet[1813]: I0621 02:25:02.157883 1813 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.94" Jun 21 02:25:02.270382 kubelet[1813]: I0621 02:25:02.270358 1813 kuberuntime_manager.go:1746] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jun 21 02:25:02.270951 containerd[1521]: time="2025-06-21T02:25:02.270913048Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jun 21 02:25:02.271472 kubelet[1813]: I0621 02:25:02.271108 1813 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jun 21 02:25:02.428748 sudo[1682]: pam_unix(sudo:session): session closed for user root Jun 21 02:25:02.430145 sshd[1681]: Connection closed by 10.0.0.1 port 55026 Jun 21 02:25:02.430477 sshd-session[1679]: pam_unix(sshd:session): session closed for user core Jun 21 02:25:02.434027 systemd-logind[1503]: Session 5 logged out. Waiting for processes to exit. Jun 21 02:25:02.434191 systemd[1]: sshd@4-10.0.0.94:22-10.0.0.1:55026.service: Deactivated successfully. Jun 21 02:25:02.436002 systemd[1]: session-5.scope: Deactivated successfully. Jun 21 02:25:02.436201 systemd[1]: session-5.scope: Consumed 456ms CPU time, 76.2M memory peak. Jun 21 02:25:02.437650 systemd-logind[1503]: Removed session 5. Jun 21 02:25:02.828333 kubelet[1813]: I0621 02:25:02.828298 1813 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jun 21 02:25:02.828463 kubelet[1813]: I0621 02:25:02.828448 1813 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jun 21 02:25:02.828514 kubelet[1813]: I0621 02:25:02.828493 1813 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jun 21 02:25:02.828544 kubelet[1813]: I0621 02:25:02.828522 1813 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jun 21 02:25:02.881941 kubelet[1813]: E0621 02:25:02.881883 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:02.881941 kubelet[1813]: I0621 02:25:02.881898 1813 apiserver.go:52] "Watching apiserver" Jun 21 02:25:02.896272 systemd[1]: Created slice kubepods-besteffort-pod4f8e552b_bb53_4f80_81ff_59c361c2ac91.slice - libcontainer container kubepods-besteffort-pod4f8e552b_bb53_4f80_81ff_59c361c2ac91.slice. Jun 21 02:25:02.897608 kubelet[1813]: I0621 02:25:02.897574 1813 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Jun 21 02:25:02.903934 kubelet[1813]: I0621 02:25:02.903863 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/4f8e552b-bb53-4f80-81ff-59c361c2ac91-kube-proxy\") pod \"kube-proxy-6xjpv\" (UID: \"4f8e552b-bb53-4f80-81ff-59c361c2ac91\") " pod="kube-system/kube-proxy-6xjpv" Jun 21 02:25:02.903934 kubelet[1813]: I0621 02:25:02.903900 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/4f8e552b-bb53-4f80-81ff-59c361c2ac91-lib-modules\") pod \"kube-proxy-6xjpv\" (UID: \"4f8e552b-bb53-4f80-81ff-59c361c2ac91\") " pod="kube-system/kube-proxy-6xjpv" Jun 21 02:25:02.903934 kubelet[1813]: I0621 02:25:02.903919 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gv7zk\" (UniqueName: \"kubernetes.io/projected/4f8e552b-bb53-4f80-81ff-59c361c2ac91-kube-api-access-gv7zk\") pod \"kube-proxy-6xjpv\" (UID: \"4f8e552b-bb53-4f80-81ff-59c361c2ac91\") " pod="kube-system/kube-proxy-6xjpv" Jun 21 02:25:02.903934 kubelet[1813]: I0621 02:25:02.903942 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/3f61dff0-9566-4d80-898e-2e7cae9612a3-run\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.904157 kubelet[1813]: I0621 02:25:02.903957 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/3f61dff0-9566-4d80-898e-2e7cae9612a3-cni\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.904157 kubelet[1813]: I0621 02:25:02.903972 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/3f61dff0-9566-4d80-898e-2e7cae9612a3-flannel-cfg\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.904157 kubelet[1813]: I0621 02:25:02.903986 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/4f8e552b-bb53-4f80-81ff-59c361c2ac91-xtables-lock\") pod \"kube-proxy-6xjpv\" (UID: \"4f8e552b-bb53-4f80-81ff-59c361c2ac91\") " pod="kube-system/kube-proxy-6xjpv" Jun 21 02:25:02.904157 kubelet[1813]: I0621 02:25:02.904001 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/3f61dff0-9566-4d80-898e-2e7cae9612a3-cni-plugin\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.904157 kubelet[1813]: I0621 02:25:02.904018 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/3f61dff0-9566-4d80-898e-2e7cae9612a3-xtables-lock\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.904264 kubelet[1813]: I0621 02:25:02.904033 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zls8c\" (UniqueName: \"kubernetes.io/projected/3f61dff0-9566-4d80-898e-2e7cae9612a3-kube-api-access-zls8c\") pod \"kube-flannel-ds-lcjgc\" (UID: \"3f61dff0-9566-4d80-898e-2e7cae9612a3\") " pod="kube-flannel/kube-flannel-ds-lcjgc" Jun 21 02:25:02.913491 systemd[1]: Created slice kubepods-burstable-pod3f61dff0_9566_4d80_898e_2e7cae9612a3.slice - libcontainer container kubepods-burstable-pod3f61dff0_9566_4d80_898e_2e7cae9612a3.slice. Jun 21 02:25:03.211561 kubelet[1813]: E0621 02:25:03.211521 1813 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" Jun 21 02:25:03.212494 containerd[1521]: time="2025-06-21T02:25:03.212230880Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-6xjpv,Uid:4f8e552b-bb53-4f80-81ff-59c361c2ac91,Namespace:kube-system,Attempt:0,}" Jun 21 02:25:03.225400 kubelet[1813]: E0621 02:25:03.225160 1813 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" Jun 21 02:25:03.225690 containerd[1521]: time="2025-06-21T02:25:03.225638932Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-lcjgc,Uid:3f61dff0-9566-4d80-898e-2e7cae9612a3,Namespace:kube-flannel,Attempt:0,}" Jun 21 02:25:03.752748 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1950657645.mount: Deactivated successfully. Jun 21 02:25:03.759078 containerd[1521]: time="2025-06-21T02:25:03.758754935Z" 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\"}" Jun 21 02:25:03.759993 containerd[1521]: time="2025-06-21T02:25:03.759930124Z" 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\"}" Jun 21 02:25:03.760569 containerd[1521]: time="2025-06-21T02:25:03.760525539Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=268705" Jun 21 02:25:03.761608 containerd[1521]: time="2025-06-21T02:25:03.761581467Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Jun 21 02:25:03.762466 containerd[1521]: time="2025-06-21T02:25:03.762425333Z" level=info msg="ImageCreate event name:\"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 21 02:25:03.764683 containerd[1521]: time="2025-06-21T02:25:03.764629108Z" 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\"}" Jun 21 02:25:03.766690 containerd[1521]: time="2025-06-21T02:25:03.766121465Z" 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 535.559705ms" Jun 21 02:25:03.766981 containerd[1521]: time="2025-06-21T02:25:03.766950856Z" 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 550.020991ms" Jun 21 02:25:03.782798 containerd[1521]: time="2025-06-21T02:25:03.782753112Z" level=info msg="connecting to shim 1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0" address="unix:///run/containerd/s/5dc4ca51093d9c7e193751362060a970b18d10fd8da47c46209785d7719710a2" namespace=k8s.io protocol=ttrpc version=3 Jun 21 02:25:03.783531 containerd[1521]: time="2025-06-21T02:25:03.783479528Z" level=info msg="connecting to shim ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039" address="unix:///run/containerd/s/a30d7f3038ecc74d42dd638d930610cc2da581365f56fa004d29174142fd713b" namespace=k8s.io protocol=ttrpc version=3 Jun 21 02:25:03.804826 systemd[1]: Started cri-containerd-ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039.scope - libcontainer container ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039. Jun 21 02:25:03.807586 systemd[1]: Started cri-containerd-1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0.scope - libcontainer container 1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0. Jun 21 02:25:03.829854 containerd[1521]: time="2025-06-21T02:25:03.829807006Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-6xjpv,Uid:4f8e552b-bb53-4f80-81ff-59c361c2ac91,Namespace:kube-system,Attempt:0,} returns sandbox id \"ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039\"" Jun 21 02:25:03.831046 kubelet[1813]: E0621 02:25:03.831019 1813 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" Jun 21 02:25:03.833218 containerd[1521]: time="2025-06-21T02:25:03.833184924Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.2\"" Jun 21 02:25:03.846071 containerd[1521]: time="2025-06-21T02:25:03.846029607Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-lcjgc,Uid:3f61dff0-9566-4d80-898e-2e7cae9612a3,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\"" Jun 21 02:25:03.846882 kubelet[1813]: E0621 02:25:03.846860 1813 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" Jun 21 02:25:03.882603 kubelet[1813]: E0621 02:25:03.882546 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:04.737499 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1683716576.mount: Deactivated successfully. Jun 21 02:25:04.883096 kubelet[1813]: E0621 02:25:04.883054 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:04.981174 containerd[1521]: time="2025-06-21T02:25:04.981123501Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.33.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:04.981808 containerd[1521]: time="2025-06-21T02:25:04.981779165Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.33.2: active requests=0, bytes read=28199474" Jun 21 02:25:04.982994 containerd[1521]: time="2025-06-21T02:25:04.982770959Z" level=info msg="ImageCreate event name:\"sha256:c26522e54bad2e6bfbb1bf11500833c94433076a3fa38436a2ec496a422c5455\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:04.985091 containerd[1521]: time="2025-06-21T02:25:04.985052904Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:4796ef3e43efa5ed2a5b015c18f81d3c2fe3aea36f555ea643cc01827eb65e51\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:04.985784 containerd[1521]: time="2025-06-21T02:25:04.985756385Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.33.2\" with image id \"sha256:c26522e54bad2e6bfbb1bf11500833c94433076a3fa38436a2ec496a422c5455\", repo tag \"registry.k8s.io/kube-proxy:v1.33.2\", repo digest \"registry.k8s.io/kube-proxy@sha256:4796ef3e43efa5ed2a5b015c18f81d3c2fe3aea36f555ea643cc01827eb65e51\", size \"28198491\" in 1.152529892s" Jun 21 02:25:04.985848 containerd[1521]: time="2025-06-21T02:25:04.985788612Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.2\" returns image reference \"sha256:c26522e54bad2e6bfbb1bf11500833c94433076a3fa38436a2ec496a422c5455\"" Jun 21 02:25:04.986991 containerd[1521]: time="2025-06-21T02:25:04.986966372Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Jun 21 02:25:04.989445 containerd[1521]: time="2025-06-21T02:25:04.989342907Z" level=info msg="CreateContainer within sandbox \"ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jun 21 02:25:04.996908 containerd[1521]: time="2025-06-21T02:25:04.996873137Z" level=info msg="Container 92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:05.003630 containerd[1521]: time="2025-06-21T02:25:05.003583187Z" level=info msg="CreateContainer within sandbox \"ca36f4d4747c6d41d151a2e84354f213ccf7d9eb3dbd83dbec6151164405a039\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930\"" Jun 21 02:25:05.004493 containerd[1521]: time="2025-06-21T02:25:05.004455302Z" level=info msg="StartContainer for \"92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930\"" Jun 21 02:25:05.005836 containerd[1521]: time="2025-06-21T02:25:05.005811104Z" level=info msg="connecting to shim 92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930" address="unix:///run/containerd/s/a30d7f3038ecc74d42dd638d930610cc2da581365f56fa004d29174142fd713b" protocol=ttrpc version=3 Jun 21 02:25:05.027822 systemd[1]: Started cri-containerd-92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930.scope - libcontainer container 92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930. Jun 21 02:25:05.061899 containerd[1521]: time="2025-06-21T02:25:05.061829784Z" level=info msg="StartContainer for \"92375160806260ae70c18e6ad6315e272e9add70276255218a275d8cbc4eb930\" returns successfully" Jun 21 02:25:05.884129 kubelet[1813]: E0621 02:25:05.884082 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:06.064160 kubelet[1813]: E0621 02:25:06.064074 1813 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" Jun 21 02:25:06.117655 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount403820641.mount: Deactivated successfully. Jun 21 02:25:06.146313 containerd[1521]: time="2025-06-21T02:25:06.146055439Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:06.147118 containerd[1521]: time="2025-06-21T02:25:06.147089165Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Jun 21 02:25:06.147946 containerd[1521]: time="2025-06-21T02:25:06.147924920Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:06.151147 containerd[1521]: time="2025-06-21T02:25:06.151097225Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:06.152351 containerd[1521]: time="2025-06-21T02:25:06.151984119Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"5125394\" in 1.164984686s" Jun 21 02:25:06.152351 containerd[1521]: time="2025-06-21T02:25:06.152014947Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Jun 21 02:25:06.156017 containerd[1521]: time="2025-06-21T02:25:06.155982867Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jun 21 02:25:06.163192 containerd[1521]: time="2025-06-21T02:25:06.163158657Z" level=info msg="Container 34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:06.165647 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1819895099.mount: Deactivated successfully. Jun 21 02:25:06.169586 containerd[1521]: time="2025-06-21T02:25:06.169553041Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\"" Jun 21 02:25:06.170107 containerd[1521]: time="2025-06-21T02:25:06.170077510Z" level=info msg="StartContainer for \"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\"" Jun 21 02:25:06.170898 containerd[1521]: time="2025-06-21T02:25:06.170868630Z" level=info msg="connecting to shim 34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc" address="unix:///run/containerd/s/5dc4ca51093d9c7e193751362060a970b18d10fd8da47c46209785d7719710a2" protocol=ttrpc version=3 Jun 21 02:25:06.195821 systemd[1]: Started cri-containerd-34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc.scope - libcontainer container 34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc. Jun 21 02:25:06.221052 containerd[1521]: time="2025-06-21T02:25:06.221019519Z" level=info msg="StartContainer for \"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\" returns successfully" Jun 21 02:25:06.226267 systemd[1]: cri-containerd-34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc.scope: Deactivated successfully. Jun 21 02:25:06.227933 containerd[1521]: time="2025-06-21T02:25:06.227896226Z" level=info msg="TaskExit event in podsandbox handler container_id:\"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\" id:\"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\" pid:2152 exited_at:{seconds:1750472706 nanos:227421129}" Jun 21 02:25:06.228152 containerd[1521]: time="2025-06-21T02:25:06.228026320Z" level=info msg="received exit event container_id:\"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\" id:\"34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc\" pid:2152 exited_at:{seconds:1750472706 nanos:227421129}" Jun 21 02:25:06.884783 kubelet[1813]: E0621 02:25:06.884747 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:07.051320 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-34e5633cd3c250f841258916f1a199496fb38d5f7ed27d6b539f34ba9a6668fc-rootfs.mount: Deactivated successfully. Jun 21 02:25:07.067124 kubelet[1813]: E0621 02:25:07.067044 1813 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" Jun 21 02:25:07.067124 kubelet[1813]: E0621 02:25:07.067081 1813 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" Jun 21 02:25:07.067777 containerd[1521]: time="2025-06-21T02:25:07.067726103Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Jun 21 02:25:07.076549 kubelet[1813]: I0621 02:25:07.076425 1813 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-6xjpv" podStartSLOduration=3.921484426 podStartE2EDuration="5.076410459s" podCreationTimestamp="2025-06-21 02:25:02 +0000 UTC" firstStartedPulling="2025-06-21 02:25:03.831861606 +0000 UTC m=+2.918643059" lastFinishedPulling="2025-06-21 02:25:04.986787679 +0000 UTC m=+4.073569092" observedRunningTime="2025-06-21 02:25:06.071964364 +0000 UTC m=+5.158745858" watchObservedRunningTime="2025-06-21 02:25:07.076410459 +0000 UTC m=+6.163191912" Jun 21 02:25:07.885856 kubelet[1813]: E0621 02:25:07.885828 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:08.494541 containerd[1521]: time="2025-06-21T02:25:08.494497600Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:08.495416 containerd[1521]: time="2025-06-21T02:25:08.494940985Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Jun 21 02:25:08.496052 containerd[1521]: time="2025-06-21T02:25:08.496023999Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:08.500038 containerd[1521]: time="2025-06-21T02:25:08.500009331Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:08.501244 containerd[1521]: time="2025-06-21T02:25:08.501220528Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32412118\" in 1.433438658s" Jun 21 02:25:08.501370 containerd[1521]: time="2025-06-21T02:25:08.501334312Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Jun 21 02:25:08.505030 containerd[1521]: time="2025-06-21T02:25:08.504728183Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jun 21 02:25:08.509598 containerd[1521]: time="2025-06-21T02:25:08.509570205Z" level=info msg="Container 5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:08.517139 containerd[1521]: time="2025-06-21T02:25:08.517104823Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\"" Jun 21 02:25:08.517847 containerd[1521]: time="2025-06-21T02:25:08.517812274Z" level=info msg="StartContainer for \"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\"" Jun 21 02:25:08.518595 containerd[1521]: time="2025-06-21T02:25:08.518571784Z" level=info msg="connecting to shim 5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07" address="unix:///run/containerd/s/5dc4ca51093d9c7e193751362060a970b18d10fd8da47c46209785d7719710a2" protocol=ttrpc version=3 Jun 21 02:25:08.531797 systemd[1]: Started cri-containerd-5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07.scope - libcontainer container 5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07. Jun 21 02:25:08.559493 systemd[1]: cri-containerd-5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07.scope: Deactivated successfully. Jun 21 02:25:08.562603 containerd[1521]: time="2025-06-21T02:25:08.562508696Z" level=info msg="received exit event container_id:\"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\" id:\"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\" pid:2229 exited_at:{seconds:1750472708 nanos:562068519}" Jun 21 02:25:08.562603 containerd[1521]: time="2025-06-21T02:25:08.562538656Z" level=info msg="TaskExit event in podsandbox handler container_id:\"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\" id:\"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\" pid:2229 exited_at:{seconds:1750472708 nanos:562068519}" Jun 21 02:25:08.563085 containerd[1521]: time="2025-06-21T02:25:08.563047375Z" level=info msg="StartContainer for \"5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07\" returns successfully" Jun 21 02:25:08.577989 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-5500c4a0acebcd1e9ec03b2414456e4851d3e7f714a264f3fc5568ea0b37eb07-rootfs.mount: Deactivated successfully. Jun 21 02:25:08.585614 kubelet[1813]: I0621 02:25:08.585586 1813 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Jun 21 02:25:08.886139 kubelet[1813]: E0621 02:25:08.885998 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:09.072048 kubelet[1813]: E0621 02:25:09.071966 1813 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" Jun 21 02:25:09.075208 containerd[1521]: time="2025-06-21T02:25:09.075163826Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jun 21 02:25:09.082602 containerd[1521]: time="2025-06-21T02:25:09.082529617Z" level=info msg="Container 3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:09.088289 containerd[1521]: time="2025-06-21T02:25:09.088238172Z" level=info msg="CreateContainer within sandbox \"1a5beb094abc117e7c1852271a188b735517361cf647bd2ea0ce6e4e0d2646b0\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa\"" Jun 21 02:25:09.088693 containerd[1521]: time="2025-06-21T02:25:09.088669742Z" level=info msg="StartContainer for \"3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa\"" Jun 21 02:25:09.089557 containerd[1521]: time="2025-06-21T02:25:09.089530115Z" level=info msg="connecting to shim 3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa" address="unix:///run/containerd/s/5dc4ca51093d9c7e193751362060a970b18d10fd8da47c46209785d7719710a2" protocol=ttrpc version=3 Jun 21 02:25:09.107800 systemd[1]: Started cri-containerd-3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa.scope - libcontainer container 3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa. Jun 21 02:25:09.132127 containerd[1521]: time="2025-06-21T02:25:09.131509683Z" level=info msg="StartContainer for \"3c214063f06c485ee0b2ec4d4abb46f9238c97fdad8b05f5ebd0631d91eb9faa\" returns successfully" Jun 21 02:25:09.886859 kubelet[1813]: E0621 02:25:09.886809 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:10.077681 kubelet[1813]: E0621 02:25:10.075913 1813 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" Jun 21 02:25:10.086071 kubelet[1813]: I0621 02:25:10.086012 1813 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-lcjgc" podStartSLOduration=3.4310567929999998 podStartE2EDuration="8.085971684s" podCreationTimestamp="2025-06-21 02:25:02 +0000 UTC" firstStartedPulling="2025-06-21 02:25:03.847428398 +0000 UTC m=+2.934209851" lastFinishedPulling="2025-06-21 02:25:08.502343289 +0000 UTC m=+7.589124742" observedRunningTime="2025-06-21 02:25:10.085956653 +0000 UTC m=+9.172738066" watchObservedRunningTime="2025-06-21 02:25:10.085971684 +0000 UTC m=+9.172753137" Jun 21 02:25:10.228557 systemd-networkd[1435]: flannel.1: Link UP Jun 21 02:25:10.228565 systemd-networkd[1435]: flannel.1: Gained carrier Jun 21 02:25:10.887109 kubelet[1813]: E0621 02:25:10.887064 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:11.077409 kubelet[1813]: E0621 02:25:11.077385 1813 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" Jun 21 02:25:11.713792 systemd-networkd[1435]: flannel.1: Gained IPv6LL Jun 21 02:25:11.888101 kubelet[1813]: E0621 02:25:11.888054 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:12.888482 kubelet[1813]: E0621 02:25:12.888407 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:13.360314 systemd[1]: Created slice kubepods-besteffort-pod160e3242_b6bb_431f_a5c8_b6560143cf82.slice - libcontainer container kubepods-besteffort-pod160e3242_b6bb_431f_a5c8_b6560143cf82.slice. Jun 21 02:25:13.467598 kubelet[1813]: I0621 02:25:13.467561 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hh4xj\" (UniqueName: \"kubernetes.io/projected/160e3242-b6bb-431f-a5c8-b6560143cf82-kube-api-access-hh4xj\") pod \"nginx-deployment-7fcdb87857-tw5tt\" (UID: \"160e3242-b6bb-431f-a5c8-b6560143cf82\") " pod="default/nginx-deployment-7fcdb87857-tw5tt" Jun 21 02:25:13.663674 containerd[1521]: time="2025-06-21T02:25:13.663550174Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-tw5tt,Uid:160e3242-b6bb-431f-a5c8-b6560143cf82,Namespace:default,Attempt:0,}" Jun 21 02:25:13.718889 systemd-networkd[1435]: cni0: Link UP Jun 21 02:25:13.718896 systemd-networkd[1435]: cni0: Gained carrier Jun 21 02:25:13.721001 systemd-networkd[1435]: cni0: Lost carrier Jun 21 02:25:13.726139 systemd-networkd[1435]: veth60dfbeaa: Link UP Jun 21 02:25:13.727824 kernel: cni0: port 1(veth60dfbeaa) entered blocking state Jun 21 02:25:13.729823 kernel: cni0: port 1(veth60dfbeaa) entered disabled state Jun 21 02:25:13.729872 kernel: veth60dfbeaa: entered allmulticast mode Jun 21 02:25:13.729896 kernel: veth60dfbeaa: entered promiscuous mode Jun 21 02:25:13.743627 systemd-networkd[1435]: veth60dfbeaa: Gained carrier Jun 21 02:25:13.743827 kernel: cni0: port 1(veth60dfbeaa) entered blocking state Jun 21 02:25:13.743873 kernel: cni0: port 1(veth60dfbeaa) entered forwarding state Jun 21 02:25:13.744077 systemd-networkd[1435]: cni0: Gained carrier Jun 21 02:25:13.746211 containerd[1521]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400009a950), "name":"cbr0", "type":"bridge"} Jun 21 02:25:13.746211 containerd[1521]: delegateAdd: netconf sent to delegate plugin: Jun 21 02:25:13.775263 containerd[1521]: {"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-06-21T02:25:13.774788186Z" level=info msg="connecting to shim b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9" address="unix:///run/containerd/s/75325a735a0190d2d0de78ba1e859ea8f3a6a288d129bc147215f7e30a8dd826" namespace=k8s.io protocol=ttrpc version=3 Jun 21 02:25:13.796820 systemd[1]: Started cri-containerd-b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9.scope - libcontainer container b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9. Jun 21 02:25:13.806989 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 02:25:13.825310 containerd[1521]: time="2025-06-21T02:25:13.825271322Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-tw5tt,Uid:160e3242-b6bb-431f-a5c8-b6560143cf82,Namespace:default,Attempt:0,} returns sandbox id \"b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9\"" Jun 21 02:25:13.826461 containerd[1521]: time="2025-06-21T02:25:13.826437803Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 21 02:25:13.889290 kubelet[1813]: E0621 02:25:13.889238 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:14.890092 kubelet[1813]: E0621 02:25:14.890040 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:14.913834 systemd-networkd[1435]: cni0: Gained IPv6LL Jun 21 02:25:15.654778 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2876270168.mount: Deactivated successfully. Jun 21 02:25:15.681824 systemd-networkd[1435]: veth60dfbeaa: Gained IPv6LL Jun 21 02:25:15.890755 kubelet[1813]: E0621 02:25:15.890653 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:16.301939 containerd[1521]: time="2025-06-21T02:25:16.301896411Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:16.302872 containerd[1521]: time="2025-06-21T02:25:16.302802845Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69950600" Jun 21 02:25:16.303367 containerd[1521]: time="2025-06-21T02:25:16.303323324Z" level=info msg="ImageCreate event name:\"sha256:e55a872cbf1b1d996b1d5333796fbe6ec0b825868f3ad30b387fc65697ed40dd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:16.306534 containerd[1521]: time="2025-06-21T02:25:16.306481870Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:16.310641 containerd[1521]: time="2025-06-21T02:25:16.310544728Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e55a872cbf1b1d996b1d5333796fbe6ec0b825868f3ad30b387fc65697ed40dd\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\", size \"69950478\" in 2.484071883s" Jun 21 02:25:16.310641 containerd[1521]: time="2025-06-21T02:25:16.310586847Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e55a872cbf1b1d996b1d5333796fbe6ec0b825868f3ad30b387fc65697ed40dd\"" Jun 21 02:25:16.314131 containerd[1521]: time="2025-06-21T02:25:16.314087067Z" level=info msg="CreateContainer within sandbox \"b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jun 21 02:25:16.320611 containerd[1521]: time="2025-06-21T02:25:16.320105123Z" level=info msg="Container 219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:16.325768 containerd[1521]: time="2025-06-21T02:25:16.325722771Z" level=info msg="CreateContainer within sandbox \"b8278b0632d4559ecfe9128ba550e6c16b3ad0693dd1210377dc9f5f819b88b9\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3\"" Jun 21 02:25:16.326298 containerd[1521]: time="2025-06-21T02:25:16.326165219Z" level=info msg="StartContainer for \"219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3\"" Jun 21 02:25:16.327158 containerd[1521]: time="2025-06-21T02:25:16.327133910Z" level=info msg="connecting to shim 219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3" address="unix:///run/containerd/s/75325a735a0190d2d0de78ba1e859ea8f3a6a288d129bc147215f7e30a8dd826" protocol=ttrpc version=3 Jun 21 02:25:16.345822 systemd[1]: Started cri-containerd-219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3.scope - libcontainer container 219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3. Jun 21 02:25:16.374730 containerd[1521]: time="2025-06-21T02:25:16.374686658Z" level=info msg="StartContainer for \"219ce1f3c4388235c018ad36cd31e49950a1edf6b7aa4da824bf67e3bacc60c3\" returns successfully" Jun 21 02:25:16.891372 kubelet[1813]: E0621 02:25:16.891313 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:17.098588 kubelet[1813]: I0621 02:25:17.098525 1813 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-tw5tt" podStartSLOduration=1.612859429 podStartE2EDuration="4.098501201s" podCreationTimestamp="2025-06-21 02:25:13 +0000 UTC" firstStartedPulling="2025-06-21 02:25:13.826006571 +0000 UTC m=+12.912788024" lastFinishedPulling="2025-06-21 02:25:16.311648343 +0000 UTC m=+15.398429796" observedRunningTime="2025-06-21 02:25:17.098277461 +0000 UTC m=+16.185058914" watchObservedRunningTime="2025-06-21 02:25:17.098501201 +0000 UTC m=+16.185282654" Jun 21 02:25:17.892310 kubelet[1813]: E0621 02:25:17.892259 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:18.892699 kubelet[1813]: E0621 02:25:18.892613 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:19.893370 kubelet[1813]: E0621 02:25:19.893329 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:19.930711 systemd[1]: Created slice kubepods-besteffort-podd53a2be7_1778_441b_af85_173609340fde.slice - libcontainer container kubepods-besteffort-podd53a2be7_1778_441b_af85_173609340fde.slice. Jun 21 02:25:20.002775 kubelet[1813]: I0621 02:25:20.002721 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/d53a2be7-1778-441b-af85-173609340fde-data\") pod \"nfs-server-provisioner-0\" (UID: \"d53a2be7-1778-441b-af85-173609340fde\") " pod="default/nfs-server-provisioner-0" Jun 21 02:25:20.002775 kubelet[1813]: I0621 02:25:20.002773 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-fr9rc\" (UniqueName: \"kubernetes.io/projected/d53a2be7-1778-441b-af85-173609340fde-kube-api-access-fr9rc\") pod \"nfs-server-provisioner-0\" (UID: \"d53a2be7-1778-441b-af85-173609340fde\") " pod="default/nfs-server-provisioner-0" Jun 21 02:25:20.234335 containerd[1521]: time="2025-06-21T02:25:20.234280274Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:d53a2be7-1778-441b-af85-173609340fde,Namespace:default,Attempt:0,}" Jun 21 02:25:20.246497 systemd-networkd[1435]: veth5838cbdc: Link UP Jun 21 02:25:20.248701 kernel: cni0: port 2(veth5838cbdc) entered blocking state Jun 21 02:25:20.248759 kernel: cni0: port 2(veth5838cbdc) entered disabled state Jun 21 02:25:20.248780 kernel: veth5838cbdc: entered allmulticast mode Jun 21 02:25:20.249670 kernel: veth5838cbdc: entered promiscuous mode Jun 21 02:25:20.255681 kernel: cni0: port 2(veth5838cbdc) entered blocking state Jun 21 02:25:20.255741 kernel: cni0: port 2(veth5838cbdc) entered forwarding state Jun 21 02:25:20.256034 systemd-networkd[1435]: veth5838cbdc: Gained carrier Jun 21 02:25:20.257763 containerd[1521]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Jun 21 02:25:20.257763 containerd[1521]: delegateAdd: netconf sent to delegate plugin: Jun 21 02:25:20.276853 containerd[1521]: {"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-06-21T02:25:20.276815582Z" level=info msg="connecting to shim 170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6" address="unix:///run/containerd/s/cc21ed312eddb34312486ea4379d9519260c00865b7c56044bfde382a2e030fd" namespace=k8s.io protocol=ttrpc version=3 Jun 21 02:25:20.294789 systemd[1]: Started cri-containerd-170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6.scope - libcontainer container 170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6. Jun 21 02:25:20.304457 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 02:25:20.321816 containerd[1521]: time="2025-06-21T02:25:20.321741018Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:d53a2be7-1778-441b-af85-173609340fde,Namespace:default,Attempt:0,} returns sandbox id \"170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6\"" Jun 21 02:25:20.323615 containerd[1521]: time="2025-06-21T02:25:20.323565402Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jun 21 02:25:20.894043 kubelet[1813]: E0621 02:25:20.893983 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:21.881160 kubelet[1813]: E0621 02:25:21.881118 1813 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:21.894694 kubelet[1813]: E0621 02:25:21.894638 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:22.017827 systemd-networkd[1435]: veth5838cbdc: Gained IPv6LL Jun 21 02:25:22.132185 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount350969068.mount: Deactivated successfully. Jun 21 02:25:22.894972 kubelet[1813]: E0621 02:25:22.894928 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:23.444235 containerd[1521]: time="2025-06-21T02:25:23.444180110Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:23.444969 containerd[1521]: time="2025-06-21T02:25:23.444941545Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625" Jun 21 02:25:23.445598 containerd[1521]: time="2025-06-21T02:25:23.445562930Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:23.448436 containerd[1521]: time="2025-06-21T02:25:23.448396874Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:23.448937 containerd[1521]: time="2025-06-21T02:25:23.448905938Z" 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.125288989s" Jun 21 02:25:23.448937 containerd[1521]: time="2025-06-21T02:25:23.448935229Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Jun 21 02:25:23.453314 containerd[1521]: time="2025-06-21T02:25:23.452940757Z" level=info msg="CreateContainer within sandbox \"170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jun 21 02:25:23.459999 containerd[1521]: time="2025-06-21T02:25:23.459228270Z" level=info msg="Container 66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:23.462030 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount784261263.mount: Deactivated successfully. Jun 21 02:25:23.465826 containerd[1521]: time="2025-06-21T02:25:23.465731140Z" level=info msg="CreateContainer within sandbox \"170d9955e4285a21a71c10da7177fb75e1394715bdd21937601182b7aae752f6\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e\"" Jun 21 02:25:23.466268 containerd[1521]: time="2025-06-21T02:25:23.466228520Z" level=info msg="StartContainer for \"66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e\"" Jun 21 02:25:23.467211 containerd[1521]: time="2025-06-21T02:25:23.467174142Z" level=info msg="connecting to shim 66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e" address="unix:///run/containerd/s/cc21ed312eddb34312486ea4379d9519260c00865b7c56044bfde382a2e030fd" protocol=ttrpc version=3 Jun 21 02:25:23.487800 systemd[1]: Started cri-containerd-66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e.scope - libcontainer container 66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e. Jun 21 02:25:23.515398 containerd[1521]: time="2025-06-21T02:25:23.515356319Z" level=info msg="StartContainer for \"66032f46c2994ecbc6fac768ce7e933d963464e5e190b72343dc725bc0caa73e\" returns successfully" Jun 21 02:25:23.895707 kubelet[1813]: E0621 02:25:23.895638 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:24.117234 kubelet[1813]: I0621 02:25:24.117146 1813 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.990514484 podStartE2EDuration="5.117131233s" podCreationTimestamp="2025-06-21 02:25:19 +0000 UTC" firstStartedPulling="2025-06-21 02:25:20.323162585 +0000 UTC m=+19.409944038" lastFinishedPulling="2025-06-21 02:25:23.449779374 +0000 UTC m=+22.536560787" observedRunningTime="2025-06-21 02:25:24.116895038 +0000 UTC m=+23.203676491" watchObservedRunningTime="2025-06-21 02:25:24.117131233 +0000 UTC m=+23.203912686" Jun 21 02:25:24.896541 kubelet[1813]: E0621 02:25:24.896456 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:25.897051 kubelet[1813]: E0621 02:25:25.896983 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:26.898141 kubelet[1813]: E0621 02:25:26.898089 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:27.898410 kubelet[1813]: E0621 02:25:27.898356 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:28.836430 systemd[1]: Created slice kubepods-besteffort-pod92db11a8_6cbe_4b78_a0a3_d0cdfc976bfa.slice - libcontainer container kubepods-besteffort-pod92db11a8_6cbe_4b78_a0a3_d0cdfc976bfa.slice. Jun 21 02:25:28.849832 kubelet[1813]: I0621 02:25:28.849741 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-1d0c1f37-2758-4a67-8b82-324153c2d182\" (UniqueName: \"kubernetes.io/nfs/92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa-pvc-1d0c1f37-2758-4a67-8b82-324153c2d182\") pod \"test-pod-1\" (UID: \"92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa\") " pod="default/test-pod-1" Jun 21 02:25:28.849832 kubelet[1813]: I0621 02:25:28.849781 1813 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-h9sxn\" (UniqueName: \"kubernetes.io/projected/92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa-kube-api-access-h9sxn\") pod \"test-pod-1\" (UID: \"92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa\") " pod="default/test-pod-1" Jun 21 02:25:28.899079 kubelet[1813]: E0621 02:25:28.899047 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:28.969689 kernel: netfs: FS-Cache loaded Jun 21 02:25:28.996054 kernel: RPC: Registered named UNIX socket transport module. Jun 21 02:25:28.996135 kernel: RPC: Registered udp transport module. Jun 21 02:25:28.996153 kernel: RPC: Registered tcp transport module. Jun 21 02:25:28.996166 kernel: RPC: Registered tcp-with-tls transport module. Jun 21 02:25:28.997128 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 21 02:25:29.179195 kernel: NFS: Registering the id_resolver key type Jun 21 02:25:29.179300 kernel: Key type id_resolver registered Jun 21 02:25:29.179321 kernel: Key type id_legacy registered Jun 21 02:25:29.202455 nfsidmap[2797]: 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 Jun 21 02:25:29.203142 nfsidmap[2797]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jun 21 02:25:29.206139 nfsidmap[2800]: 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 Jun 21 02:25:29.206304 nfsidmap[2800]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jun 21 02:25:29.211452 nfsrahead[2804]: setting /var/lib/kubelet/pods/92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa/volumes/kubernetes.io~nfs/pvc-1d0c1f37-2758-4a67-8b82-324153c2d182 readahead to 128 Jun 21 02:25:29.439844 containerd[1521]: time="2025-06-21T02:25:29.439779087Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa,Namespace:default,Attempt:0,}" Jun 21 02:25:29.452144 systemd-networkd[1435]: vethb39a633f: Link UP Jun 21 02:25:29.453135 kernel: cni0: port 3(vethb39a633f) entered blocking state Jun 21 02:25:29.453184 kernel: cni0: port 3(vethb39a633f) entered disabled state Jun 21 02:25:29.453199 kernel: vethb39a633f: entered allmulticast mode Jun 21 02:25:29.453212 kernel: vethb39a633f: entered promiscuous mode Jun 21 02:25:29.457907 kernel: cni0: port 3(vethb39a633f) entered blocking state Jun 21 02:25:29.457962 kernel: cni0: port 3(vethb39a633f) entered forwarding state Jun 21 02:25:29.458071 systemd-networkd[1435]: vethb39a633f: Gained carrier Jun 21 02:25:29.461331 containerd[1521]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Jun 21 02:25:29.461331 containerd[1521]: delegateAdd: netconf sent to delegate plugin: Jun 21 02:25:29.479364 containerd[1521]: {"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-06-21T02:25:29.479317510Z" level=info msg="connecting to shim 0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef" address="unix:///run/containerd/s/7aa1280c38dc4aab98132c52e6410eb31ebbb2e90e024da436761550afacc1e5" namespace=k8s.io protocol=ttrpc version=3 Jun 21 02:25:29.514883 systemd[1]: Started cri-containerd-0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef.scope - libcontainer container 0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef. Jun 21 02:25:29.524576 systemd-resolved[1350]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 02:25:29.542787 containerd[1521]: time="2025-06-21T02:25:29.542731645Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:92db11a8-6cbe-4b78-a0a3-d0cdfc976bfa,Namespace:default,Attempt:0,} returns sandbox id \"0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef\"" Jun 21 02:25:29.543754 containerd[1521]: time="2025-06-21T02:25:29.543728793Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 21 02:25:29.752389 containerd[1521]: time="2025-06-21T02:25:29.751902508Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 02:25:29.752600 containerd[1521]: time="2025-06-21T02:25:29.752561019Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jun 21 02:25:29.755693 containerd[1521]: time="2025-06-21T02:25:29.755566908Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e55a872cbf1b1d996b1d5333796fbe6ec0b825868f3ad30b387fc65697ed40dd\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\", size \"69950478\" in 211.804267ms" Jun 21 02:25:29.755693 containerd[1521]: time="2025-06-21T02:25:29.755599516Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e55a872cbf1b1d996b1d5333796fbe6ec0b825868f3ad30b387fc65697ed40dd\"" Jun 21 02:25:29.759191 containerd[1521]: time="2025-06-21T02:25:29.759135926Z" level=info msg="CreateContainer within sandbox \"0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jun 21 02:25:29.765708 containerd[1521]: time="2025-06-21T02:25:29.765102454Z" level=info msg="Container 7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1: CDI devices from CRI Config.CDIDevices: []" Jun 21 02:25:29.770999 containerd[1521]: time="2025-06-21T02:25:29.770956636Z" level=info msg="CreateContainer within sandbox \"0a691f11053c7cedd5dad67de0f208ae949c21e13abe12af2b59f3a13da7a4ef\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1\"" Jun 21 02:25:29.771679 containerd[1521]: time="2025-06-21T02:25:29.771286631Z" level=info msg="StartContainer for \"7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1\"" Jun 21 02:25:29.772171 containerd[1521]: time="2025-06-21T02:25:29.772147309Z" level=info msg="connecting to shim 7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1" address="unix:///run/containerd/s/7aa1280c38dc4aab98132c52e6410eb31ebbb2e90e024da436761550afacc1e5" protocol=ttrpc version=3 Jun 21 02:25:29.789788 systemd[1]: Started cri-containerd-7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1.scope - libcontainer container 7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1. Jun 21 02:25:29.812409 containerd[1521]: time="2025-06-21T02:25:29.812376770Z" level=info msg="StartContainer for \"7d598ec8a75c6b91944876bc2c20db46e410e87dadd21fdd9a058f8f004864b1\" returns successfully" Jun 21 02:25:29.900181 kubelet[1813]: E0621 02:25:29.900127 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:30.127702 kubelet[1813]: I0621 02:25:30.127570 1813 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=9.914640312 podStartE2EDuration="10.127555674s" podCreationTimestamp="2025-06-21 02:25:20 +0000 UTC" firstStartedPulling="2025-06-21 02:25:29.543433966 +0000 UTC m=+28.630215419" lastFinishedPulling="2025-06-21 02:25:29.756349328 +0000 UTC m=+28.843130781" observedRunningTime="2025-06-21 02:25:30.127479497 +0000 UTC m=+29.214260910" watchObservedRunningTime="2025-06-21 02:25:30.127555674 +0000 UTC m=+29.214337087" Jun 21 02:25:30.900341 kubelet[1813]: E0621 02:25:30.900278 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 02:25:31.489813 systemd-networkd[1435]: vethb39a633f: Gained IPv6LL Jun 21 02:25:31.901141 kubelet[1813]: E0621 02:25:31.901018 1813 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"