Aug 19 00:04:49.820411 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 19 00:04:49.820435 kernel: Linux version 6.12.41-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Mon Aug 18 22:15:14 -00 2025 Aug 19 00:04:49.820444 kernel: KASLR enabled Aug 19 00:04:49.820450 kernel: efi: EFI v2.7 by EDK II Aug 19 00:04:49.820456 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb21fd18 Aug 19 00:04:49.820461 kernel: random: crng init done Aug 19 00:04:49.820468 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Aug 19 00:04:49.820473 kernel: secureboot: Secure boot enabled Aug 19 00:04:49.820479 kernel: ACPI: Early table checksum verification disabled Aug 19 00:04:49.820486 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Aug 19 00:04:49.820492 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 19 00:04:49.820498 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820504 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820509 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820516 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820525 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820531 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820538 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820544 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820550 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 19 00:04:49.820556 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 19 00:04:49.820563 kernel: ACPI: Use ACPI SPCR as default console: Yes Aug 19 00:04:49.820569 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 19 00:04:49.820575 kernel: NODE_DATA(0) allocated [mem 0xdc737a00-0xdc73efff] Aug 19 00:04:49.820581 kernel: Zone ranges: Aug 19 00:04:49.820601 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 19 00:04:49.820608 kernel: DMA32 empty Aug 19 00:04:49.820614 kernel: Normal empty Aug 19 00:04:49.820621 kernel: Device empty Aug 19 00:04:49.820627 kernel: Movable zone start for each node Aug 19 00:04:49.820633 kernel: Early memory node ranges Aug 19 00:04:49.820639 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Aug 19 00:04:49.820646 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Aug 19 00:04:49.820652 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Aug 19 00:04:49.820658 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Aug 19 00:04:49.820665 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Aug 19 00:04:49.820671 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Aug 19 00:04:49.820679 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Aug 19 00:04:49.820686 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Aug 19 00:04:49.820692 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 19 00:04:49.820717 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 19 00:04:49.820724 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 19 00:04:49.820731 kernel: cma: Reserved 16 MiB at 0x00000000d7a00000 on node -1 Aug 19 00:04:49.820738 kernel: psci: probing for conduit method from ACPI. Aug 19 00:04:49.822106 kernel: psci: PSCIv1.1 detected in firmware. Aug 19 00:04:49.822128 kernel: psci: Using standard PSCI v0.2 function IDs Aug 19 00:04:49.822136 kernel: psci: Trusted OS migration not required Aug 19 00:04:49.822143 kernel: psci: SMC Calling Convention v1.1 Aug 19 00:04:49.822150 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 19 00:04:49.822157 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Aug 19 00:04:49.822164 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Aug 19 00:04:49.822172 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 19 00:04:49.822178 kernel: Detected PIPT I-cache on CPU0 Aug 19 00:04:49.822194 kernel: CPU features: detected: GIC system register CPU interface Aug 19 00:04:49.822201 kernel: CPU features: detected: Spectre-v4 Aug 19 00:04:49.822208 kernel: CPU features: detected: Spectre-BHB Aug 19 00:04:49.822215 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 19 00:04:49.822221 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 19 00:04:49.822229 kernel: CPU features: detected: ARM erratum 1418040 Aug 19 00:04:49.822235 kernel: CPU features: detected: SSBS not fully self-synchronizing Aug 19 00:04:49.822242 kernel: alternatives: applying boot alternatives Aug 19 00:04:49.822251 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=a868ccde263e96e0a18737fdbf04ca04bbf30dfe23963f1ae3994966e8fc9468 Aug 19 00:04:49.822258 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 19 00:04:49.822265 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 19 00:04:49.822274 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 19 00:04:49.822281 kernel: Fallback order for Node 0: 0 Aug 19 00:04:49.822288 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Aug 19 00:04:49.822294 kernel: Policy zone: DMA Aug 19 00:04:49.822301 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 19 00:04:49.822308 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Aug 19 00:04:49.822314 kernel: software IO TLB: area num 4. Aug 19 00:04:49.822321 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Aug 19 00:04:49.822328 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Aug 19 00:04:49.822334 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 19 00:04:49.822342 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 19 00:04:49.822349 kernel: rcu: RCU event tracing is enabled. Aug 19 00:04:49.822357 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 19 00:04:49.822364 kernel: Trampoline variant of Tasks RCU enabled. Aug 19 00:04:49.822371 kernel: Tracing variant of Tasks RCU enabled. Aug 19 00:04:49.822378 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 19 00:04:49.822384 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 19 00:04:49.822391 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 19 00:04:49.822398 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 19 00:04:49.822405 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 19 00:04:49.822411 kernel: GICv3: 256 SPIs implemented Aug 19 00:04:49.822418 kernel: GICv3: 0 Extended SPIs implemented Aug 19 00:04:49.822424 kernel: Root IRQ handler: gic_handle_irq Aug 19 00:04:49.822432 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 19 00:04:49.822439 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Aug 19 00:04:49.822446 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 19 00:04:49.822453 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 19 00:04:49.822459 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Aug 19 00:04:49.822466 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Aug 19 00:04:49.822473 kernel: GICv3: using LPI property table @0x0000000040130000 Aug 19 00:04:49.822479 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Aug 19 00:04:49.822486 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 19 00:04:49.822493 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 19 00:04:49.822499 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 19 00:04:49.822506 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 19 00:04:49.822514 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 19 00:04:49.822521 kernel: arm-pv: using stolen time PV Aug 19 00:04:49.822528 kernel: Console: colour dummy device 80x25 Aug 19 00:04:49.822535 kernel: ACPI: Core revision 20240827 Aug 19 00:04:49.822542 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 19 00:04:49.822550 kernel: pid_max: default: 32768 minimum: 301 Aug 19 00:04:49.822557 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Aug 19 00:04:49.822564 kernel: landlock: Up and running. Aug 19 00:04:49.822571 kernel: SELinux: Initializing. Aug 19 00:04:49.822578 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 19 00:04:49.822587 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 19 00:04:49.822605 kernel: rcu: Hierarchical SRCU implementation. Aug 19 00:04:49.822613 kernel: rcu: Max phase no-delay instances is 400. Aug 19 00:04:49.822620 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Aug 19 00:04:49.822627 kernel: Remapping and enabling EFI services. Aug 19 00:04:49.822634 kernel: smp: Bringing up secondary CPUs ... Aug 19 00:04:49.822641 kernel: Detected PIPT I-cache on CPU1 Aug 19 00:04:49.822649 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 19 00:04:49.822656 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Aug 19 00:04:49.822671 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 19 00:04:49.822678 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 19 00:04:49.822687 kernel: Detected PIPT I-cache on CPU2 Aug 19 00:04:49.822716 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 19 00:04:49.822726 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Aug 19 00:04:49.822733 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 19 00:04:49.822740 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 19 00:04:49.822747 kernel: Detected PIPT I-cache on CPU3 Aug 19 00:04:49.822757 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 19 00:04:49.822765 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Aug 19 00:04:49.822773 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 19 00:04:49.822780 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 19 00:04:49.822787 kernel: smp: Brought up 1 node, 4 CPUs Aug 19 00:04:49.822794 kernel: SMP: Total of 4 processors activated. Aug 19 00:04:49.822801 kernel: CPU: All CPU(s) started at EL1 Aug 19 00:04:49.822809 kernel: CPU features: detected: 32-bit EL0 Support Aug 19 00:04:49.822816 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 19 00:04:49.822825 kernel: CPU features: detected: Common not Private translations Aug 19 00:04:49.822832 kernel: CPU features: detected: CRC32 instructions Aug 19 00:04:49.822840 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 19 00:04:49.822847 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 19 00:04:49.822854 kernel: CPU features: detected: LSE atomic instructions Aug 19 00:04:49.822861 kernel: CPU features: detected: Privileged Access Never Aug 19 00:04:49.822868 kernel: CPU features: detected: RAS Extension Support Aug 19 00:04:49.822876 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 19 00:04:49.822883 kernel: alternatives: applying system-wide alternatives Aug 19 00:04:49.822892 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Aug 19 00:04:49.822901 kernel: Memory: 2422436K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 127516K reserved, 16384K cma-reserved) Aug 19 00:04:49.822908 kernel: devtmpfs: initialized Aug 19 00:04:49.822916 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 19 00:04:49.822923 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 19 00:04:49.822930 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 19 00:04:49.822938 kernel: 0 pages in range for non-PLT usage Aug 19 00:04:49.822945 kernel: 508576 pages in range for PLT usage Aug 19 00:04:49.822952 kernel: pinctrl core: initialized pinctrl subsystem Aug 19 00:04:49.822961 kernel: SMBIOS 3.0.0 present. Aug 19 00:04:49.822968 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Aug 19 00:04:49.822976 kernel: DMI: Memory slots populated: 1/1 Aug 19 00:04:49.822983 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 19 00:04:49.822991 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 19 00:04:49.822998 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 19 00:04:49.823006 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 19 00:04:49.823013 kernel: audit: initializing netlink subsys (disabled) Aug 19 00:04:49.823021 kernel: audit: type=2000 audit(0.033:1): state=initialized audit_enabled=0 res=1 Aug 19 00:04:49.823030 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 19 00:04:49.823037 kernel: cpuidle: using governor menu Aug 19 00:04:49.823045 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 19 00:04:49.823052 kernel: ASID allocator initialised with 32768 entries Aug 19 00:04:49.823059 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 19 00:04:49.823066 kernel: Serial: AMBA PL011 UART driver Aug 19 00:04:49.823074 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 19 00:04:49.823081 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 19 00:04:49.823089 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 19 00:04:49.823097 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 19 00:04:49.823105 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 19 00:04:49.823112 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 19 00:04:49.823120 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 19 00:04:49.823127 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 19 00:04:49.823134 kernel: ACPI: Added _OSI(Module Device) Aug 19 00:04:49.823142 kernel: ACPI: Added _OSI(Processor Device) Aug 19 00:04:49.823149 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 19 00:04:49.823156 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 19 00:04:49.823166 kernel: ACPI: Interpreter enabled Aug 19 00:04:49.823173 kernel: ACPI: Using GIC for interrupt routing Aug 19 00:04:49.823180 kernel: ACPI: MCFG table detected, 1 entries Aug 19 00:04:49.823188 kernel: ACPI: CPU0 has been hot-added Aug 19 00:04:49.823195 kernel: ACPI: CPU1 has been hot-added Aug 19 00:04:49.823203 kernel: ACPI: CPU2 has been hot-added Aug 19 00:04:49.823210 kernel: ACPI: CPU3 has been hot-added Aug 19 00:04:49.823217 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 19 00:04:49.823224 kernel: printk: legacy console [ttyAMA0] enabled Aug 19 00:04:49.823233 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 19 00:04:49.823424 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 19 00:04:49.823490 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 19 00:04:49.823550 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 19 00:04:49.823624 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 19 00:04:49.823689 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 19 00:04:49.823737 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 19 00:04:49.823749 kernel: PCI host bridge to bus 0000:00 Aug 19 00:04:49.823828 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 19 00:04:49.823884 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 19 00:04:49.823938 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 19 00:04:49.823992 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 19 00:04:49.824072 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Aug 19 00:04:49.824149 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Aug 19 00:04:49.824216 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Aug 19 00:04:49.824275 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Aug 19 00:04:49.824334 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Aug 19 00:04:49.824394 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Aug 19 00:04:49.824455 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Aug 19 00:04:49.824516 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Aug 19 00:04:49.824571 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 19 00:04:49.824656 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 19 00:04:49.824726 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 19 00:04:49.824736 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 19 00:04:49.824743 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 19 00:04:49.824750 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 19 00:04:49.824758 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 19 00:04:49.824765 kernel: iommu: Default domain type: Translated Aug 19 00:04:49.824772 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 19 00:04:49.824783 kernel: efivars: Registered efivars operations Aug 19 00:04:49.824791 kernel: vgaarb: loaded Aug 19 00:04:49.824799 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 19 00:04:49.824806 kernel: VFS: Disk quotas dquot_6.6.0 Aug 19 00:04:49.824814 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 19 00:04:49.824822 kernel: pnp: PnP ACPI init Aug 19 00:04:49.824895 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 19 00:04:49.824907 kernel: pnp: PnP ACPI: found 1 devices Aug 19 00:04:49.824916 kernel: NET: Registered PF_INET protocol family Aug 19 00:04:49.824923 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 19 00:04:49.824931 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 19 00:04:49.824938 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 19 00:04:49.824945 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 19 00:04:49.824952 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 19 00:04:49.824960 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 19 00:04:49.824967 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 19 00:04:49.824975 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 19 00:04:49.824983 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 19 00:04:49.824990 kernel: PCI: CLS 0 bytes, default 64 Aug 19 00:04:49.824997 kernel: kvm [1]: HYP mode not available Aug 19 00:04:49.825004 kernel: Initialise system trusted keyrings Aug 19 00:04:49.825012 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 19 00:04:49.825019 kernel: Key type asymmetric registered Aug 19 00:04:49.825026 kernel: Asymmetric key parser 'x509' registered Aug 19 00:04:49.825033 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Aug 19 00:04:49.825040 kernel: io scheduler mq-deadline registered Aug 19 00:04:49.825049 kernel: io scheduler kyber registered Aug 19 00:04:49.825056 kernel: io scheduler bfq registered Aug 19 00:04:49.825063 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 19 00:04:49.825071 kernel: ACPI: button: Power Button [PWRB] Aug 19 00:04:49.825078 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 19 00:04:49.825143 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 19 00:04:49.825153 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 19 00:04:49.825160 kernel: thunder_xcv, ver 1.0 Aug 19 00:04:49.825167 kernel: thunder_bgx, ver 1.0 Aug 19 00:04:49.825176 kernel: nicpf, ver 1.0 Aug 19 00:04:49.825183 kernel: nicvf, ver 1.0 Aug 19 00:04:49.825254 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 19 00:04:49.825311 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-19T00:04:49 UTC (1755561889) Aug 19 00:04:49.825320 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 19 00:04:49.825328 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Aug 19 00:04:49.825336 kernel: watchdog: NMI not fully supported Aug 19 00:04:49.825344 kernel: watchdog: Hard watchdog permanently disabled Aug 19 00:04:49.825353 kernel: NET: Registered PF_INET6 protocol family Aug 19 00:04:49.825361 kernel: Segment Routing with IPv6 Aug 19 00:04:49.825368 kernel: In-situ OAM (IOAM) with IPv6 Aug 19 00:04:49.825375 kernel: NET: Registered PF_PACKET protocol family Aug 19 00:04:49.825382 kernel: Key type dns_resolver registered Aug 19 00:04:49.825389 kernel: registered taskstats version 1 Aug 19 00:04:49.825396 kernel: Loading compiled-in X.509 certificates Aug 19 00:04:49.825404 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.41-flatcar: becc5a61d1c5dcbcd174f4649c64b863031dbaa8' Aug 19 00:04:49.825411 kernel: Demotion targets for Node 0: null Aug 19 00:04:49.825420 kernel: Key type .fscrypt registered Aug 19 00:04:49.825428 kernel: Key type fscrypt-provisioning registered Aug 19 00:04:49.825435 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 19 00:04:49.825442 kernel: ima: Allocated hash algorithm: sha1 Aug 19 00:04:49.825449 kernel: ima: No architecture policies found Aug 19 00:04:49.825456 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 19 00:04:49.825463 kernel: clk: Disabling unused clocks Aug 19 00:04:49.825470 kernel: PM: genpd: Disabling unused power domains Aug 19 00:04:49.825477 kernel: Warning: unable to open an initial console. Aug 19 00:04:49.825486 kernel: Freeing unused kernel memory: 38912K Aug 19 00:04:49.825493 kernel: Run /init as init process Aug 19 00:04:49.825501 kernel: with arguments: Aug 19 00:04:49.825508 kernel: /init Aug 19 00:04:49.825515 kernel: with environment: Aug 19 00:04:49.825522 kernel: HOME=/ Aug 19 00:04:49.825529 kernel: TERM=linux Aug 19 00:04:49.825536 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 19 00:04:49.825544 systemd[1]: Successfully made /usr/ read-only. Aug 19 00:04:49.825556 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) Aug 19 00:04:49.825565 systemd[1]: Detected virtualization kvm. Aug 19 00:04:49.825572 systemd[1]: Detected architecture arm64. Aug 19 00:04:49.825579 systemd[1]: Running in initrd. Aug 19 00:04:49.825587 systemd[1]: No hostname configured, using default hostname. Aug 19 00:04:49.825603 systemd[1]: Hostname set to . Aug 19 00:04:49.825611 systemd[1]: Initializing machine ID from VM UUID. Aug 19 00:04:49.825621 systemd[1]: Queued start job for default target initrd.target. Aug 19 00:04:49.825629 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:04:49.825637 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:04:49.825645 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 19 00:04:49.825653 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 19 00:04:49.825661 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 19 00:04:49.825670 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 19 00:04:49.825680 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 19 00:04:49.825688 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 19 00:04:49.825706 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:04:49.825714 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:04:49.825722 systemd[1]: Reached target paths.target - Path Units. Aug 19 00:04:49.825730 systemd[1]: Reached target slices.target - Slice Units. Aug 19 00:04:49.825737 systemd[1]: Reached target swap.target - Swaps. Aug 19 00:04:49.825745 systemd[1]: Reached target timers.target - Timer Units. Aug 19 00:04:49.825755 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 19 00:04:49.825763 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 19 00:04:49.825771 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 19 00:04:49.825779 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Aug 19 00:04:49.825787 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:04:49.825795 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 19 00:04:49.825802 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:04:49.825810 systemd[1]: Reached target sockets.target - Socket Units. Aug 19 00:04:49.825818 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 19 00:04:49.825828 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 19 00:04:49.825836 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 19 00:04:49.825844 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). Aug 19 00:04:49.825852 systemd[1]: Starting systemd-fsck-usr.service... Aug 19 00:04:49.825860 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 19 00:04:49.825868 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 19 00:04:49.825876 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:04:49.825884 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:04:49.825894 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 19 00:04:49.825902 systemd[1]: Finished systemd-fsck-usr.service. Aug 19 00:04:49.825910 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 19 00:04:49.825943 systemd-journald[243]: Collecting audit messages is disabled. Aug 19 00:04:49.825966 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 19 00:04:49.825975 systemd-journald[243]: Journal started Aug 19 00:04:49.825995 systemd-journald[243]: Runtime Journal (/run/log/journal/fd802a7806f045ee92686f6c3df52bfa) is 6M, max 48.5M, 42.4M free. Aug 19 00:04:49.807680 systemd-modules-load[247]: Inserted module 'overlay' Aug 19 00:04:49.829427 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:04:49.831122 systemd[1]: Started systemd-journald.service - Journal Service. Aug 19 00:04:49.833731 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 19 00:04:49.834395 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 19 00:04:49.837853 kernel: Bridge firewalling registered Aug 19 00:04:49.837438 systemd-modules-load[247]: Inserted module 'br_netfilter' Aug 19 00:04:49.839581 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 19 00:04:49.845601 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 19 00:04:49.846766 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 19 00:04:49.849868 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 19 00:04:49.857212 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:04:49.860120 systemd-tmpfiles[269]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Aug 19 00:04:49.865124 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:04:49.869579 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:04:49.872609 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 19 00:04:49.876170 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 19 00:04:49.878619 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 19 00:04:49.916074 dracut-cmdline[290]: 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=a868ccde263e96e0a18737fdbf04ca04bbf30dfe23963f1ae3994966e8fc9468 Aug 19 00:04:49.931849 systemd-resolved[291]: Positive Trust Anchors: Aug 19 00:04:49.931872 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 19 00:04:49.931904 systemd-resolved[291]: 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 Aug 19 00:04:49.938549 systemd-resolved[291]: Defaulting to hostname 'linux'. Aug 19 00:04:49.939899 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 19 00:04:49.941350 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:04:50.034757 kernel: SCSI subsystem initialized Aug 19 00:04:50.044759 kernel: Loading iSCSI transport class v2.0-870. Aug 19 00:04:50.059755 kernel: iscsi: registered transport (tcp) Aug 19 00:04:50.084682 kernel: iscsi: registered transport (qla4xxx) Aug 19 00:04:50.084818 kernel: QLogic iSCSI HBA Driver Aug 19 00:04:50.116839 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 19 00:04:50.159109 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:04:50.163186 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 19 00:04:50.234902 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 19 00:04:50.238150 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 19 00:04:50.315752 kernel: raid6: neonx8 gen() 11160 MB/s Aug 19 00:04:50.332746 kernel: raid6: neonx4 gen() 15629 MB/s Aug 19 00:04:50.349743 kernel: raid6: neonx2 gen() 13076 MB/s Aug 19 00:04:50.366739 kernel: raid6: neonx1 gen() 10371 MB/s Aug 19 00:04:50.383863 kernel: raid6: int64x8 gen() 6843 MB/s Aug 19 00:04:50.400757 kernel: raid6: int64x4 gen() 7277 MB/s Aug 19 00:04:50.417731 kernel: raid6: int64x2 gen() 6057 MB/s Aug 19 00:04:50.434747 kernel: raid6: int64x1 gen() 5006 MB/s Aug 19 00:04:50.434814 kernel: raid6: using algorithm neonx4 gen() 15629 MB/s Aug 19 00:04:50.451756 kernel: raid6: .... xor() 12256 MB/s, rmw enabled Aug 19 00:04:50.451816 kernel: raid6: using neon recovery algorithm Aug 19 00:04:50.468058 kernel: xor: measuring software checksum speed Aug 19 00:04:50.468202 kernel: 8regs : 21562 MB/sec Aug 19 00:04:50.468274 kernel: 32regs : 21676 MB/sec Aug 19 00:04:50.469094 kernel: arm64_neon : 27268 MB/sec Aug 19 00:04:50.469136 kernel: xor: using function: arm64_neon (27268 MB/sec) Aug 19 00:04:50.530764 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 19 00:04:50.539772 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 19 00:04:50.546421 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:04:50.592439 systemd-udevd[499]: Using default interface naming scheme 'v255'. Aug 19 00:04:50.596808 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:04:50.598727 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 19 00:04:50.631310 dracut-pre-trigger[502]: rd.md=0: removing MD RAID activation Aug 19 00:04:50.667467 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 19 00:04:50.670241 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 19 00:04:50.740301 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:04:50.743240 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 19 00:04:50.796333 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 19 00:04:50.798725 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 19 00:04:50.805889 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 19 00:04:50.806032 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:04:50.817327 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 19 00:04:50.817350 kernel: GPT:9289727 != 19775487 Aug 19 00:04:50.817360 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 19 00:04:50.817369 kernel: GPT:9289727 != 19775487 Aug 19 00:04:50.817378 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 19 00:04:50.816136 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:04:50.819801 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 19 00:04:50.820102 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:04:50.822653 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 19 00:04:50.851621 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 19 00:04:50.852892 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:04:50.866210 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 19 00:04:50.867471 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 19 00:04:50.881474 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 19 00:04:50.888220 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 19 00:04:50.889371 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 19 00:04:50.892028 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 19 00:04:50.893601 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:04:50.895475 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 19 00:04:50.898217 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 19 00:04:50.899823 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 19 00:04:50.918878 disk-uuid[592]: Primary Header is updated. Aug 19 00:04:50.918878 disk-uuid[592]: Secondary Entries is updated. Aug 19 00:04:50.918878 disk-uuid[592]: Secondary Header is updated. Aug 19 00:04:50.921996 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 19 00:04:50.924741 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 19 00:04:51.938726 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 19 00:04:51.941534 disk-uuid[598]: The operation has completed successfully. Aug 19 00:04:51.988951 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 19 00:04:51.990056 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 19 00:04:52.009450 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 19 00:04:52.029949 sh[612]: Success Aug 19 00:04:52.049072 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 19 00:04:52.049131 kernel: device-mapper: uevent: version 1.0.3 Aug 19 00:04:52.049880 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Aug 19 00:04:52.058853 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Aug 19 00:04:52.086171 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 19 00:04:52.088998 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 19 00:04:52.103281 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 19 00:04:52.109998 kernel: BTRFS: device fsid 1e492084-d287-4a43-8dc6-ad086a072625 devid 1 transid 45 /dev/mapper/usr (253:0) scanned by mount (624) Aug 19 00:04:52.110038 kernel: BTRFS info (device dm-0): first mount of filesystem 1e492084-d287-4a43-8dc6-ad086a072625 Aug 19 00:04:52.110048 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:04:52.111706 kernel: BTRFS info (device dm-0): using free-space-tree Aug 19 00:04:52.115293 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 19 00:04:52.116450 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Aug 19 00:04:52.117680 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 19 00:04:52.118575 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 19 00:04:52.121311 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 19 00:04:52.144721 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (656) Aug 19 00:04:52.144777 kernel: BTRFS info (device vda6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:04:52.146459 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:04:52.146509 kernel: BTRFS info (device vda6): using free-space-tree Aug 19 00:04:52.154765 kernel: BTRFS info (device vda6): last unmount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:04:52.155514 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 19 00:04:52.157592 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 19 00:04:52.231559 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 19 00:04:52.236419 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 19 00:04:52.286379 systemd-networkd[799]: lo: Link UP Aug 19 00:04:52.286392 systemd-networkd[799]: lo: Gained carrier Aug 19 00:04:52.287130 systemd-networkd[799]: Enumeration completed Aug 19 00:04:52.287521 systemd-networkd[799]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:04:52.287524 systemd-networkd[799]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 19 00:04:52.288358 systemd-networkd[799]: eth0: Link UP Aug 19 00:04:52.288448 systemd-networkd[799]: eth0: Gained carrier Aug 19 00:04:52.288457 systemd-networkd[799]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:04:52.288838 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 19 00:04:52.290007 systemd[1]: Reached target network.target - Network. Aug 19 00:04:52.307781 systemd-networkd[799]: eth0: DHCPv4 address 10.0.0.18/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 19 00:04:52.317411 ignition[704]: Ignition 2.21.0 Aug 19 00:04:52.317428 ignition[704]: Stage: fetch-offline Aug 19 00:04:52.317460 ignition[704]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:52.317467 ignition[704]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:52.317670 ignition[704]: parsed url from cmdline: "" Aug 19 00:04:52.317673 ignition[704]: no config URL provided Aug 19 00:04:52.317678 ignition[704]: reading system config file "/usr/lib/ignition/user.ign" Aug 19 00:04:52.317684 ignition[704]: no config at "/usr/lib/ignition/user.ign" Aug 19 00:04:52.317720 ignition[704]: op(1): [started] loading QEMU firmware config module Aug 19 00:04:52.317725 ignition[704]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 19 00:04:52.330200 ignition[704]: op(1): [finished] loading QEMU firmware config module Aug 19 00:04:52.337511 ignition[704]: parsing config with SHA512: f5c94ef63352b5f3cb74fa664711ad674ba0f8df342b1edb9fbbced40e08b9d2c7ffc3d85f895e5c828083cc38d6925fbd61fc10fd81d69904ae837645e3e0e9 Aug 19 00:04:52.340936 unknown[704]: fetched base config from "system" Aug 19 00:04:52.340950 unknown[704]: fetched user config from "qemu" Aug 19 00:04:52.341225 ignition[704]: fetch-offline: fetch-offline passed Aug 19 00:04:52.341286 ignition[704]: Ignition finished successfully Aug 19 00:04:52.345174 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 19 00:04:52.346243 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 19 00:04:52.347149 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 19 00:04:52.386867 ignition[812]: Ignition 2.21.0 Aug 19 00:04:52.386882 ignition[812]: Stage: kargs Aug 19 00:04:52.387021 ignition[812]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:52.387030 ignition[812]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:52.388140 ignition[812]: kargs: kargs passed Aug 19 00:04:52.388196 ignition[812]: Ignition finished successfully Aug 19 00:04:52.391079 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 19 00:04:52.392948 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 19 00:04:52.429816 ignition[820]: Ignition 2.21.0 Aug 19 00:04:52.429833 ignition[820]: Stage: disks Aug 19 00:04:52.429986 ignition[820]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:52.429995 ignition[820]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:52.431883 ignition[820]: disks: disks passed Aug 19 00:04:52.432175 ignition[820]: Ignition finished successfully Aug 19 00:04:52.434562 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 19 00:04:52.436038 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 19 00:04:52.437357 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 19 00:04:52.439233 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 19 00:04:52.440721 systemd[1]: Reached target sysinit.target - System Initialization. Aug 19 00:04:52.442492 systemd[1]: Reached target basic.target - Basic System. Aug 19 00:04:52.444794 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 19 00:04:52.479692 systemd-fsck[830]: ROOT: clean, 15/553520 files, 52789/553472 blocks Aug 19 00:04:52.490822 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 19 00:04:52.493156 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 19 00:04:52.590727 kernel: EXT4-fs (vda9): mounted filesystem 593a9299-85f8-44ab-a00f-cf95b7233713 r/w with ordered data mode. Quota mode: none. Aug 19 00:04:52.591290 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 19 00:04:52.592672 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 19 00:04:52.598854 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 19 00:04:52.601660 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 19 00:04:52.603217 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 19 00:04:52.603264 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 19 00:04:52.603290 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 19 00:04:52.618060 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 19 00:04:52.620253 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 19 00:04:52.627748 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (839) Aug 19 00:04:52.629980 kernel: BTRFS info (device vda6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:04:52.630029 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:04:52.630041 kernel: BTRFS info (device vda6): using free-space-tree Aug 19 00:04:52.634570 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 19 00:04:52.684181 initrd-setup-root[863]: cut: /sysroot/etc/passwd: No such file or directory Aug 19 00:04:52.691491 initrd-setup-root[870]: cut: /sysroot/etc/group: No such file or directory Aug 19 00:04:52.696305 initrd-setup-root[877]: cut: /sysroot/etc/shadow: No such file or directory Aug 19 00:04:52.700081 initrd-setup-root[884]: cut: /sysroot/etc/gshadow: No such file or directory Aug 19 00:04:52.815504 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 19 00:04:52.817857 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 19 00:04:52.819264 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 19 00:04:52.834796 kernel: BTRFS info (device vda6): last unmount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:04:52.861344 ignition[953]: INFO : Ignition 2.21.0 Aug 19 00:04:52.861344 ignition[953]: INFO : Stage: mount Aug 19 00:04:52.862774 ignition[953]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:52.862774 ignition[953]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:52.862774 ignition[953]: INFO : mount: mount passed Aug 19 00:04:52.862774 ignition[953]: INFO : Ignition finished successfully Aug 19 00:04:52.864070 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 19 00:04:52.867329 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 19 00:04:52.870907 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 19 00:04:53.109166 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 19 00:04:53.112076 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 19 00:04:53.137504 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (964) Aug 19 00:04:53.137558 kernel: BTRFS info (device vda6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:04:53.137570 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:04:53.138278 kernel: BTRFS info (device vda6): using free-space-tree Aug 19 00:04:53.160155 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 19 00:04:53.208002 ignition[981]: INFO : Ignition 2.21.0 Aug 19 00:04:53.208002 ignition[981]: INFO : Stage: files Aug 19 00:04:53.210923 ignition[981]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:53.210923 ignition[981]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:53.210923 ignition[981]: DEBUG : files: compiled without relabeling support, skipping Aug 19 00:04:53.216189 ignition[981]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 19 00:04:53.216189 ignition[981]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 19 00:04:53.219534 ignition[981]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 19 00:04:53.222460 ignition[981]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 19 00:04:53.222460 ignition[981]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 19 00:04:53.221002 unknown[981]: wrote ssh authorized keys file for user: core Aug 19 00:04:53.228334 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Aug 19 00:04:53.228334 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Aug 19 00:04:53.235930 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 19 00:04:53.235930 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 19 00:04:53.235930 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Aug 19 00:04:53.250368 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Aug 19 00:04:53.250368 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Aug 19 00:04:53.255586 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-arm64.raw: attempt #1 Aug 19 00:04:53.623838 systemd-networkd[799]: eth0: Gained IPv6LL Aug 19 00:04:53.945198 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Aug 19 00:04:54.295654 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Aug 19 00:04:54.295654 ignition[981]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Aug 19 00:04:54.295654 ignition[981]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 19 00:04:54.303413 ignition[981]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 19 00:04:54.303413 ignition[981]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Aug 19 00:04:54.303413 ignition[981]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Aug 19 00:04:54.331460 ignition[981]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 19 00:04:54.334731 ignition[981]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 19 00:04:54.336164 ignition[981]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Aug 19 00:04:54.336164 ignition[981]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 19 00:04:54.336164 ignition[981]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 19 00:04:54.336164 ignition[981]: INFO : files: files passed Aug 19 00:04:54.336164 ignition[981]: INFO : Ignition finished successfully Aug 19 00:04:54.338134 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 19 00:04:54.341122 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 19 00:04:54.343504 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 19 00:04:54.371886 initrd-setup-root-after-ignition[1009]: grep: /sysroot/oem/oem-release: No such file or directory Aug 19 00:04:54.372907 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 19 00:04:54.373061 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 19 00:04:54.377229 initrd-setup-root-after-ignition[1013]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:04:54.377229 initrd-setup-root-after-ignition[1013]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:04:54.380465 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:04:54.381899 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 19 00:04:54.383521 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 19 00:04:54.388345 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 19 00:04:54.441082 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 19 00:04:54.441234 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 19 00:04:54.443464 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 19 00:04:54.445113 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 19 00:04:54.447023 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 19 00:04:54.448073 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 19 00:04:54.465765 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 19 00:04:54.468135 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 19 00:04:54.492518 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:04:54.493618 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:04:54.495352 systemd[1]: Stopped target timers.target - Timer Units. Aug 19 00:04:54.501171 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 19 00:04:54.501315 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 19 00:04:54.505465 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 19 00:04:54.507353 systemd[1]: Stopped target basic.target - Basic System. Aug 19 00:04:54.508725 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 19 00:04:54.510277 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 19 00:04:54.512216 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 19 00:04:54.514134 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Aug 19 00:04:54.515938 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 19 00:04:54.517543 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 19 00:04:54.519327 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 19 00:04:54.521398 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 19 00:04:54.523166 systemd[1]: Stopped target swap.target - Swaps. Aug 19 00:04:54.524531 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 19 00:04:54.524693 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 19 00:04:54.527180 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:04:54.528910 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:04:54.531209 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 19 00:04:54.534804 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:04:54.535968 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 19 00:04:54.536108 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 19 00:04:54.541206 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 19 00:04:54.541431 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 19 00:04:54.543772 systemd[1]: Stopped target paths.target - Path Units. Aug 19 00:04:54.545200 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 19 00:04:54.545316 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:04:54.547378 systemd[1]: Stopped target slices.target - Slice Units. Aug 19 00:04:54.548941 systemd[1]: Stopped target sockets.target - Socket Units. Aug 19 00:04:54.553583 systemd[1]: iscsid.socket: Deactivated successfully. Aug 19 00:04:54.553686 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 19 00:04:54.555889 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 19 00:04:54.555996 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 19 00:04:54.557260 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 19 00:04:54.557397 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 19 00:04:54.558784 systemd[1]: ignition-files.service: Deactivated successfully. Aug 19 00:04:54.558888 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 19 00:04:54.561230 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 19 00:04:54.564027 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 19 00:04:54.565481 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 19 00:04:54.565627 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:04:54.567423 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 19 00:04:54.567530 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 19 00:04:54.573124 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 19 00:04:54.576894 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 19 00:04:54.587272 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 19 00:04:54.592896 ignition[1037]: INFO : Ignition 2.21.0 Aug 19 00:04:54.592896 ignition[1037]: INFO : Stage: umount Aug 19 00:04:54.595943 ignition[1037]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:04:54.595943 ignition[1037]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 19 00:04:54.595943 ignition[1037]: INFO : umount: umount passed Aug 19 00:04:54.595943 ignition[1037]: INFO : Ignition finished successfully Aug 19 00:04:54.595975 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 19 00:04:54.596090 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 19 00:04:54.598994 systemd[1]: Stopped target network.target - Network. Aug 19 00:04:54.600484 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 19 00:04:54.600575 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 19 00:04:54.601863 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 19 00:04:54.601910 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 19 00:04:54.605183 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 19 00:04:54.605244 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 19 00:04:54.606773 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 19 00:04:54.606820 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 19 00:04:54.608688 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 19 00:04:54.610330 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 19 00:04:54.616720 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 19 00:04:54.616882 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 19 00:04:54.620767 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Aug 19 00:04:54.621150 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 19 00:04:54.621204 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:04:54.624475 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Aug 19 00:04:54.624817 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 19 00:04:54.624916 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 19 00:04:54.629555 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Aug 19 00:04:54.630220 systemd[1]: Stopped target network-pre.target - Preparation for Network. Aug 19 00:04:54.631704 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 19 00:04:54.631752 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:04:54.636300 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 19 00:04:54.637749 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 19 00:04:54.637812 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 19 00:04:54.639946 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 19 00:04:54.640002 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:04:54.642690 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 19 00:04:54.642757 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 19 00:04:54.644641 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:04:54.649262 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Aug 19 00:04:54.657462 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 19 00:04:54.657627 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:04:54.661213 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 19 00:04:54.661310 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 19 00:04:54.663514 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 19 00:04:54.663603 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 19 00:04:54.665193 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 19 00:04:54.665232 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:04:54.668629 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 19 00:04:54.668705 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 19 00:04:54.671501 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 19 00:04:54.671560 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 19 00:04:54.674195 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 19 00:04:54.674255 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 19 00:04:54.677605 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 19 00:04:54.679170 systemd[1]: systemd-network-generator.service: Deactivated successfully. Aug 19 00:04:54.679234 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:04:54.682013 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 19 00:04:54.682061 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:04:54.684600 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 19 00:04:54.684641 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 19 00:04:54.690780 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 19 00:04:54.690854 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:04:54.692111 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 19 00:04:54.692159 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:04:54.695880 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 19 00:04:54.699935 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 19 00:04:54.701591 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 19 00:04:54.701761 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 19 00:04:54.706357 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 19 00:04:54.706458 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 19 00:04:54.708602 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 19 00:04:54.710252 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 19 00:04:54.738203 systemd[1]: Switching root. Aug 19 00:04:54.771096 systemd-journald[243]: Journal stopped Aug 19 00:04:55.863683 systemd-journald[243]: Received SIGTERM from PID 1 (systemd). Aug 19 00:04:55.865890 kernel: SELinux: policy capability network_peer_controls=1 Aug 19 00:04:55.865909 kernel: SELinux: policy capability open_perms=1 Aug 19 00:04:55.865923 kernel: SELinux: policy capability extended_socket_class=1 Aug 19 00:04:55.865933 kernel: SELinux: policy capability always_check_network=0 Aug 19 00:04:55.865943 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 19 00:04:55.865952 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 19 00:04:55.865961 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 19 00:04:55.865970 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 19 00:04:55.865982 kernel: SELinux: policy capability userspace_initial_context=0 Aug 19 00:04:55.865993 kernel: audit: type=1403 audit(1755561895.000:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 19 00:04:55.866007 systemd[1]: Successfully loaded SELinux policy in 68.048ms. Aug 19 00:04:55.866026 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.197ms. Aug 19 00:04:55.866042 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) Aug 19 00:04:55.866055 systemd[1]: Detected virtualization kvm. Aug 19 00:04:55.866064 systemd[1]: Detected architecture arm64. Aug 19 00:04:55.866080 systemd[1]: Detected first boot. Aug 19 00:04:55.866090 systemd[1]: Initializing machine ID from VM UUID. Aug 19 00:04:55.866100 kernel: NET: Registered PF_VSOCK protocol family Aug 19 00:04:55.866113 zram_generator::config[1083]: No configuration found. Aug 19 00:04:55.866125 systemd[1]: Populated /etc with preset unit settings. Aug 19 00:04:55.866136 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Aug 19 00:04:55.866146 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 19 00:04:55.866160 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 19 00:04:55.866170 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 19 00:04:55.866180 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 19 00:04:55.866190 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 19 00:04:55.866200 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 19 00:04:55.866210 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 19 00:04:55.866221 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 19 00:04:55.866231 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 19 00:04:55.866242 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 19 00:04:55.866253 systemd[1]: Created slice user.slice - User and Session Slice. Aug 19 00:04:55.866263 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:04:55.866274 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:04:55.866285 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 19 00:04:55.866295 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 19 00:04:55.866305 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 19 00:04:55.866315 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 19 00:04:55.866325 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 19 00:04:55.866337 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:04:55.866347 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:04:55.866357 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 19 00:04:55.866368 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 19 00:04:55.866378 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 19 00:04:55.866388 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 19 00:04:55.866398 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:04:55.866409 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 19 00:04:55.866420 systemd[1]: Reached target slices.target - Slice Units. Aug 19 00:04:55.866431 systemd[1]: Reached target swap.target - Swaps. Aug 19 00:04:55.866441 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 19 00:04:55.866451 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 19 00:04:55.866462 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Aug 19 00:04:55.866472 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:04:55.866482 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 19 00:04:55.866492 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:04:55.866502 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 19 00:04:55.866514 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 19 00:04:55.866524 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 19 00:04:55.866535 systemd[1]: Mounting media.mount - External Media Directory... Aug 19 00:04:55.866545 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 19 00:04:55.866555 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 19 00:04:55.866573 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 19 00:04:55.866585 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). Aug 19 00:04:55.866596 systemd[1]: Reached target machines.target - Containers. Aug 19 00:04:55.866606 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 19 00:04:55.866619 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:04:55.866630 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 19 00:04:55.866640 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 19 00:04:55.866651 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 19 00:04:55.866661 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 19 00:04:55.866671 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 19 00:04:55.866681 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 19 00:04:55.866692 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 19 00:04:55.866715 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 19 00:04:55.866727 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 19 00:04:55.866737 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 19 00:04:55.866747 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 19 00:04:55.866757 systemd[1]: Stopped systemd-fsck-usr.service. Aug 19 00:04:55.866768 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). Aug 19 00:04:55.866779 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 19 00:04:55.866789 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 19 00:04:55.866799 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 19 00:04:55.866812 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 19 00:04:55.866822 kernel: loop: module loaded Aug 19 00:04:55.866832 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Aug 19 00:04:55.866842 kernel: fuse: init (API version 7.41) Aug 19 00:04:55.866854 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 19 00:04:55.866864 systemd[1]: verity-setup.service: Deactivated successfully. Aug 19 00:04:55.866875 systemd[1]: Stopped verity-setup.service. Aug 19 00:04:55.866885 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 19 00:04:55.866895 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 19 00:04:55.866905 systemd[1]: Mounted media.mount - External Media Directory. Aug 19 00:04:55.866916 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 19 00:04:55.866926 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 19 00:04:55.866936 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 19 00:04:55.866948 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:04:55.866960 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 19 00:04:55.866970 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 19 00:04:55.866981 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 19 00:04:55.866991 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 19 00:04:55.867001 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 19 00:04:55.867013 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 19 00:04:55.867023 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 19 00:04:55.867033 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 19 00:04:55.867043 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 19 00:04:55.867053 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 19 00:04:55.867063 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 19 00:04:55.867073 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 19 00:04:55.867083 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 19 00:04:55.867093 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 19 00:04:55.867105 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 19 00:04:55.867115 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 19 00:04:55.867125 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Aug 19 00:04:55.867135 kernel: ACPI: bus type drm_connector registered Aug 19 00:04:55.867145 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 19 00:04:55.867155 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:04:55.867194 systemd-journald[1141]: Collecting audit messages is disabled. Aug 19 00:04:55.867218 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 19 00:04:55.867229 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 19 00:04:55.867241 systemd-journald[1141]: Journal started Aug 19 00:04:55.867263 systemd-journald[1141]: Runtime Journal (/run/log/journal/fd802a7806f045ee92686f6c3df52bfa) is 6M, max 48.5M, 42.4M free. Aug 19 00:04:55.401080 systemd[1]: Queued start job for default target multi-user.target. Aug 19 00:04:55.414671 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 19 00:04:55.415095 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 19 00:04:55.878170 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 19 00:04:55.878237 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 19 00:04:55.887771 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 19 00:04:55.893125 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 19 00:04:55.902744 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 19 00:04:55.902800 systemd[1]: Started systemd-journald.service - Journal Service. Aug 19 00:04:55.903857 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 19 00:04:55.906152 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 19 00:04:55.907296 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:04:55.909332 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Aug 19 00:04:55.911774 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 19 00:04:55.913826 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 19 00:04:55.976942 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 19 00:04:55.980957 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 19 00:04:56.002732 kernel: loop0: detected capacity change from 0 to 119320 Aug 19 00:04:56.004759 systemd-journald[1141]: Time spent on flushing to /var/log/journal/fd802a7806f045ee92686f6c3df52bfa is 39.130ms for 867 entries. Aug 19 00:04:56.004759 systemd-journald[1141]: System Journal (/var/log/journal/fd802a7806f045ee92686f6c3df52bfa) is 8M, max 195.6M, 187.6M free. Aug 19 00:04:56.161100 systemd-journald[1141]: Received client request to flush runtime journal. Aug 19 00:04:56.161238 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 19 00:04:56.161332 kernel: loop1: detected capacity change from 0 to 100608 Aug 19 00:04:56.013826 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 19 00:04:56.015271 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:04:56.027302 systemd-tmpfiles[1174]: ACLs are not supported, ignoring. Aug 19 00:04:56.027314 systemd-tmpfiles[1174]: ACLs are not supported, ignoring. Aug 19 00:04:56.028688 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:04:56.033663 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 19 00:04:56.037335 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 19 00:04:56.041682 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 19 00:04:56.057999 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Aug 19 00:04:56.063558 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 19 00:04:56.166732 kernel: loop2: detected capacity change from 0 to 207008 Aug 19 00:04:56.165531 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 19 00:04:56.190114 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 19 00:04:56.200992 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 19 00:04:56.231878 kernel: loop3: detected capacity change from 0 to 119320 Aug 19 00:04:56.244420 systemd-tmpfiles[1221]: ACLs are not supported, ignoring. Aug 19 00:04:56.244443 systemd-tmpfiles[1221]: ACLs are not supported, ignoring. Aug 19 00:04:56.250234 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:04:56.256736 kernel: loop4: detected capacity change from 0 to 100608 Aug 19 00:04:56.270761 kernel: loop5: detected capacity change from 0 to 207008 Aug 19 00:04:56.279476 (sd-merge)[1223]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Aug 19 00:04:56.279982 (sd-merge)[1223]: Merged extensions into '/usr'. Aug 19 00:04:56.285105 systemd[1]: Reload requested from client PID 1173 ('systemd-sysext') (unit systemd-sysext.service)... Aug 19 00:04:56.285303 systemd[1]: Reloading... Aug 19 00:04:56.360737 zram_generator::config[1254]: No configuration found. Aug 19 00:04:56.531730 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 19 00:04:56.532012 systemd[1]: Reloading finished in 246 ms. Aug 19 00:04:56.541378 ldconfig[1169]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 19 00:04:56.555814 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 19 00:04:56.557399 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 19 00:04:56.558952 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Aug 19 00:04:56.579289 systemd[1]: Starting ensure-sysext.service... Aug 19 00:04:56.581772 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 19 00:04:56.605714 systemd-tmpfiles[1287]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Aug 19 00:04:56.606275 systemd-tmpfiles[1287]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Aug 19 00:04:56.606585 systemd-tmpfiles[1287]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 19 00:04:56.606805 systemd-tmpfiles[1287]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 19 00:04:56.607426 systemd-tmpfiles[1287]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 19 00:04:56.607646 systemd-tmpfiles[1287]: ACLs are not supported, ignoring. Aug 19 00:04:56.607709 systemd-tmpfiles[1287]: ACLs are not supported, ignoring. Aug 19 00:04:56.614882 systemd-tmpfiles[1287]: Detected autofs mount point /boot during canonicalization of boot. Aug 19 00:04:56.615052 systemd-tmpfiles[1287]: Skipping /boot Aug 19 00:04:56.628576 systemd-tmpfiles[1287]: Detected autofs mount point /boot during canonicalization of boot. Aug 19 00:04:56.628807 systemd-tmpfiles[1287]: Skipping /boot Aug 19 00:04:56.630569 systemd[1]: Reload requested from client PID 1286 ('systemctl') (unit ensure-sysext.service)... Aug 19 00:04:56.630600 systemd[1]: Reloading... Aug 19 00:04:56.684731 zram_generator::config[1314]: No configuration found. Aug 19 00:04:56.854593 systemd[1]: Reloading finished in 223 ms. Aug 19 00:04:56.876649 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 19 00:04:56.883753 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:04:56.903127 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 19 00:04:56.906019 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 19 00:04:56.908413 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 19 00:04:56.914930 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 19 00:04:56.930363 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:04:56.934872 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 19 00:04:56.954003 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 19 00:04:56.959380 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 19 00:04:56.964053 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:04:56.966434 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 19 00:04:56.971043 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 19 00:04:56.974776 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 19 00:04:56.975823 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:04:56.975953 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). Aug 19 00:04:56.986006 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 19 00:04:56.988507 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 19 00:04:56.989401 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 19 00:04:56.991190 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 19 00:04:56.991393 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 19 00:04:57.003371 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 19 00:04:57.004759 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 19 00:04:57.006875 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 19 00:04:57.010963 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 19 00:04:57.018972 systemd-udevd[1355]: Using default interface naming scheme 'v255'. Aug 19 00:04:57.018984 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:04:57.020444 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 19 00:04:57.022743 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 19 00:04:57.028034 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 19 00:04:57.034984 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 19 00:04:57.036099 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:04:57.036236 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). Aug 19 00:04:57.038087 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 19 00:04:57.041272 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 19 00:04:57.043214 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 19 00:04:57.043434 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 19 00:04:57.044055 augenrules[1394]: No rules Aug 19 00:04:57.047848 systemd[1]: audit-rules.service: Deactivated successfully. Aug 19 00:04:57.049512 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 19 00:04:57.051136 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 19 00:04:57.051390 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 19 00:04:57.053015 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 19 00:04:57.053209 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 19 00:04:57.055206 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 19 00:04:57.055436 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 19 00:04:57.060470 systemd[1]: Finished ensure-sysext.service. Aug 19 00:04:57.066081 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:04:57.069444 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 19 00:04:57.071782 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 19 00:04:57.071876 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 19 00:04:57.073860 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 19 00:04:57.076777 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). Aug 19 00:04:57.111567 systemd-resolved[1353]: Positive Trust Anchors: Aug 19 00:04:57.115379 systemd-resolved[1353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 19 00:04:57.115417 systemd-resolved[1353]: 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 Aug 19 00:04:57.125092 systemd-resolved[1353]: Defaulting to hostname 'linux'. Aug 19 00:04:57.126626 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 19 00:04:57.127648 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:04:57.134292 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 19 00:04:57.167932 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 19 00:04:57.170649 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 19 00:04:57.195804 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 19 00:04:57.243749 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 19 00:04:57.245125 systemd[1]: Reached target sysinit.target - System Initialization. Aug 19 00:04:57.246289 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 19 00:04:57.247541 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 19 00:04:57.248630 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 19 00:04:57.249520 systemd-networkd[1413]: lo: Link UP Aug 19 00:04:57.249531 systemd-networkd[1413]: lo: Gained carrier Aug 19 00:04:57.250312 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 19 00:04:57.250351 systemd[1]: Reached target paths.target - Path Units. Aug 19 00:04:57.251209 systemd[1]: Reached target time-set.target - System Time Set. Aug 19 00:04:57.251396 systemd-networkd[1413]: Enumeration completed Aug 19 00:04:57.251902 systemd-networkd[1413]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:04:57.251909 systemd-networkd[1413]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 19 00:04:57.252459 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 19 00:04:57.255011 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 19 00:04:57.255856 systemd-networkd[1413]: eth0: Link UP Aug 19 00:04:57.255974 systemd-networkd[1413]: eth0: Gained carrier Aug 19 00:04:57.255998 systemd-networkd[1413]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:04:57.256191 systemd[1]: Reached target timers.target - Timer Units. Aug 19 00:04:57.259118 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 19 00:04:57.261475 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 19 00:04:57.264656 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Aug 19 00:04:57.266115 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Aug 19 00:04:57.267373 systemd[1]: Reached target ssh-access.target - SSH Access Available. Aug 19 00:04:57.272584 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 19 00:04:57.274281 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Aug 19 00:04:57.276352 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 19 00:04:57.277756 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 19 00:04:57.278915 systemd[1]: Reached target network.target - Network. Aug 19 00:04:57.279712 systemd[1]: Reached target sockets.target - Socket Units. Aug 19 00:04:57.280765 systemd[1]: Reached target basic.target - Basic System. Aug 19 00:04:57.281671 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 19 00:04:57.281724 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 19 00:04:57.282902 systemd[1]: Starting containerd.service - containerd container runtime... Aug 19 00:04:57.285126 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 19 00:04:57.287043 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 19 00:04:57.289815 systemd-networkd[1413]: eth0: DHCPv4 address 10.0.0.18/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 19 00:04:57.290682 systemd-timesyncd[1418]: Network configuration changed, trying to establish connection. Aug 19 00:04:57.291588 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 19 00:04:57.294391 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 19 00:04:57.295134 systemd-timesyncd[1418]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 19 00:04:57.295204 systemd-timesyncd[1418]: Initial clock synchronization to Tue 2025-08-19 00:04:57.033616 UTC. Aug 19 00:04:57.296775 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). Aug 19 00:04:57.299835 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 19 00:04:57.302638 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 19 00:04:57.304862 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 19 00:04:57.310955 jq[1467]: false Aug 19 00:04:57.315475 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 19 00:04:57.317651 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Aug 19 00:04:57.320943 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 19 00:04:57.323299 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 19 00:04:57.324965 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 19 00:04:57.327260 systemd[1]: Starting update-engine.service - Update Engine... Aug 19 00:04:57.329931 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 19 00:04:57.334166 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 19 00:04:57.337103 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 19 00:04:57.337310 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 19 00:04:57.337601 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 19 00:04:57.337798 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 19 00:04:57.358143 jq[1482]: true Aug 19 00:04:57.362219 extend-filesystems[1468]: Found /dev/vda6 Aug 19 00:04:57.366008 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:04:57.391291 (ntainerd)[1499]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 19 00:04:57.392122 extend-filesystems[1468]: Found /dev/vda9 Aug 19 00:04:57.400768 extend-filesystems[1468]: Checking size of /dev/vda9 Aug 19 00:04:57.409011 jq[1494]: true Aug 19 00:04:57.417994 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Aug 19 00:04:57.423072 systemd[1]: motdgen.service: Deactivated successfully. Aug 19 00:04:57.423325 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 19 00:04:57.445075 dbus-daemon[1465]: [system] SELinux support is enabled Aug 19 00:04:57.445287 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 19 00:04:57.448553 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). Aug 19 00:04:57.448596 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 19 00:04:57.450456 update_engine[1480]: I20250819 00:04:57.450193 1480 main.cc:92] Flatcar Update Engine starting Aug 19 00:04:57.451572 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). Aug 19 00:04:57.451596 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 19 00:04:57.457565 extend-filesystems[1468]: Resized partition /dev/vda9 Aug 19 00:04:57.464070 systemd[1]: Started update-engine.service - Update Engine. Aug 19 00:04:57.464473 update_engine[1480]: I20250819 00:04:57.464102 1480 update_check_scheduler.cc:74] Next update check in 7m35s Aug 19 00:04:57.467335 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 19 00:04:57.471750 extend-filesystems[1517]: resize2fs 1.47.2 (1-Jan-2025) Aug 19 00:04:57.485788 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 19 00:04:57.537065 systemd-logind[1472]: Watching system buttons on /dev/input/event0 (Power Button) Aug 19 00:04:57.537350 systemd-logind[1472]: New seat seat0. Aug 19 00:04:57.538848 systemd[1]: Started systemd-logind.service - User Login Management. Aug 19 00:04:57.588316 locksmithd[1522]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 19 00:04:57.590476 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:04:57.599726 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 19 00:04:57.627483 extend-filesystems[1517]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 19 00:04:57.627483 extend-filesystems[1517]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 19 00:04:57.627483 extend-filesystems[1517]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 19 00:04:57.631345 extend-filesystems[1468]: Resized filesystem in /dev/vda9 Aug 19 00:04:57.630523 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 19 00:04:57.630788 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 19 00:04:57.643090 bash[1526]: Updated "/home/core/.ssh/authorized_keys" Aug 19 00:04:57.645098 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 19 00:04:57.647012 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 19 00:04:57.694316 containerd[1499]: time="2025-08-19T00:04:57Z" 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 Aug 19 00:04:57.696116 containerd[1499]: time="2025-08-19T00:04:57.696067920Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Aug 19 00:04:57.706837 containerd[1499]: time="2025-08-19T00:04:57.706774520Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.88µs" Aug 19 00:04:57.706837 containerd[1499]: time="2025-08-19T00:04:57.706819480Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Aug 19 00:04:57.706837 containerd[1499]: time="2025-08-19T00:04:57.706840400Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Aug 19 00:04:57.707060 containerd[1499]: time="2025-08-19T00:04:57.707026840Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Aug 19 00:04:57.707060 containerd[1499]: time="2025-08-19T00:04:57.707053680Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Aug 19 00:04:57.707167 containerd[1499]: time="2025-08-19T00:04:57.707081440Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707167 containerd[1499]: time="2025-08-19T00:04:57.707134120Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707167 containerd[1499]: time="2025-08-19T00:04:57.707145400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707440 containerd[1499]: time="2025-08-19T00:04:57.707393640Z" 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 Aug 19 00:04:57.707466 containerd[1499]: time="2025-08-19T00:04:57.707444840Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707466 containerd[1499]: time="2025-08-19T00:04:57.707458520Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707508 containerd[1499]: time="2025-08-19T00:04:57.707467960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707598 containerd[1499]: time="2025-08-19T00:04:57.707562320Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707818 containerd[1499]: time="2025-08-19T00:04:57.707785760Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Aug 19 00:04:57.707851 containerd[1499]: time="2025-08-19T00:04:57.707819400Z" 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 Aug 19 00:04:57.707851 containerd[1499]: time="2025-08-19T00:04:57.707831280Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Aug 19 00:04:57.707887 containerd[1499]: time="2025-08-19T00:04:57.707868240Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Aug 19 00:04:57.708140 containerd[1499]: time="2025-08-19T00:04:57.708113480Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Aug 19 00:04:57.708197 containerd[1499]: time="2025-08-19T00:04:57.708182520Z" level=info msg="metadata content store policy set" policy=shared Aug 19 00:04:57.736709 containerd[1499]: time="2025-08-19T00:04:57.736649160Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736730080Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736747080Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736775760Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736791960Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736811640Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736824560Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736836800Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Aug 19 00:04:57.736852 containerd[1499]: time="2025-08-19T00:04:57.736851760Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Aug 19 00:04:57.736978 containerd[1499]: time="2025-08-19T00:04:57.736863800Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Aug 19 00:04:57.736978 containerd[1499]: time="2025-08-19T00:04:57.736874480Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Aug 19 00:04:57.736978 containerd[1499]: time="2025-08-19T00:04:57.736887080Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Aug 19 00:04:57.737092 containerd[1499]: time="2025-08-19T00:04:57.737057520Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Aug 19 00:04:57.737092 containerd[1499]: time="2025-08-19T00:04:57.737086160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Aug 19 00:04:57.737092 containerd[1499]: time="2025-08-19T00:04:57.737105160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Aug 19 00:04:57.737092 containerd[1499]: time="2025-08-19T00:04:57.737116960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Aug 19 00:04:57.737926 containerd[1499]: time="2025-08-19T00:04:57.737134760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Aug 19 00:04:57.737979 containerd[1499]: time="2025-08-19T00:04:57.737932080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Aug 19 00:04:57.737979 containerd[1499]: time="2025-08-19T00:04:57.737959760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Aug 19 00:04:57.738036 containerd[1499]: time="2025-08-19T00:04:57.737973960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Aug 19 00:04:57.738036 containerd[1499]: time="2025-08-19T00:04:57.737991320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Aug 19 00:04:57.738036 containerd[1499]: time="2025-08-19T00:04:57.738007000Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Aug 19 00:04:57.738036 containerd[1499]: time="2025-08-19T00:04:57.738023040Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Aug 19 00:04:57.738288 containerd[1499]: time="2025-08-19T00:04:57.738257280Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Aug 19 00:04:57.738288 containerd[1499]: time="2025-08-19T00:04:57.738280480Z" level=info msg="Start snapshots syncer" Aug 19 00:04:57.738339 containerd[1499]: time="2025-08-19T00:04:57.738310920Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Aug 19 00:04:57.738701 containerd[1499]: time="2025-08-19T00:04:57.738645960Z" 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\"}" Aug 19 00:04:57.738806 containerd[1499]: time="2025-08-19T00:04:57.738737800Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Aug 19 00:04:57.739341 containerd[1499]: time="2025-08-19T00:04:57.739302480Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Aug 19 00:04:57.739622 containerd[1499]: time="2025-08-19T00:04:57.739595640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Aug 19 00:04:57.739648 containerd[1499]: time="2025-08-19T00:04:57.739639040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Aug 19 00:04:57.739667 containerd[1499]: time="2025-08-19T00:04:57.739656760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Aug 19 00:04:57.739685 containerd[1499]: time="2025-08-19T00:04:57.739669520Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Aug 19 00:04:57.739734 containerd[1499]: time="2025-08-19T00:04:57.739687360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Aug 19 00:04:57.739734 containerd[1499]: time="2025-08-19T00:04:57.739719240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Aug 19 00:04:57.739770 containerd[1499]: time="2025-08-19T00:04:57.739735000Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Aug 19 00:04:57.739788 containerd[1499]: time="2025-08-19T00:04:57.739769760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Aug 19 00:04:57.739806 containerd[1499]: time="2025-08-19T00:04:57.739785920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Aug 19 00:04:57.739806 containerd[1499]: time="2025-08-19T00:04:57.739801600Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Aug 19 00:04:57.739861 containerd[1499]: time="2025-08-19T00:04:57.739842760Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Aug 19 00:04:57.739883 containerd[1499]: time="2025-08-19T00:04:57.739867240Z" 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 Aug 19 00:04:57.739902 containerd[1499]: time="2025-08-19T00:04:57.739882120Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 19 00:04:57.739902 containerd[1499]: time="2025-08-19T00:04:57.739896760Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 19 00:04:57.739935 containerd[1499]: time="2025-08-19T00:04:57.739906920Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Aug 19 00:04:57.739935 containerd[1499]: time="2025-08-19T00:04:57.739920400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Aug 19 00:04:57.739976 containerd[1499]: time="2025-08-19T00:04:57.739935320Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Aug 19 00:04:57.740045 containerd[1499]: time="2025-08-19T00:04:57.740028160Z" level=info msg="runtime interface created" Aug 19 00:04:57.740045 containerd[1499]: time="2025-08-19T00:04:57.740041720Z" level=info msg="created NRI interface" Aug 19 00:04:57.740080 containerd[1499]: time="2025-08-19T00:04:57.740052480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Aug 19 00:04:57.740080 containerd[1499]: time="2025-08-19T00:04:57.740070280Z" level=info msg="Connect containerd service" Aug 19 00:04:57.740121 containerd[1499]: time="2025-08-19T00:04:57.740105200Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 19 00:04:57.741798 containerd[1499]: time="2025-08-19T00:04:57.741319880Z" 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" Aug 19 00:04:57.834777 containerd[1499]: time="2025-08-19T00:04:57.834685400Z" level=info msg="Start subscribing containerd event" Aug 19 00:04:57.834875 containerd[1499]: time="2025-08-19T00:04:57.834784120Z" level=info msg="Start recovering state" Aug 19 00:04:57.834923 containerd[1499]: time="2025-08-19T00:04:57.834892760Z" level=info msg="Start event monitor" Aug 19 00:04:57.834923 containerd[1499]: time="2025-08-19T00:04:57.834910360Z" level=info msg="Start cni network conf syncer for default" Aug 19 00:04:57.834962 containerd[1499]: time="2025-08-19T00:04:57.834931200Z" level=info msg="Start streaming server" Aug 19 00:04:57.835303 containerd[1499]: time="2025-08-19T00:04:57.834975120Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Aug 19 00:04:57.835303 containerd[1499]: time="2025-08-19T00:04:57.834985520Z" level=info msg="runtime interface starting up..." Aug 19 00:04:57.835303 containerd[1499]: time="2025-08-19T00:04:57.834992000Z" level=info msg="starting plugins..." Aug 19 00:04:57.835303 containerd[1499]: time="2025-08-19T00:04:57.835007200Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Aug 19 00:04:57.835400 containerd[1499]: time="2025-08-19T00:04:57.835351040Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 19 00:04:57.835491 containerd[1499]: time="2025-08-19T00:04:57.835400960Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 19 00:04:57.837798 containerd[1499]: time="2025-08-19T00:04:57.837771960Z" level=info msg="containerd successfully booted in 0.143850s" Aug 19 00:04:57.837894 systemd[1]: Started containerd.service - containerd container runtime. Aug 19 00:04:58.192939 sshd_keygen[1497]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 19 00:04:58.212053 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 19 00:04:58.214589 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 19 00:04:58.229485 systemd[1]: issuegen.service: Deactivated successfully. Aug 19 00:04:58.229729 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 19 00:04:58.232241 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 19 00:04:58.262856 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 19 00:04:58.265576 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 19 00:04:58.267825 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 19 00:04:58.269104 systemd[1]: Reached target getty.target - Login Prompts. Aug 19 00:04:58.871826 systemd-networkd[1413]: eth0: Gained IPv6LL Aug 19 00:04:58.876866 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 19 00:04:58.879789 systemd[1]: Reached target network-online.target - Network is Online. Aug 19 00:04:58.886779 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 19 00:04:58.889830 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 19 00:04:58.892230 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 19 00:04:58.969558 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 19 00:04:58.972441 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 19 00:04:58.972728 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 19 00:04:58.976096 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 19 00:04:59.665528 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 19 00:04:59.666936 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 19 00:04:59.670015 (kubelet)[1600]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Aug 19 00:04:59.672858 systemd[1]: Startup finished in 2.056s (kernel) + 5.360s (initrd) + 4.743s (userspace) = 12.161s. Aug 19 00:05:00.128530 kubelet[1600]: E0819 00:05:00.128422 1600 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" Aug 19 00:05:00.130900 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 19 00:05:00.131035 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 19 00:05:00.131356 systemd[1]: kubelet.service: Consumed 862ms CPU time, 257M memory peak. Aug 19 00:05:02.653113 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 19 00:05:02.654684 systemd[1]: Started sshd@0-10.0.0.18:22-10.0.0.1:49536.service - OpenSSH per-connection server daemon (10.0.0.1:49536). Aug 19 00:05:02.839264 sshd[1613]: Accepted publickey for core from 10.0.0.1 port 49536 ssh2: RSA SHA256:MuzZtQhRnNVq1rVZP5vx2TeC98TmfU3V7QIECoaqFtM Aug 19 00:05:02.844986 sshd-session[1613]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:05:02.860650 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 19 00:05:02.864714 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 19 00:05:02.878988 systemd-logind[1472]: New session 1 of user core. Aug 19 00:05:02.898850 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 19 00:05:02.907668 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 19 00:05:02.924966 (systemd)[1618]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 19 00:05:02.928913 systemd-logind[1472]: New session c1 of user core. Aug 19 00:05:03.073832 systemd[1618]: Queued start job for default target default.target. Aug 19 00:05:03.094925 systemd[1618]: Created slice app.slice - User Application Slice. Aug 19 00:05:03.094954 systemd[1618]: Reached target paths.target - Paths. Aug 19 00:05:03.095000 systemd[1618]: Reached target timers.target - Timers. Aug 19 00:05:03.096648 systemd[1618]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 19 00:05:03.115437 systemd[1618]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 19 00:05:03.115561 systemd[1618]: Reached target sockets.target - Sockets. Aug 19 00:05:03.115604 systemd[1618]: Reached target basic.target - Basic System. Aug 19 00:05:03.115631 systemd[1618]: Reached target default.target - Main User Target. Aug 19 00:05:03.115657 systemd[1618]: Startup finished in 176ms. Aug 19 00:05:03.116458 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 19 00:05:03.121197 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 19 00:05:03.203355 systemd[1]: Started sshd@1-10.0.0.18:22-10.0.0.1:49538.service - OpenSSH per-connection server daemon (10.0.0.1:49538). Aug 19 00:05:03.283714 sshd[1629]: Accepted publickey for core from 10.0.0.1 port 49538 ssh2: RSA SHA256:MuzZtQhRnNVq1rVZP5vx2TeC98TmfU3V7QIECoaqFtM Aug 19 00:05:03.285252 sshd-session[1629]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:05:03.290636 systemd-logind[1472]: New session 2 of user core. Aug 19 00:05:03.297923 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 19 00:05:03.353733 sshd[1632]: Connection closed by 10.0.0.1 port 49538 Aug 19 00:05:03.354590 sshd-session[1629]: pam_unix(sshd:session): session closed for user core Aug 19 00:05:03.362515 systemd[1]: sshd@1-10.0.0.18:22-10.0.0.1:49538.service: Deactivated successfully. Aug 19 00:05:03.364499 systemd[1]: session-2.scope: Deactivated successfully. Aug 19 00:05:03.366531 systemd-logind[1472]: Session 2 logged out. Waiting for processes to exit. Aug 19 00:05:03.374136 systemd[1]: Started sshd@2-10.0.0.18:22-10.0.0.1:49550.service - OpenSSH per-connection server daemon (10.0.0.1:49550). Aug 19 00:05:03.374913 systemd-logind[1472]: Removed session 2. Aug 19 00:05:03.453450 sshd[1638]: Accepted publickey for core from 10.0.0.1 port 49550 ssh2: RSA SHA256:MuzZtQhRnNVq1rVZP5vx2TeC98TmfU3V7QIECoaqFtM Aug 19 00:05:03.454959 sshd-session[1638]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:05:03.464768 systemd-logind[1472]: New session 3 of user core. Aug 19 00:05:03.486222 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 19 00:05:03.542500 sshd[1641]: Connection closed by 10.0.0.1 port 49550 Aug 19 00:05:03.543658 sshd-session[1638]: pam_unix(sshd:session): session closed for user core Aug 19 00:05:03.563115 systemd[1]: sshd@2-10.0.0.18:22-10.0.0.1:49550.service: Deactivated successfully. Aug 19 00:05:03.566661 systemd[1]: session-3.scope: Deactivated successfully. Aug 19 00:05:03.570479 systemd-logind[1472]: Session 3 logged out. Waiting for processes to exit. Aug 19 00:05:03.577541 systemd[1]: Started sshd@3-10.0.0.18:22-10.0.0.1:49552.service - OpenSSH per-connection server daemon (10.0.0.1:49552). Aug 19 00:05:03.579010 systemd-logind[1472]: Removed session 3. Aug 19 00:05:03.648881 sshd[1647]: Accepted publickey for core from 10.0.0.1 port 49552 ssh2: RSA SHA256:MuzZtQhRnNVq1rVZP5vx2TeC98TmfU3V7QIECoaqFtM Aug 19 00:05:03.650305 sshd-session[1647]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:05:03.655510 systemd-logind[1472]: New session 4 of user core. Aug 19 00:05:03.672079 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 19 00:05:03.726666 sshd[1650]: Connection closed by 10.0.0.1 port 49552 Aug 19 00:05:03.726446 sshd-session[1647]: pam_unix(sshd:session): session closed for user core Aug 19 00:05:03.739407 systemd[1]: sshd@3-10.0.0.18:22-10.0.0.1:49552.service: Deactivated successfully. Aug 19 00:05:03.743089 systemd[1]: session-4.scope: Deactivated successfully. Aug 19 00:05:03.744198 systemd-logind[1472]: Session 4 logged out. Waiting for processes to exit. Aug 19 00:05:03.748098 systemd[1]: Started sshd@4-10.0.0.18:22-10.0.0.1:49554.service - OpenSSH per-connection server daemon (10.0.0.1:49554). Aug 19 00:05:03.748570 systemd-logind[1472]: Removed session 4. Aug 19 00:05:03.807998 sshd[1656]: Accepted publickey for core from 10.0.0.1 port 49554 ssh2: RSA SHA256:MuzZtQhRnNVq1rVZP5vx2TeC98TmfU3V7QIECoaqFtM Aug 19 00:05:03.809432 sshd-session[1656]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:05:03.815486 systemd-logind[1472]: New session 5 of user core. Aug 19 00:05:03.826942 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 19 00:05:03.885775 sudo[1660]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 19 00:05:03.886050 sudo[1660]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 19 00:05:03.897940 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 19 00:05:03.927410 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 19 00:05:03.927687 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 19 00:05:04.547482 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 19 00:05:04.547636 systemd[1]: kubelet.service: Consumed 862ms CPU time, 257M memory peak. Aug 19 00:05:04.552973 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 19 00:05:04.583346 systemd[1]: Reload requested from client PID 1702 ('systemctl') (unit session-5.scope)... Aug 19 00:05:04.583371 systemd[1]: Reloading... Aug 19 00:05:04.681732 zram_generator::config[1742]: No configuration found. Aug 19 00:05:04.961253 systemd[1]: Reloading finished in 377 ms. Aug 19 00:05:05.024430 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Aug 19 00:05:05.024522 systemd[1]: kubelet.service: Failed with result 'signal'. Aug 19 00:05:05.024826 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 19 00:05:05.024891 systemd[1]: kubelet.service: Consumed 110ms CPU time, 95M memory peak. Aug 19 00:05:05.026650 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 19 00:05:05.151160 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 19 00:05:05.155528 (kubelet)[1788]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Aug 19 00:05:05.193418 kubelet[1788]: 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. Aug 19 00:05:05.193418 kubelet[1788]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Aug 19 00:05:05.193418 kubelet[1788]: 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. Aug 19 00:05:05.194953 kubelet[1788]: I0819 00:05:05.193502 1788 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Aug 19 00:05:05.794077 kubelet[1788]: I0819 00:05:05.794023 1788 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Aug 19 00:05:05.794077 kubelet[1788]: I0819 00:05:05.794063 1788 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 19 00:05:05.794380 kubelet[1788]: I0819 00:05:05.794350 1788 server.go:954] "Client rotation is on, will bootstrap in background" Aug 19 00:05:05.837576 kubelet[1788]: I0819 00:05:05.837338 1788 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 19 00:05:05.846989 kubelet[1788]: I0819 00:05:05.846956 1788 server.go:1444] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Aug 19 00:05:05.851136 kubelet[1788]: I0819 00:05:05.850118 1788 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 19 00:05:05.851136 kubelet[1788]: I0819 00:05:05.850403 1788 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 19 00:05:05.851136 kubelet[1788]: I0819 00:05:05.850435 1788 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.18","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Aug 19 00:05:05.851136 kubelet[1788]: I0819 00:05:05.850692 1788 topology_manager.go:138] "Creating topology manager with none policy" Aug 19 00:05:05.851409 kubelet[1788]: I0819 00:05:05.850715 1788 container_manager_linux.go:304] "Creating device plugin manager" Aug 19 00:05:05.851409 kubelet[1788]: I0819 00:05:05.850953 1788 state_mem.go:36] "Initialized new in-memory state store" Aug 19 00:05:05.856436 kubelet[1788]: I0819 00:05:05.856399 1788 kubelet.go:446] "Attempting to sync node with API server" Aug 19 00:05:05.856635 kubelet[1788]: I0819 00:05:05.856621 1788 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 19 00:05:05.857676 kubelet[1788]: I0819 00:05:05.857629 1788 kubelet.go:352] "Adding apiserver pod source" Aug 19 00:05:05.857676 kubelet[1788]: I0819 00:05:05.857659 1788 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 19 00:05:05.857834 kubelet[1788]: E0819 00:05:05.857772 1788 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:05.858012 kubelet[1788]: E0819 00:05:05.857978 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:05.861692 kubelet[1788]: I0819 00:05:05.861668 1788 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v2.0.5" apiVersion="v1" Aug 19 00:05:05.864299 kubelet[1788]: I0819 00:05:05.864271 1788 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Aug 19 00:05:05.864544 kubelet[1788]: W0819 00:05:05.864469 1788 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 19 00:05:05.865740 kubelet[1788]: I0819 00:05:05.865719 1788 watchdog_linux.go:99] "Systemd watchdog is not enabled" Aug 19 00:05:05.865786 kubelet[1788]: I0819 00:05:05.865762 1788 server.go:1287] "Started kubelet" Aug 19 00:05:05.865887 kubelet[1788]: I0819 00:05:05.865851 1788 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Aug 19 00:05:05.866869 kubelet[1788]: I0819 00:05:05.866845 1788 server.go:479] "Adding debug handlers to kubelet server" Aug 19 00:05:05.867399 kubelet[1788]: I0819 00:05:05.867320 1788 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Aug 19 00:05:05.867752 kubelet[1788]: I0819 00:05:05.867725 1788 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 19 00:05:05.869267 kubelet[1788]: I0819 00:05:05.869236 1788 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 19 00:05:05.869758 kubelet[1788]: I0819 00:05:05.869733 1788 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Aug 19 00:05:05.870243 kubelet[1788]: E0819 00:05:05.870198 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:05.870276 kubelet[1788]: I0819 00:05:05.870256 1788 volume_manager.go:297] "Starting Kubelet Volume Manager" Aug 19 00:05:05.870512 kubelet[1788]: I0819 00:05:05.870492 1788 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Aug 19 00:05:05.870585 kubelet[1788]: I0819 00:05:05.870573 1788 reconciler.go:26] "Reconciler: start to sync state" Aug 19 00:05:05.871304 kubelet[1788]: I0819 00:05:05.871269 1788 factory.go:221] Registration of the systemd container factory successfully Aug 19 00:05:05.871662 kubelet[1788]: I0819 00:05:05.871627 1788 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Aug 19 00:05:05.872034 kubelet[1788]: W0819 00:05:05.872004 1788 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.18" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Aug 19 00:05:05.872086 kubelet[1788]: E0819 00:05:05.872044 1788 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.18\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Aug 19 00:05:05.872459 kubelet[1788]: E0819 00:05:05.872175 1788 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.18.185d02408455d515 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.18,UID:10.0.0.18,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.18,},FirstTimestamp:2025-08-19 00:05:05.865741589 +0000 UTC m=+0.707128850,LastTimestamp:2025-08-19 00:05:05.865741589 +0000 UTC m=+0.707128850,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.18,}" Aug 19 00:05:05.873306 kubelet[1788]: E0819 00:05:05.873147 1788 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 19 00:05:05.873306 kubelet[1788]: W0819 00:05:05.873218 1788 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Aug 19 00:05:05.873306 kubelet[1788]: E0819 00:05:05.873246 1788 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Aug 19 00:05:05.874224 kubelet[1788]: I0819 00:05:05.874193 1788 factory.go:221] Registration of the containerd container factory successfully Aug 19 00:05:05.881721 kubelet[1788]: E0819 00:05:05.881376 1788 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.18.185d024084c69bc0 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.18,UID:10.0.0.18,APIVersion:,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.18,},FirstTimestamp:2025-08-19 00:05:05.87313248 +0000 UTC m=+0.714519741,LastTimestamp:2025-08-19 00:05:05.87313248 +0000 UTC m=+0.714519741,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.18,}" Aug 19 00:05:05.881721 kubelet[1788]: W0819 00:05:05.881592 1788 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Aug 19 00:05:05.881721 kubelet[1788]: E0819 00:05:05.881621 1788 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Aug 19 00:05:05.881721 kubelet[1788]: E0819 00:05:05.881716 1788 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.18\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Aug 19 00:05:05.884179 kubelet[1788]: I0819 00:05:05.884152 1788 cpu_manager.go:221] "Starting CPU manager" policy="none" Aug 19 00:05:05.884670 kubelet[1788]: I0819 00:05:05.884430 1788 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Aug 19 00:05:05.884670 kubelet[1788]: I0819 00:05:05.884462 1788 state_mem.go:36] "Initialized new in-memory state store" Aug 19 00:05:05.958942 kubelet[1788]: I0819 00:05:05.958909 1788 policy_none.go:49] "None policy: Start" Aug 19 00:05:05.959069 kubelet[1788]: I0819 00:05:05.959058 1788 memory_manager.go:186] "Starting memorymanager" policy="None" Aug 19 00:05:05.959121 kubelet[1788]: I0819 00:05:05.959114 1788 state_mem.go:35] "Initializing new in-memory state store" Aug 19 00:05:05.966666 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Aug 19 00:05:05.970356 kubelet[1788]: E0819 00:05:05.970323 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:05.984004 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Aug 19 00:05:05.988328 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Aug 19 00:05:05.994658 kubelet[1788]: I0819 00:05:05.994621 1788 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 19 00:05:05.995079 kubelet[1788]: I0819 00:05:05.994960 1788 eviction_manager.go:189] "Eviction manager: starting control loop" Aug 19 00:05:05.995151 kubelet[1788]: I0819 00:05:05.994975 1788 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Aug 19 00:05:05.995500 kubelet[1788]: I0819 00:05:05.995443 1788 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 19 00:05:05.996382 kubelet[1788]: E0819 00:05:05.996348 1788 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Aug 19 00:05:05.996446 kubelet[1788]: E0819 00:05:05.996398 1788 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.18\" not found" Aug 19 00:05:06.010092 kubelet[1788]: I0819 00:05:06.010030 1788 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 19 00:05:06.011149 kubelet[1788]: I0819 00:05:06.011117 1788 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 19 00:05:06.011149 kubelet[1788]: I0819 00:05:06.011147 1788 status_manager.go:227] "Starting to sync pod status with apiserver" Aug 19 00:05:06.011149 kubelet[1788]: I0819 00:05:06.011171 1788 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Aug 19 00:05:06.011149 kubelet[1788]: I0819 00:05:06.011183 1788 kubelet.go:2382] "Starting kubelet main sync loop" Aug 19 00:05:06.011149 kubelet[1788]: E0819 00:05:06.011226 1788 kubelet.go:2406] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Aug 19 00:05:06.089156 kubelet[1788]: E0819 00:05:06.089016 1788 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.18\" not found" node="10.0.0.18" Aug 19 00:05:06.097286 kubelet[1788]: I0819 00:05:06.096946 1788 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.18" Aug 19 00:05:06.108982 kubelet[1788]: I0819 00:05:06.108929 1788 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.18" Aug 19 00:05:06.108982 kubelet[1788]: E0819 00:05:06.108978 1788 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.18\": node \"10.0.0.18\" not found" Aug 19 00:05:06.150626 kubelet[1788]: E0819 00:05:06.150562 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.192043 sudo[1660]: pam_unix(sudo:session): session closed for user root Aug 19 00:05:06.194721 sshd[1659]: Connection closed by 10.0.0.1 port 49554 Aug 19 00:05:06.195305 sshd-session[1656]: pam_unix(sshd:session): session closed for user core Aug 19 00:05:06.200003 systemd[1]: sshd@4-10.0.0.18:22-10.0.0.1:49554.service: Deactivated successfully. Aug 19 00:05:06.201867 systemd[1]: session-5.scope: Deactivated successfully. Aug 19 00:05:06.202054 systemd[1]: session-5.scope: Consumed 559ms CPU time, 75.5M memory peak. Aug 19 00:05:06.203016 systemd-logind[1472]: Session 5 logged out. Waiting for processes to exit. Aug 19 00:05:06.204594 systemd-logind[1472]: Removed session 5. Aug 19 00:05:06.250827 kubelet[1788]: E0819 00:05:06.250777 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.351792 kubelet[1788]: E0819 00:05:06.351365 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.452238 kubelet[1788]: E0819 00:05:06.452194 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.552830 kubelet[1788]: E0819 00:05:06.552745 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.653920 kubelet[1788]: E0819 00:05:06.653820 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.754422 kubelet[1788]: E0819 00:05:06.754380 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.797002 kubelet[1788]: I0819 00:05:06.796947 1788 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 19 00:05:06.797219 kubelet[1788]: W0819 00:05:06.797191 1788 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Aug 19 00:05:06.854616 kubelet[1788]: E0819 00:05:06.854573 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:06.858859 kubelet[1788]: E0819 00:05:06.858814 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:06.955492 kubelet[1788]: E0819 00:05:06.955325 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:07.056096 kubelet[1788]: E0819 00:05:07.056022 1788 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.18\" not found" Aug 19 00:05:07.157751 kubelet[1788]: I0819 00:05:07.157650 1788 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 19 00:05:07.158062 containerd[1499]: time="2025-08-19T00:05:07.157998903Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 19 00:05:07.158894 kubelet[1788]: I0819 00:05:07.158640 1788 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 19 00:05:07.859532 kubelet[1788]: I0819 00:05:07.859464 1788 apiserver.go:52] "Watching apiserver" Aug 19 00:05:07.859532 kubelet[1788]: E0819 00:05:07.859459 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:07.870871 kubelet[1788]: I0819 00:05:07.870767 1788 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Aug 19 00:05:07.877218 systemd[1]: Created slice kubepods-besteffort-pod82691a3e_25c2_4873_875e_632676f22047.slice - libcontainer container kubepods-besteffort-pod82691a3e_25c2_4873_875e_632676f22047.slice. Aug 19 00:05:07.885199 kubelet[1788]: I0819 00:05:07.885153 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/82691a3e-25c2-4873-875e-632676f22047-kube-proxy\") pod \"kube-proxy-92dls\" (UID: \"82691a3e-25c2-4873-875e-632676f22047\") " pod="kube-system/kube-proxy-92dls" Aug 19 00:05:07.885199 kubelet[1788]: I0819 00:05:07.885197 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/82691a3e-25c2-4873-875e-632676f22047-xtables-lock\") pod \"kube-proxy-92dls\" (UID: \"82691a3e-25c2-4873-875e-632676f22047\") " pod="kube-system/kube-proxy-92dls" Aug 19 00:05:07.885199 kubelet[1788]: I0819 00:05:07.885217 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/db9e1ee4-de87-4d1e-a93f-43011ec68aba-cni-plugin\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.885374 kubelet[1788]: I0819 00:05:07.885232 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/db9e1ee4-de87-4d1e-a93f-43011ec68aba-xtables-lock\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.885374 kubelet[1788]: I0819 00:05:07.885262 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/db9e1ee4-de87-4d1e-a93f-43011ec68aba-flannel-cfg\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.885374 kubelet[1788]: I0819 00:05:07.885279 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-x6hwf\" (UniqueName: \"kubernetes.io/projected/db9e1ee4-de87-4d1e-a93f-43011ec68aba-kube-api-access-x6hwf\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.885374 kubelet[1788]: I0819 00:05:07.885298 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/82691a3e-25c2-4873-875e-632676f22047-lib-modules\") pod \"kube-proxy-92dls\" (UID: \"82691a3e-25c2-4873-875e-632676f22047\") " pod="kube-system/kube-proxy-92dls" Aug 19 00:05:07.885374 kubelet[1788]: I0819 00:05:07.885315 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-whqmc\" (UniqueName: \"kubernetes.io/projected/82691a3e-25c2-4873-875e-632676f22047-kube-api-access-whqmc\") pod \"kube-proxy-92dls\" (UID: \"82691a3e-25c2-4873-875e-632676f22047\") " pod="kube-system/kube-proxy-92dls" Aug 19 00:05:07.885479 kubelet[1788]: I0819 00:05:07.885340 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/db9e1ee4-de87-4d1e-a93f-43011ec68aba-run\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.885479 kubelet[1788]: I0819 00:05:07.885362 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/db9e1ee4-de87-4d1e-a93f-43011ec68aba-cni\") pod \"kube-flannel-ds-8z52g\" (UID: \"db9e1ee4-de87-4d1e-a93f-43011ec68aba\") " pod="kube-flannel/kube-flannel-ds-8z52g" Aug 19 00:05:07.906577 systemd[1]: Created slice kubepods-burstable-poddb9e1ee4_de87_4d1e_a93f_43011ec68aba.slice - libcontainer container kubepods-burstable-poddb9e1ee4_de87_4d1e_a93f_43011ec68aba.slice. Aug 19 00:05:08.204566 containerd[1499]: time="2025-08-19T00:05:08.204452531Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-92dls,Uid:82691a3e-25c2-4873-875e-632676f22047,Namespace:kube-system,Attempt:0,}" Aug 19 00:05:08.220732 containerd[1499]: time="2025-08-19T00:05:08.220665594Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-8z52g,Uid:db9e1ee4-de87-4d1e-a93f-43011ec68aba,Namespace:kube-flannel,Attempt:0,}" Aug 19 00:05:08.746381 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1180017456.mount: Deactivated successfully. Aug 19 00:05:08.756729 containerd[1499]: time="2025-08-19T00:05:08.756561611Z" 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\"}" Aug 19 00:05:08.757936 containerd[1499]: time="2025-08-19T00:05:08.757898618Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=268705" Aug 19 00:05:08.758822 containerd[1499]: time="2025-08-19T00:05:08.758787035Z" 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\"}" Aug 19 00:05:08.760473 containerd[1499]: time="2025-08-19T00:05:08.760413334Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Aug 19 00:05:08.761172 containerd[1499]: time="2025-08-19T00:05:08.761086695Z" level=info msg="ImageCreate event name:\"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 19 00:05:08.765582 containerd[1499]: time="2025-08-19T00:05:08.763995078Z" 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\"}" Aug 19 00:05:08.765582 containerd[1499]: time="2025-08-19T00:05:08.765094545Z" 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 543.350938ms" Aug 19 00:05:08.766368 containerd[1499]: time="2025-08-19T00:05:08.765831991Z" 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 516.878827ms" Aug 19 00:05:08.793290 containerd[1499]: time="2025-08-19T00:05:08.792385198Z" level=info msg="connecting to shim eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7" address="unix:///run/containerd/s/81c83d1d6e6758ca2dfae899f4cf0886f9eda184e77aa80305d8f1a611199673" namespace=k8s.io protocol=ttrpc version=3 Aug 19 00:05:08.799248 containerd[1499]: time="2025-08-19T00:05:08.799195390Z" level=info msg="connecting to shim d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead" address="unix:///run/containerd/s/bf62585c8c82b96ec09bdc8770191099bb81a5a7bddd421bdc8b687e10f9fbb8" namespace=k8s.io protocol=ttrpc version=3 Aug 19 00:05:08.825919 systemd[1]: Started cri-containerd-d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead.scope - libcontainer container d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead. Aug 19 00:05:08.827943 systemd[1]: Started cri-containerd-eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7.scope - libcontainer container eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7. Aug 19 00:05:08.851407 containerd[1499]: time="2025-08-19T00:05:08.851350414Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-92dls,Uid:82691a3e-25c2-4873-875e-632676f22047,Namespace:kube-system,Attempt:0,} returns sandbox id \"eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7\"" Aug 19 00:05:08.854368 containerd[1499]: time="2025-08-19T00:05:08.854254514Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.8\"" Aug 19 00:05:08.860052 kubelet[1788]: E0819 00:05:08.860002 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:08.866213 containerd[1499]: time="2025-08-19T00:05:08.866156279Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-8z52g,Uid:db9e1ee4-de87-4d1e-a93f-43011ec68aba,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\"" Aug 19 00:05:09.861127 kubelet[1788]: E0819 00:05:09.861058 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:09.875380 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount596338713.mount: Deactivated successfully. Aug 19 00:05:10.113749 containerd[1499]: time="2025-08-19T00:05:10.113607139Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:10.114284 containerd[1499]: time="2025-08-19T00:05:10.114244874Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.8: active requests=0, bytes read=27376726" Aug 19 00:05:10.115263 containerd[1499]: time="2025-08-19T00:05:10.115221286Z" level=info msg="ImageCreate event name:\"sha256:2cf30e39f99f8f4ee1a736a4f3175cc2d8d3f58936d8fa83ec5523658fdc7b8b\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:10.117322 containerd[1499]: time="2025-08-19T00:05:10.117288590Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:adc1335b480ddd833aac3b0bd20f68ff0f3c3cf7a0bd337933b006d9f5cec40a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:10.118159 containerd[1499]: time="2025-08-19T00:05:10.117960141Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.32.8\" with image id \"sha256:2cf30e39f99f8f4ee1a736a4f3175cc2d8d3f58936d8fa83ec5523658fdc7b8b\", repo tag \"registry.k8s.io/kube-proxy:v1.32.8\", repo digest \"registry.k8s.io/kube-proxy@sha256:adc1335b480ddd833aac3b0bd20f68ff0f3c3cf7a0bd337933b006d9f5cec40a\", size \"27375743\" in 1.26364961s" Aug 19 00:05:10.118159 containerd[1499]: time="2025-08-19T00:05:10.117998089Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.8\" returns image reference \"sha256:2cf30e39f99f8f4ee1a736a4f3175cc2d8d3f58936d8fa83ec5523658fdc7b8b\"" Aug 19 00:05:10.119854 containerd[1499]: time="2025-08-19T00:05:10.119819979Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 19 00:05:10.121312 containerd[1499]: time="2025-08-19T00:05:10.121184062Z" level=info msg="CreateContainer within sandbox \"eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 19 00:05:10.132389 containerd[1499]: time="2025-08-19T00:05:10.132338326Z" level=info msg="Container 43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:10.135487 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2166604159.mount: Deactivated successfully. Aug 19 00:05:10.142072 containerd[1499]: time="2025-08-19T00:05:10.142008461Z" level=info msg="CreateContainer within sandbox \"eb248419c81e5e29ac8caf7b3692ea10560d67fd60f3689994132091c5bfbaf7\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d\"" Aug 19 00:05:10.144815 containerd[1499]: time="2025-08-19T00:05:10.144775053Z" level=info msg="StartContainer for \"43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d\"" Aug 19 00:05:10.146478 containerd[1499]: time="2025-08-19T00:05:10.146433029Z" level=info msg="connecting to shim 43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d" address="unix:///run/containerd/s/81c83d1d6e6758ca2dfae899f4cf0886f9eda184e77aa80305d8f1a611199673" protocol=ttrpc version=3 Aug 19 00:05:10.166913 systemd[1]: Started cri-containerd-43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d.scope - libcontainer container 43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d. Aug 19 00:05:10.203881 containerd[1499]: time="2025-08-19T00:05:10.202573341Z" level=info msg="StartContainer for \"43718c76eecce295e89251a06be96c53db48acd280a5bbee7dfb3e1ef180243d\" returns successfully" Aug 19 00:05:10.864249 kubelet[1788]: E0819 00:05:10.864192 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:11.051612 kubelet[1788]: I0819 00:05:11.051479 1788 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-92dls" podStartSLOduration=3.786335279 podStartE2EDuration="5.05146268s" podCreationTimestamp="2025-08-19 00:05:06 +0000 UTC" firstStartedPulling="2025-08-19 00:05:08.853840662 +0000 UTC m=+3.695227923" lastFinishedPulling="2025-08-19 00:05:10.118968063 +0000 UTC m=+4.960355324" observedRunningTime="2025-08-19 00:05:11.051284194 +0000 UTC m=+5.892671455" watchObservedRunningTime="2025-08-19 00:05:11.05146268 +0000 UTC m=+5.892849981" Aug 19 00:05:11.653946 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1355863726.mount: Deactivated successfully. Aug 19 00:05:11.804622 containerd[1499]: time="2025-08-19T00:05:11.803957790Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:11.805825 containerd[1499]: time="2025-08-19T00:05:11.805780990Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532" Aug 19 00:05:11.806854 containerd[1499]: time="2025-08-19T00:05:11.806788554Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:11.809474 containerd[1499]: time="2025-08-19T00:05:11.809426236Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:11.810634 containerd[1499]: time="2025-08-19T00:05:11.810510636Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3662650\" in 1.69044134s" Aug 19 00:05:11.810634 containerd[1499]: time="2025-08-19T00:05:11.810545076Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Aug 19 00:05:11.813386 containerd[1499]: time="2025-08-19T00:05:11.813343786Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 19 00:05:11.823735 containerd[1499]: time="2025-08-19T00:05:11.823616804Z" level=info msg="Container 4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:11.835599 containerd[1499]: time="2025-08-19T00:05:11.835555136Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\"" Aug 19 00:05:11.836061 containerd[1499]: time="2025-08-19T00:05:11.836034440Z" level=info msg="StartContainer for \"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\"" Aug 19 00:05:11.837304 containerd[1499]: time="2025-08-19T00:05:11.837159882Z" level=info msg="connecting to shim 4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4" address="unix:///run/containerd/s/bf62585c8c82b96ec09bdc8770191099bb81a5a7bddd421bdc8b687e10f9fbb8" protocol=ttrpc version=3 Aug 19 00:05:11.860914 systemd[1]: Started cri-containerd-4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4.scope - libcontainer container 4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4. Aug 19 00:05:11.865087 kubelet[1788]: E0819 00:05:11.865014 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:11.892109 containerd[1499]: time="2025-08-19T00:05:11.892070357Z" level=info msg="StartContainer for \"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\" returns successfully" Aug 19 00:05:11.899945 systemd[1]: cri-containerd-4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4.scope: Deactivated successfully. Aug 19 00:05:11.901327 containerd[1499]: time="2025-08-19T00:05:11.901217894Z" level=info msg="received exit event container_id:\"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\" id:\"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\" pid:2119 exited_at:{seconds:1755561911 nanos:900742090}" Aug 19 00:05:11.901576 containerd[1499]: time="2025-08-19T00:05:11.901286020Z" level=info msg="TaskExit event in podsandbox handler container_id:\"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\" id:\"4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4\" pid:2119 exited_at:{seconds:1755561911 nanos:900742090}" Aug 19 00:05:12.596917 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-4b63de74440cf9727e60fbb4ec4d97c9b349e37ae337c8c68a964986983d29f4-rootfs.mount: Deactivated successfully. Aug 19 00:05:12.866169 kubelet[1788]: E0819 00:05:12.866049 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:13.039361 containerd[1499]: time="2025-08-19T00:05:13.039315772Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 19 00:05:13.866488 kubelet[1788]: E0819 00:05:13.866428 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:14.636892 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3028108195.mount: Deactivated successfully. Aug 19 00:05:14.867409 kubelet[1788]: E0819 00:05:14.867332 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:15.576305 containerd[1499]: time="2025-08-19T00:05:15.575426472Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:15.576305 containerd[1499]: time="2025-08-19T00:05:15.575868455Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261" Aug 19 00:05:15.577104 containerd[1499]: time="2025-08-19T00:05:15.577070822Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:15.579596 containerd[1499]: time="2025-08-19T00:05:15.579556842Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:15.580655 containerd[1499]: time="2025-08-19T00:05:15.580472421Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26863435\" in 2.541108771s" Aug 19 00:05:15.580655 containerd[1499]: time="2025-08-19T00:05:15.580501403Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Aug 19 00:05:15.582830 containerd[1499]: time="2025-08-19T00:05:15.582798104Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 19 00:05:15.589599 containerd[1499]: time="2025-08-19T00:05:15.588994955Z" level=info msg="Container 28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:15.598178 containerd[1499]: time="2025-08-19T00:05:15.598135076Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\"" Aug 19 00:05:15.599132 containerd[1499]: time="2025-08-19T00:05:15.599060023Z" level=info msg="StartContainer for \"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\"" Aug 19 00:05:15.600297 containerd[1499]: time="2025-08-19T00:05:15.600268410Z" level=info msg="connecting to shim 28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda" address="unix:///run/containerd/s/bf62585c8c82b96ec09bdc8770191099bb81a5a7bddd421bdc8b687e10f9fbb8" protocol=ttrpc version=3 Aug 19 00:05:15.628887 systemd[1]: Started cri-containerd-28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda.scope - libcontainer container 28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda. Aug 19 00:05:15.664051 containerd[1499]: time="2025-08-19T00:05:15.663992771Z" level=info msg="StartContainer for \"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\" returns successfully" Aug 19 00:05:15.680973 systemd[1]: cri-containerd-28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda.scope: Deactivated successfully. Aug 19 00:05:15.682902 containerd[1499]: time="2025-08-19T00:05:15.682745933Z" level=info msg="received exit event container_id:\"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\" id:\"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\" pid:2193 exited_at:{seconds:1755561915 nanos:681927186}" Aug 19 00:05:15.683036 containerd[1499]: time="2025-08-19T00:05:15.682938441Z" level=info msg="TaskExit event in podsandbox handler container_id:\"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\" id:\"28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda\" pid:2193 exited_at:{seconds:1755561915 nanos:681927186}" Aug 19 00:05:15.704616 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-28bcf986b5ea9b2992b0e242592e9979376809c71d7fda19a2771d63d8802fda-rootfs.mount: Deactivated successfully. Aug 19 00:05:15.738528 kubelet[1788]: I0819 00:05:15.738498 1788 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Aug 19 00:05:15.868099 kubelet[1788]: E0819 00:05:15.867970 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:16.047153 containerd[1499]: time="2025-08-19T00:05:16.047110670Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 19 00:05:16.070663 containerd[1499]: time="2025-08-19T00:05:16.070057292Z" level=info msg="Container 7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:16.079987 containerd[1499]: time="2025-08-19T00:05:16.079946835Z" level=info msg="CreateContainer within sandbox \"d872019967d4a20e3daa9dbcd083a5a8d961ffbb8c5d09dfe20698f9cbdd7ead\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab\"" Aug 19 00:05:16.080918 containerd[1499]: time="2025-08-19T00:05:16.080879153Z" level=info msg="StartContainer for \"7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab\"" Aug 19 00:05:16.082226 containerd[1499]: time="2025-08-19T00:05:16.082191983Z" level=info msg="connecting to shim 7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab" address="unix:///run/containerd/s/bf62585c8c82b96ec09bdc8770191099bb81a5a7bddd421bdc8b687e10f9fbb8" protocol=ttrpc version=3 Aug 19 00:05:16.110907 systemd[1]: Started cri-containerd-7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab.scope - libcontainer container 7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab. Aug 19 00:05:16.147751 containerd[1499]: time="2025-08-19T00:05:16.145236339Z" level=info msg="StartContainer for \"7a27e95ba69556473a8196059587faf11733678b7c21478696b106b6b56052ab\" returns successfully" Aug 19 00:05:16.868310 kubelet[1788]: E0819 00:05:16.868235 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:17.178108 kubelet[1788]: I0819 00:05:17.177952 1788 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-8z52g" podStartSLOduration=4.463611394 podStartE2EDuration="11.177933398s" podCreationTimestamp="2025-08-19 00:05:06 +0000 UTC" firstStartedPulling="2025-08-19 00:05:08.867345012 +0000 UTC m=+3.708732272" lastFinishedPulling="2025-08-19 00:05:15.581667015 +0000 UTC m=+10.423054276" observedRunningTime="2025-08-19 00:05:17.066716939 +0000 UTC m=+11.908104240" watchObservedRunningTime="2025-08-19 00:05:17.177933398 +0000 UTC m=+12.019320659" Aug 19 00:05:17.183858 systemd[1]: Created slice kubepods-besteffort-podd02610d4_0633_4ff5_a297_1b5630b9eb27.slice - libcontainer container kubepods-besteffort-podd02610d4_0633_4ff5_a297_1b5630b9eb27.slice. Aug 19 00:05:17.250581 systemd-networkd[1413]: flannel.1: Link UP Aug 19 00:05:17.250591 systemd-networkd[1413]: flannel.1: Gained carrier Aug 19 00:05:17.260951 kubelet[1788]: I0819 00:05:17.258668 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5bv8j\" (UniqueName: \"kubernetes.io/projected/d02610d4-0633-4ff5-a297-1b5630b9eb27-kube-api-access-5bv8j\") pod \"nginx-deployment-7fcdb87857-7d9cs\" (UID: \"d02610d4-0633-4ff5-a297-1b5630b9eb27\") " pod="default/nginx-deployment-7fcdb87857-7d9cs" Aug 19 00:05:17.487384 containerd[1499]: time="2025-08-19T00:05:17.487281783Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-7d9cs,Uid:d02610d4-0633-4ff5-a297-1b5630b9eb27,Namespace:default,Attempt:0,}" Aug 19 00:05:17.524952 systemd-networkd[1413]: cni0: Link UP Aug 19 00:05:17.532993 systemd-networkd[1413]: veth58998dc3: Link UP Aug 19 00:05:17.536756 kernel: cni0: port 1(veth58998dc3) entered blocking state Aug 19 00:05:17.536859 kernel: cni0: port 1(veth58998dc3) entered disabled state Aug 19 00:05:17.536879 kernel: veth58998dc3: entered allmulticast mode Aug 19 00:05:17.537749 kernel: veth58998dc3: entered promiscuous mode Aug 19 00:05:17.550614 systemd-networkd[1413]: veth58998dc3: Gained carrier Aug 19 00:05:17.550793 kernel: cni0: port 1(veth58998dc3) entered blocking state Aug 19 00:05:17.550820 kernel: cni0: port 1(veth58998dc3) entered forwarding state Aug 19 00:05:17.550943 systemd-networkd[1413]: cni0: Gained carrier Aug 19 00:05:17.553168 containerd[1499]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x40001288e8), "name":"cbr0", "type":"bridge"} Aug 19 00:05:17.553168 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Aug 19 00:05:17.596954 containerd[1499]: {"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-08-19T00:05:17.596886139Z" level=info msg="connecting to shim 75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98" address="unix:///run/containerd/s/5afb74f39882cb35bb0e39a27be0f2cf35a7d3478c181d0c71ca2804e5534b44" namespace=k8s.io protocol=ttrpc version=3 Aug 19 00:05:17.621047 systemd[1]: Started cri-containerd-75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98.scope - libcontainer container 75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98. Aug 19 00:05:17.633256 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 19 00:05:17.655401 containerd[1499]: time="2025-08-19T00:05:17.655343067Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-7d9cs,Uid:d02610d4-0633-4ff5-a297-1b5630b9eb27,Namespace:default,Attempt:0,} returns sandbox id \"75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98\"" Aug 19 00:05:17.657246 containerd[1499]: time="2025-08-19T00:05:17.656991077Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 19 00:05:17.868806 kubelet[1788]: E0819 00:05:17.868641 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:18.869779 kubelet[1788]: E0819 00:05:18.869710 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:18.904867 systemd-networkd[1413]: cni0: Gained IPv6LL Aug 19 00:05:19.160828 systemd-networkd[1413]: veth58998dc3: Gained IPv6LL Aug 19 00:05:19.288869 systemd-networkd[1413]: flannel.1: Gained IPv6LL Aug 19 00:05:19.555731 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3620713384.mount: Deactivated successfully. Aug 19 00:05:19.870321 kubelet[1788]: E0819 00:05:19.870210 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:20.301709 containerd[1499]: time="2025-08-19T00:05:20.301552862Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:20.303645 containerd[1499]: time="2025-08-19T00:05:20.303569445Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69986522" Aug 19 00:05:20.304690 containerd[1499]: time="2025-08-19T00:05:20.304629207Z" level=info msg="ImageCreate event name:\"sha256:9fddf21fd9c2634e7bf6e633e36b0fb227f6cd5fbe1b3334a16de3ab50f31e5e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:20.307821 containerd[1499]: time="2025-08-19T00:05:20.307781699Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:883ca821a91fc20bcde818eeee4e1ed55ef63a020d6198ecd5a03af5a4eac530\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:20.308745 containerd[1499]: time="2025-08-19T00:05:20.308715080Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:9fddf21fd9c2634e7bf6e633e36b0fb227f6cd5fbe1b3334a16de3ab50f31e5e\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:883ca821a91fc20bcde818eeee4e1ed55ef63a020d6198ecd5a03af5a4eac530\", size \"69986400\" in 2.651652478s" Aug 19 00:05:20.308911 containerd[1499]: time="2025-08-19T00:05:20.308808917Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:9fddf21fd9c2634e7bf6e633e36b0fb227f6cd5fbe1b3334a16de3ab50f31e5e\"" Aug 19 00:05:20.311095 containerd[1499]: time="2025-08-19T00:05:20.311058735Z" level=info msg="CreateContainer within sandbox \"75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 19 00:05:20.319949 containerd[1499]: time="2025-08-19T00:05:20.319899682Z" level=info msg="Container 0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:20.326887 containerd[1499]: time="2025-08-19T00:05:20.326833456Z" level=info msg="CreateContainer within sandbox \"75ae51e68dc199321a8e8ceef48126d6390856dd13cd9c00e78d3999b5836c98\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a\"" Aug 19 00:05:20.327411 containerd[1499]: time="2025-08-19T00:05:20.327378870Z" level=info msg="StartContainer for \"0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a\"" Aug 19 00:05:20.328283 containerd[1499]: time="2025-08-19T00:05:20.328253553Z" level=info msg="connecting to shim 0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a" address="unix:///run/containerd/s/5afb74f39882cb35bb0e39a27be0f2cf35a7d3478c181d0c71ca2804e5534b44" protocol=ttrpc version=3 Aug 19 00:05:20.357924 systemd[1]: Started cri-containerd-0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a.scope - libcontainer container 0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a. Aug 19 00:05:20.387821 containerd[1499]: time="2025-08-19T00:05:20.387766813Z" level=info msg="StartContainer for \"0683bea678e56c26bfd1c967ce0ebe2e183ee97aaa4666dd74fb6eaeb070e58a\" returns successfully" Aug 19 00:05:20.871202 kubelet[1788]: E0819 00:05:20.871154 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:21.871581 kubelet[1788]: E0819 00:05:21.871528 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:22.872223 kubelet[1788]: E0819 00:05:22.872174 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:23.764142 kubelet[1788]: I0819 00:05:23.764056 1788 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-7d9cs" podStartSLOduration=4.110990893 podStartE2EDuration="6.764035521s" podCreationTimestamp="2025-08-19 00:05:17 +0000 UTC" firstStartedPulling="2025-08-19 00:05:17.65661166 +0000 UTC m=+12.497998921" lastFinishedPulling="2025-08-19 00:05:20.309656288 +0000 UTC m=+15.151043549" observedRunningTime="2025-08-19 00:05:21.071099748 +0000 UTC m=+15.912487009" watchObservedRunningTime="2025-08-19 00:05:23.764035521 +0000 UTC m=+18.605422782" Aug 19 00:05:23.773919 systemd[1]: Created slice kubepods-besteffort-pod6dfc65eb_e72f_47f9_874f_84c8afa35195.slice - libcontainer container kubepods-besteffort-pod6dfc65eb_e72f_47f9_874f_84c8afa35195.slice. Aug 19 00:05:23.793507 kubelet[1788]: I0819 00:05:23.793412 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/6dfc65eb-e72f-47f9-874f-84c8afa35195-data\") pod \"nfs-server-provisioner-0\" (UID: \"6dfc65eb-e72f-47f9-874f-84c8afa35195\") " pod="default/nfs-server-provisioner-0" Aug 19 00:05:23.793507 kubelet[1788]: I0819 00:05:23.793456 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-j6bdh\" (UniqueName: \"kubernetes.io/projected/6dfc65eb-e72f-47f9-874f-84c8afa35195-kube-api-access-j6bdh\") pod \"nfs-server-provisioner-0\" (UID: \"6dfc65eb-e72f-47f9-874f-84c8afa35195\") " pod="default/nfs-server-provisioner-0" Aug 19 00:05:23.873155 kubelet[1788]: E0819 00:05:23.873081 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:24.080109 containerd[1499]: time="2025-08-19T00:05:24.079992377Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:6dfc65eb-e72f-47f9-874f-84c8afa35195,Namespace:default,Attempt:0,}" Aug 19 00:05:24.091473 systemd-networkd[1413]: vethf0d42b92: Link UP Aug 19 00:05:24.093730 kernel: cni0: port 2(vethf0d42b92) entered blocking state Aug 19 00:05:24.093806 kernel: cni0: port 2(vethf0d42b92) entered disabled state Aug 19 00:05:24.093823 kernel: vethf0d42b92: entered allmulticast mode Aug 19 00:05:24.093838 kernel: vethf0d42b92: entered promiscuous mode Aug 19 00:05:24.099149 kernel: cni0: port 2(vethf0d42b92) entered blocking state Aug 19 00:05:24.099231 kernel: cni0: port 2(vethf0d42b92) entered forwarding state Aug 19 00:05:24.101668 systemd-networkd[1413]: vethf0d42b92: Gained carrier Aug 19 00:05:24.105999 containerd[1499]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x40000a68e8), "name":"cbr0", "type":"bridge"} Aug 19 00:05:24.105999 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Aug 19 00:05:24.138282 containerd[1499]: {"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-08-19T00:05:24.137950735Z" level=info msg="connecting to shim c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7" address="unix:///run/containerd/s/3f51db0c11612de978c64c68ef5d0b7fa0907784314fa7f18164eeafd5684237" namespace=k8s.io protocol=ttrpc version=3 Aug 19 00:05:24.166929 systemd[1]: Started cri-containerd-c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7.scope - libcontainer container c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7. Aug 19 00:05:24.177416 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 19 00:05:24.205782 containerd[1499]: time="2025-08-19T00:05:24.205740944Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:6dfc65eb-e72f-47f9-874f-84c8afa35195,Namespace:default,Attempt:0,} returns sandbox id \"c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7\"" Aug 19 00:05:24.208559 containerd[1499]: time="2025-08-19T00:05:24.207424913Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 19 00:05:24.874158 kubelet[1788]: E0819 00:05:24.874088 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:25.303906 systemd-networkd[1413]: vethf0d42b92: Gained IPv6LL Aug 19 00:05:25.858820 kubelet[1788]: E0819 00:05:25.858769 1788 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:25.875122 kubelet[1788]: E0819 00:05:25.875079 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:26.414405 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2670721480.mount: Deactivated successfully. Aug 19 00:05:26.876090 kubelet[1788]: E0819 00:05:26.875778 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:27.741785 containerd[1499]: time="2025-08-19T00:05:27.741733742Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:27.743464 containerd[1499]: time="2025-08-19T00:05:27.743203422Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625" Aug 19 00:05:27.744332 containerd[1499]: time="2025-08-19T00:05:27.744296998Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:27.746745 containerd[1499]: time="2025-08-19T00:05:27.746713154Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:27.747578 containerd[1499]: time="2025-08-19T00:05:27.747542590Z" 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.54008207s" Aug 19 00:05:27.747578 containerd[1499]: time="2025-08-19T00:05:27.747576327Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Aug 19 00:05:27.750288 containerd[1499]: time="2025-08-19T00:05:27.749783105Z" level=info msg="CreateContainer within sandbox \"c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 19 00:05:27.756668 containerd[1499]: time="2025-08-19T00:05:27.756624611Z" level=info msg="Container 3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:27.765033 containerd[1499]: time="2025-08-19T00:05:27.764985682Z" level=info msg="CreateContainer within sandbox \"c2567ab606613731b0c3d3346c73887aa44c44503636864dd43d1ef584be50f7\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4\"" Aug 19 00:05:27.765851 containerd[1499]: time="2025-08-19T00:05:27.765816797Z" level=info msg="StartContainer for \"3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4\"" Aug 19 00:05:27.767001 containerd[1499]: time="2025-08-19T00:05:27.766965695Z" level=info msg="connecting to shim 3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4" address="unix:///run/containerd/s/3f51db0c11612de978c64c68ef5d0b7fa0907784314fa7f18164eeafd5684237" protocol=ttrpc version=3 Aug 19 00:05:27.786861 systemd[1]: Started cri-containerd-3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4.scope - libcontainer container 3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4. Aug 19 00:05:27.819895 containerd[1499]: time="2025-08-19T00:05:27.819368122Z" level=info msg="StartContainer for \"3d9709eb2e53b3afef6f6a37736e67f2d88deceb59a67ddfc6be3342c11c08c4\" returns successfully" Aug 19 00:05:27.876866 kubelet[1788]: E0819 00:05:27.876822 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:28.877999 kubelet[1788]: E0819 00:05:28.877952 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:29.878635 kubelet[1788]: E0819 00:05:29.878590 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:30.879673 kubelet[1788]: E0819 00:05:30.879621 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:31.880647 kubelet[1788]: E0819 00:05:31.880604 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:32.881968 kubelet[1788]: E0819 00:05:32.881918 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:33.882482 kubelet[1788]: E0819 00:05:33.882438 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:34.883837 kubelet[1788]: E0819 00:05:34.883792 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:35.885075 kubelet[1788]: E0819 00:05:35.885014 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:36.887633 kubelet[1788]: E0819 00:05:36.886057 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:37.665172 kubelet[1788]: I0819 00:05:37.665088 1788 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=11.123724046 podStartE2EDuration="14.665071643s" podCreationTimestamp="2025-08-19 00:05:23 +0000 UTC" firstStartedPulling="2025-08-19 00:05:24.207177205 +0000 UTC m=+19.048564466" lastFinishedPulling="2025-08-19 00:05:27.748524802 +0000 UTC m=+22.589912063" observedRunningTime="2025-08-19 00:05:28.084432791 +0000 UTC m=+22.925820052" watchObservedRunningTime="2025-08-19 00:05:37.665071643 +0000 UTC m=+32.506458904" Aug 19 00:05:37.675911 systemd[1]: Created slice kubepods-besteffort-pod0aebf4f3_13bc_4f21_8141_8cfb020db1df.slice - libcontainer container kubepods-besteffort-pod0aebf4f3_13bc_4f21_8141_8cfb020db1df.slice. Aug 19 00:05:37.778589 kubelet[1788]: I0819 00:05:37.778513 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-91b2ddc4-8b74-433b-9e52-223ede9ed6d7\" (UniqueName: \"kubernetes.io/nfs/0aebf4f3-13bc-4f21-8141-8cfb020db1df-pvc-91b2ddc4-8b74-433b-9e52-223ede9ed6d7\") pod \"test-pod-1\" (UID: \"0aebf4f3-13bc-4f21-8141-8cfb020db1df\") " pod="default/test-pod-1" Aug 19 00:05:37.778589 kubelet[1788]: I0819 00:05:37.778570 1788 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-vhmjn\" (UniqueName: \"kubernetes.io/projected/0aebf4f3-13bc-4f21-8141-8cfb020db1df-kube-api-access-vhmjn\") pod \"test-pod-1\" (UID: \"0aebf4f3-13bc-4f21-8141-8cfb020db1df\") " pod="default/test-pod-1" Aug 19 00:05:37.886763 kubelet[1788]: E0819 00:05:37.886679 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:37.913734 kernel: netfs: FS-Cache loaded Aug 19 00:05:37.948789 kernel: RPC: Registered named UNIX socket transport module. Aug 19 00:05:37.948908 kernel: RPC: Registered udp transport module. Aug 19 00:05:37.948929 kernel: RPC: Registered tcp transport module. Aug 19 00:05:37.948944 kernel: RPC: Registered tcp-with-tls transport module. Aug 19 00:05:37.949759 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 19 00:05:38.135963 kernel: NFS: Registering the id_resolver key type Aug 19 00:05:38.136096 kernel: Key type id_resolver registered Aug 19 00:05:38.136139 kernel: Key type id_legacy registered Aug 19 00:05:38.173636 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 Aug 19 00:05:38.176439 nfsidmap[2800]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 19 00:05:38.179827 nfsidmap[2801]: 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 Aug 19 00:05:38.179984 nfsidmap[2801]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 19 00:05:38.190298 nfsrahead[2803]: setting /var/lib/kubelet/pods/0aebf4f3-13bc-4f21-8141-8cfb020db1df/volumes/kubernetes.io~nfs/pvc-91b2ddc4-8b74-433b-9e52-223ede9ed6d7 readahead to 128 Aug 19 00:05:38.280772 containerd[1499]: time="2025-08-19T00:05:38.280738971Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0aebf4f3-13bc-4f21-8141-8cfb020db1df,Namespace:default,Attempt:0,}" Aug 19 00:05:38.291055 systemd-networkd[1413]: veth4f9521c4: Link UP Aug 19 00:05:38.295516 kernel: cni0: port 3(veth4f9521c4) entered blocking state Aug 19 00:05:38.295607 kernel: cni0: port 3(veth4f9521c4) entered disabled state Aug 19 00:05:38.295624 kernel: veth4f9521c4: entered allmulticast mode Aug 19 00:05:38.296737 kernel: veth4f9521c4: entered promiscuous mode Aug 19 00:05:38.303895 kernel: cni0: port 3(veth4f9521c4) entered blocking state Aug 19 00:05:38.303983 kernel: cni0: port 3(veth4f9521c4) entered forwarding state Aug 19 00:05:38.304158 systemd-networkd[1413]: veth4f9521c4: Gained carrier Aug 19 00:05:38.306546 containerd[1499]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000018938), "name":"cbr0", "type":"bridge"} Aug 19 00:05:38.306546 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Aug 19 00:05:38.327245 containerd[1499]: {"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-08-19T00:05:38.327188094Z" level=info msg="connecting to shim 4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6" address="unix:///run/containerd/s/c947c4de232ac37296ba636e83778fbfe95bd88d48254aa5242729b5f5bb2d62" namespace=k8s.io protocol=ttrpc version=3 Aug 19 00:05:38.358898 systemd[1]: Started cri-containerd-4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6.scope - libcontainer container 4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6. Aug 19 00:05:38.371276 systemd-resolved[1353]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 19 00:05:38.392446 containerd[1499]: time="2025-08-19T00:05:38.392406381Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0aebf4f3-13bc-4f21-8141-8cfb020db1df,Namespace:default,Attempt:0,} returns sandbox id \"4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6\"" Aug 19 00:05:38.393487 containerd[1499]: time="2025-08-19T00:05:38.393451232Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 19 00:05:38.668825 containerd[1499]: time="2025-08-19T00:05:38.668661627Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 19 00:05:38.669803 containerd[1499]: time="2025-08-19T00:05:38.669768117Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Aug 19 00:05:38.673120 containerd[1499]: time="2025-08-19T00:05:38.673051586Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:9fddf21fd9c2634e7bf6e633e36b0fb227f6cd5fbe1b3334a16de3ab50f31e5e\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:883ca821a91fc20bcde818eeee4e1ed55ef63a020d6198ecd5a03af5a4eac530\", size \"69986400\" in 279.554596ms" Aug 19 00:05:38.673120 containerd[1499]: time="2025-08-19T00:05:38.673105785Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:9fddf21fd9c2634e7bf6e633e36b0fb227f6cd5fbe1b3334a16de3ab50f31e5e\"" Aug 19 00:05:38.675385 containerd[1499]: time="2025-08-19T00:05:38.675342363Z" level=info msg="CreateContainer within sandbox \"4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 19 00:05:38.689876 containerd[1499]: time="2025-08-19T00:05:38.689822485Z" level=info msg="Container b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17: CDI devices from CRI Config.CDIDevices: []" Aug 19 00:05:38.699706 containerd[1499]: time="2025-08-19T00:05:38.699648335Z" level=info msg="CreateContainer within sandbox \"4b44539ecfe7ecc7440c8d6ef5ffb72533e15b0ad19f43e12115bc85eaf18eb6\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17\"" Aug 19 00:05:38.700539 containerd[1499]: time="2025-08-19T00:05:38.700493912Z" level=info msg="StartContainer for \"b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17\"" Aug 19 00:05:38.701494 containerd[1499]: time="2025-08-19T00:05:38.701461645Z" level=info msg="connecting to shim b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17" address="unix:///run/containerd/s/c947c4de232ac37296ba636e83778fbfe95bd88d48254aa5242729b5f5bb2d62" protocol=ttrpc version=3 Aug 19 00:05:38.726941 systemd[1]: Started cri-containerd-b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17.scope - libcontainer container b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17. Aug 19 00:05:38.772419 containerd[1499]: time="2025-08-19T00:05:38.772368976Z" level=info msg="StartContainer for \"b73dc7b436eb90d53dfa9fd0c41cd1c9eb4c4a03ba37bd72d052b0e193a8cb17\" returns successfully" Aug 19 00:05:38.887523 kubelet[1788]: E0819 00:05:38.887464 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:39.116202 kubelet[1788]: I0819 00:05:39.116140 1788 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=14.83531245 podStartE2EDuration="15.116122051s" podCreationTimestamp="2025-08-19 00:05:24 +0000 UTC" firstStartedPulling="2025-08-19 00:05:38.3931732 +0000 UTC m=+33.234560421" lastFinishedPulling="2025-08-19 00:05:38.673982761 +0000 UTC m=+33.515370022" observedRunningTime="2025-08-19 00:05:39.116044053 +0000 UTC m=+33.957431354" watchObservedRunningTime="2025-08-19 00:05:39.116122051 +0000 UTC m=+33.957509312" Aug 19 00:05:39.511886 systemd-networkd[1413]: veth4f9521c4: Gained IPv6LL Aug 19 00:05:39.888114 kubelet[1788]: E0819 00:05:39.887981 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:40.888962 kubelet[1788]: E0819 00:05:40.888761 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 19 00:05:41.889676 kubelet[1788]: E0819 00:05:41.889615 1788 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"