Jul 10 00:19:33.880084 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 10 00:19:33.880104 kernel: Linux version 6.6.95-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Wed Jul 9 22:54:34 -00 2025 Jul 10 00:19:33.880114 kernel: KASLR enabled Jul 10 00:19:33.880119 kernel: efi: EFI v2.7 by EDK II Jul 10 00:19:33.880125 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Jul 10 00:19:33.880131 kernel: random: crng init done Jul 10 00:19:33.880138 kernel: ACPI: Early table checksum verification disabled Jul 10 00:19:33.880144 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Jul 10 00:19:33.880150 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 10 00:19:33.880157 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880163 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880169 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880175 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880181 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880200 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880208 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880214 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880221 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:33.880227 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 10 00:19:33.880233 kernel: NUMA: Failed to initialise from firmware Jul 10 00:19:33.880240 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 00:19:33.880246 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Jul 10 00:19:33.880252 kernel: Zone ranges: Jul 10 00:19:33.880258 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 00:19:33.880265 kernel: DMA32 empty Jul 10 00:19:33.880272 kernel: Normal empty Jul 10 00:19:33.880278 kernel: Movable zone start for each node Jul 10 00:19:33.880284 kernel: Early memory node ranges Jul 10 00:19:33.880291 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Jul 10 00:19:33.880297 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Jul 10 00:19:33.880303 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Jul 10 00:19:33.880310 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jul 10 00:19:33.880316 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jul 10 00:19:33.880322 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jul 10 00:19:33.880328 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 10 00:19:33.880335 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 10 00:19:33.880341 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 10 00:19:33.880349 kernel: psci: probing for conduit method from ACPI. Jul 10 00:19:33.880355 kernel: psci: PSCIv1.1 detected in firmware. Jul 10 00:19:33.880362 kernel: psci: Using standard PSCI v0.2 function IDs Jul 10 00:19:33.880370 kernel: psci: Trusted OS migration not required Jul 10 00:19:33.880377 kernel: psci: SMC Calling Convention v1.1 Jul 10 00:19:33.880384 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 10 00:19:33.880392 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Jul 10 00:19:33.880398 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Jul 10 00:19:33.880405 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 10 00:19:33.880412 kernel: Detected PIPT I-cache on CPU0 Jul 10 00:19:33.880418 kernel: CPU features: detected: GIC system register CPU interface Jul 10 00:19:33.880425 kernel: CPU features: detected: Hardware dirty bit management Jul 10 00:19:33.880432 kernel: CPU features: detected: Spectre-v4 Jul 10 00:19:33.880438 kernel: CPU features: detected: Spectre-BHB Jul 10 00:19:33.880445 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 10 00:19:33.880455 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 10 00:19:33.880485 kernel: CPU features: detected: ARM erratum 1418040 Jul 10 00:19:33.880492 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 10 00:19:33.880498 kernel: alternatives: applying boot alternatives Jul 10 00:19:33.880506 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=2fac453dfc912247542078b0007b053dde4e47cc6ef808508492c36b6016a78f Jul 10 00:19:33.880513 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 10 00:19:33.880520 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 10 00:19:33.880527 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 10 00:19:33.880533 kernel: Fallback order for Node 0: 0 Jul 10 00:19:33.880540 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Jul 10 00:19:33.880546 kernel: Policy zone: DMA Jul 10 00:19:33.880553 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 10 00:19:33.880561 kernel: software IO TLB: area num 4. Jul 10 00:19:33.880568 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Jul 10 00:19:33.880575 kernel: Memory: 2386404K/2572288K available (10304K kernel code, 2186K rwdata, 8108K rodata, 39424K init, 897K bss, 185884K reserved, 0K cma-reserved) Jul 10 00:19:33.880582 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 10 00:19:33.880589 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 10 00:19:33.880596 kernel: rcu: RCU event tracing is enabled. Jul 10 00:19:33.880603 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 10 00:19:33.880609 kernel: Trampoline variant of Tasks RCU enabled. Jul 10 00:19:33.880616 kernel: Tracing variant of Tasks RCU enabled. Jul 10 00:19:33.880623 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 10 00:19:33.880633 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 10 00:19:33.880642 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 10 00:19:33.880650 kernel: GICv3: 256 SPIs implemented Jul 10 00:19:33.880657 kernel: GICv3: 0 Extended SPIs implemented Jul 10 00:19:33.880664 kernel: Root IRQ handler: gic_handle_irq Jul 10 00:19:33.880670 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 10 00:19:33.880677 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 10 00:19:33.880684 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 10 00:19:33.880690 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Jul 10 00:19:33.880697 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Jul 10 00:19:33.880704 kernel: GICv3: using LPI property table @0x00000000400f0000 Jul 10 00:19:33.880711 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Jul 10 00:19:33.880718 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 10 00:19:33.880725 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 00:19:33.880732 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 10 00:19:33.880739 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 10 00:19:33.880746 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 10 00:19:33.880753 kernel: arm-pv: using stolen time PV Jul 10 00:19:33.880760 kernel: Console: colour dummy device 80x25 Jul 10 00:19:33.880766 kernel: ACPI: Core revision 20230628 Jul 10 00:19:33.880774 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 10 00:19:33.880781 kernel: pid_max: default: 32768 minimum: 301 Jul 10 00:19:33.880787 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jul 10 00:19:33.880796 kernel: landlock: Up and running. Jul 10 00:19:33.880802 kernel: SELinux: Initializing. Jul 10 00:19:33.880809 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 00:19:33.880816 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 00:19:33.880823 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 00:19:33.880830 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 00:19:33.880837 kernel: rcu: Hierarchical SRCU implementation. Jul 10 00:19:33.880844 kernel: rcu: Max phase no-delay instances is 400. Jul 10 00:19:33.880851 kernel: Platform MSI: ITS@0x8080000 domain created Jul 10 00:19:33.880858 kernel: PCI/MSI: ITS@0x8080000 domain created Jul 10 00:19:33.880865 kernel: Remapping and enabling EFI services. Jul 10 00:19:33.880872 kernel: smp: Bringing up secondary CPUs ... Jul 10 00:19:33.880879 kernel: Detected PIPT I-cache on CPU1 Jul 10 00:19:33.880886 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 10 00:19:33.880893 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Jul 10 00:19:33.880900 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 00:19:33.880906 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 10 00:19:33.880919 kernel: Detected PIPT I-cache on CPU2 Jul 10 00:19:33.880926 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 10 00:19:33.880934 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Jul 10 00:19:33.880941 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 00:19:33.880953 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 10 00:19:33.880961 kernel: Detected PIPT I-cache on CPU3 Jul 10 00:19:33.880968 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 10 00:19:33.880976 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Jul 10 00:19:33.880983 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 10 00:19:33.880990 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 10 00:19:33.880997 kernel: smp: Brought up 1 node, 4 CPUs Jul 10 00:19:33.881006 kernel: SMP: Total of 4 processors activated. Jul 10 00:19:33.881013 kernel: CPU features: detected: 32-bit EL0 Support Jul 10 00:19:33.881020 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 10 00:19:33.881028 kernel: CPU features: detected: Common not Private translations Jul 10 00:19:33.881035 kernel: CPU features: detected: CRC32 instructions Jul 10 00:19:33.881042 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 10 00:19:33.881049 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 10 00:19:33.881057 kernel: CPU features: detected: LSE atomic instructions Jul 10 00:19:33.881065 kernel: CPU features: detected: Privileged Access Never Jul 10 00:19:33.881072 kernel: CPU features: detected: RAS Extension Support Jul 10 00:19:33.881080 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 10 00:19:33.881087 kernel: CPU: All CPU(s) started at EL1 Jul 10 00:19:33.881094 kernel: alternatives: applying system-wide alternatives Jul 10 00:19:33.881101 kernel: devtmpfs: initialized Jul 10 00:19:33.881108 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 10 00:19:33.881116 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 10 00:19:33.881123 kernel: pinctrl core: initialized pinctrl subsystem Jul 10 00:19:33.881132 kernel: SMBIOS 3.0.0 present. Jul 10 00:19:33.881139 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Jul 10 00:19:33.881146 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 10 00:19:33.881154 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 10 00:19:33.881161 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 10 00:19:33.881169 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 10 00:19:33.881176 kernel: audit: initializing netlink subsys (disabled) Jul 10 00:19:33.881190 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Jul 10 00:19:33.881199 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 10 00:19:33.881208 kernel: cpuidle: using governor menu Jul 10 00:19:33.881215 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 10 00:19:33.881222 kernel: ASID allocator initialised with 32768 entries Jul 10 00:19:33.881229 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 10 00:19:33.881237 kernel: Serial: AMBA PL011 UART driver Jul 10 00:19:33.881244 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 10 00:19:33.881251 kernel: Modules: 0 pages in range for non-PLT usage Jul 10 00:19:33.881258 kernel: Modules: 509008 pages in range for PLT usage Jul 10 00:19:33.881266 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 10 00:19:33.881274 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 10 00:19:33.881282 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 10 00:19:33.881289 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 10 00:19:33.881296 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 10 00:19:33.881304 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 10 00:19:33.881311 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 10 00:19:33.881318 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 10 00:19:33.881325 kernel: ACPI: Added _OSI(Module Device) Jul 10 00:19:33.881332 kernel: ACPI: Added _OSI(Processor Device) Jul 10 00:19:33.881341 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 10 00:19:33.881348 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 10 00:19:33.881355 kernel: ACPI: Interpreter enabled Jul 10 00:19:33.881362 kernel: ACPI: Using GIC for interrupt routing Jul 10 00:19:33.881370 kernel: ACPI: MCFG table detected, 1 entries Jul 10 00:19:33.881377 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 10 00:19:33.881384 kernel: printk: console [ttyAMA0] enabled Jul 10 00:19:33.881391 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 10 00:19:33.881520 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 10 00:19:33.881596 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 10 00:19:33.881660 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 10 00:19:33.881737 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 10 00:19:33.881801 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 10 00:19:33.881811 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 10 00:19:33.881818 kernel: PCI host bridge to bus 0000:00 Jul 10 00:19:33.881885 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 10 00:19:33.881954 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 10 00:19:33.882011 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 10 00:19:33.882066 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 10 00:19:33.882149 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Jul 10 00:19:33.882287 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Jul 10 00:19:33.882357 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Jul 10 00:19:33.882425 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Jul 10 00:19:33.882489 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Jul 10 00:19:33.882557 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Jul 10 00:19:33.882621 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Jul 10 00:19:33.882684 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Jul 10 00:19:33.882742 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 10 00:19:33.882832 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 10 00:19:33.882896 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 10 00:19:33.882906 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 10 00:19:33.882921 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 10 00:19:33.882929 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 10 00:19:33.882936 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 10 00:19:33.882943 kernel: iommu: Default domain type: Translated Jul 10 00:19:33.882951 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 10 00:19:33.882958 kernel: efivars: Registered efivars operations Jul 10 00:19:33.882968 kernel: vgaarb: loaded Jul 10 00:19:33.882976 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 10 00:19:33.882983 kernel: VFS: Disk quotas dquot_6.6.0 Jul 10 00:19:33.882990 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 10 00:19:33.882997 kernel: pnp: PnP ACPI init Jul 10 00:19:33.883075 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 10 00:19:33.883086 kernel: pnp: PnP ACPI: found 1 devices Jul 10 00:19:33.883094 kernel: NET: Registered PF_INET protocol family Jul 10 00:19:33.883101 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 10 00:19:33.883111 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 10 00:19:33.883118 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 10 00:19:33.883125 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 10 00:19:33.883133 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 10 00:19:33.883140 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 10 00:19:33.883147 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 00:19:33.883155 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 00:19:33.883162 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 10 00:19:33.883171 kernel: PCI: CLS 0 bytes, default 64 Jul 10 00:19:33.883178 kernel: kvm [1]: HYP mode not available Jul 10 00:19:33.883234 kernel: Initialise system trusted keyrings Jul 10 00:19:33.883243 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 10 00:19:33.883250 kernel: Key type asymmetric registered Jul 10 00:19:33.883257 kernel: Asymmetric key parser 'x509' registered Jul 10 00:19:33.883264 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 10 00:19:33.883272 kernel: io scheduler mq-deadline registered Jul 10 00:19:33.883279 kernel: io scheduler kyber registered Jul 10 00:19:33.883286 kernel: io scheduler bfq registered Jul 10 00:19:33.883296 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 10 00:19:33.883303 kernel: ACPI: button: Power Button [PWRB] Jul 10 00:19:33.883311 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 10 00:19:33.883396 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 10 00:19:33.883406 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 10 00:19:33.883414 kernel: thunder_xcv, ver 1.0 Jul 10 00:19:33.883421 kernel: thunder_bgx, ver 1.0 Jul 10 00:19:33.883428 kernel: nicpf, ver 1.0 Jul 10 00:19:33.883435 kernel: nicvf, ver 1.0 Jul 10 00:19:33.883511 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 10 00:19:33.883574 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-10T00:19:33 UTC (1752106773) Jul 10 00:19:33.883584 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 10 00:19:33.883592 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Jul 10 00:19:33.883599 kernel: watchdog: Delayed init of the lockup detector failed: -19 Jul 10 00:19:33.883607 kernel: watchdog: Hard watchdog permanently disabled Jul 10 00:19:33.883614 kernel: NET: Registered PF_INET6 protocol family Jul 10 00:19:33.883621 kernel: Segment Routing with IPv6 Jul 10 00:19:33.883631 kernel: In-situ OAM (IOAM) with IPv6 Jul 10 00:19:33.883638 kernel: NET: Registered PF_PACKET protocol family Jul 10 00:19:33.883645 kernel: Key type dns_resolver registered Jul 10 00:19:33.883652 kernel: registered taskstats version 1 Jul 10 00:19:33.883659 kernel: Loading compiled-in X.509 certificates Jul 10 00:19:33.883667 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.95-flatcar: 9cbc45ab00feb4acb0fa362a962909c99fb6ef52' Jul 10 00:19:33.883674 kernel: Key type .fscrypt registered Jul 10 00:19:33.883681 kernel: Key type fscrypt-provisioning registered Jul 10 00:19:33.883688 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 10 00:19:33.883697 kernel: ima: Allocated hash algorithm: sha1 Jul 10 00:19:33.883704 kernel: ima: No architecture policies found Jul 10 00:19:33.883712 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 10 00:19:33.883719 kernel: clk: Disabling unused clocks Jul 10 00:19:33.883726 kernel: Freeing unused kernel memory: 39424K Jul 10 00:19:33.883733 kernel: Run /init as init process Jul 10 00:19:33.883740 kernel: with arguments: Jul 10 00:19:33.883748 kernel: /init Jul 10 00:19:33.883755 kernel: with environment: Jul 10 00:19:33.883763 kernel: HOME=/ Jul 10 00:19:33.883770 kernel: TERM=linux Jul 10 00:19:33.883777 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 10 00:19:33.883787 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 10 00:19:33.883796 systemd[1]: Detected virtualization kvm. Jul 10 00:19:33.883804 systemd[1]: Detected architecture arm64. Jul 10 00:19:33.883812 systemd[1]: Running in initrd. Jul 10 00:19:33.883821 systemd[1]: No hostname configured, using default hostname. Jul 10 00:19:33.883828 systemd[1]: Hostname set to . Jul 10 00:19:33.883836 systemd[1]: Initializing machine ID from VM UUID. Jul 10 00:19:33.883844 systemd[1]: Queued start job for default target initrd.target. Jul 10 00:19:33.883852 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:33.883860 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:33.883868 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 10 00:19:33.883876 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 00:19:33.883885 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 10 00:19:33.883893 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 10 00:19:33.883903 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 10 00:19:33.883921 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 10 00:19:33.883930 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:33.883938 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:33.883945 systemd[1]: Reached target paths.target - Path Units. Jul 10 00:19:33.883955 systemd[1]: Reached target slices.target - Slice Units. Jul 10 00:19:33.883963 systemd[1]: Reached target swap.target - Swaps. Jul 10 00:19:33.883971 systemd[1]: Reached target timers.target - Timer Units. Jul 10 00:19:33.883978 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 00:19:33.883987 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 00:19:33.883994 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 10 00:19:33.884002 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 10 00:19:33.884010 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:33.884018 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:33.884027 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:33.884035 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 00:19:33.884043 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 10 00:19:33.884051 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 00:19:33.884059 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 10 00:19:33.884067 systemd[1]: Starting systemd-fsck-usr.service... Jul 10 00:19:33.884074 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 00:19:33.884082 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 00:19:33.884092 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:33.884099 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 10 00:19:33.884107 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:33.884115 systemd[1]: Finished systemd-fsck-usr.service. Jul 10 00:19:33.884124 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 00:19:33.884151 systemd-journald[238]: Collecting audit messages is disabled. Jul 10 00:19:33.884170 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:33.884178 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:33.884228 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 10 00:19:33.884238 systemd-journald[238]: Journal started Jul 10 00:19:33.884257 systemd-journald[238]: Runtime Journal (/run/log/journal/75837fbbfcc84bedb1ef2c37e611aa30) is 5.9M, max 47.3M, 41.4M free. Jul 10 00:19:33.877454 systemd-modules-load[239]: Inserted module 'overlay' Jul 10 00:19:33.890213 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 00:19:33.890255 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 00:19:33.893841 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 00:19:33.900159 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:33.902668 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 10 00:19:33.902693 kernel: Bridge firewalling registered Jul 10 00:19:33.902613 systemd-modules-load[239]: Inserted module 'br_netfilter' Jul 10 00:19:33.903870 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:33.907787 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 00:19:33.909000 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:33.911651 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 10 00:19:33.914051 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:33.919236 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:33.925406 dracut-cmdline[271]: dracut-dracut-053 Jul 10 00:19:33.929093 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 00:19:33.932315 dracut-cmdline[271]: Using kernel command line parameters: rd.driver.pre=btrfs 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=2fac453dfc912247542078b0007b053dde4e47cc6ef808508492c36b6016a78f Jul 10 00:19:33.954973 systemd-resolved[281]: Positive Trust Anchors: Jul 10 00:19:33.954988 systemd-resolved[281]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 00:19:33.955020 systemd-resolved[281]: 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 Jul 10 00:19:33.959684 systemd-resolved[281]: Defaulting to hostname 'linux'. Jul 10 00:19:33.960677 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 00:19:33.962028 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:33.998209 kernel: SCSI subsystem initialized Jul 10 00:19:34.002203 kernel: Loading iSCSI transport class v2.0-870. Jul 10 00:19:34.009209 kernel: iscsi: registered transport (tcp) Jul 10 00:19:34.022216 kernel: iscsi: registered transport (qla4xxx) Jul 10 00:19:34.022254 kernel: QLogic iSCSI HBA Driver Jul 10 00:19:34.064577 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 10 00:19:34.077311 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 10 00:19:34.095129 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 10 00:19:34.095166 kernel: device-mapper: uevent: version 1.0.3 Jul 10 00:19:34.096316 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 10 00:19:34.143240 kernel: raid6: neonx8 gen() 15540 MB/s Jul 10 00:19:34.160228 kernel: raid6: neonx4 gen() 15114 MB/s Jul 10 00:19:34.177200 kernel: raid6: neonx2 gen() 13122 MB/s Jul 10 00:19:34.194215 kernel: raid6: neonx1 gen() 10186 MB/s Jul 10 00:19:34.211214 kernel: raid6: int64x8 gen() 6391 MB/s Jul 10 00:19:34.228227 kernel: raid6: int64x4 gen() 7243 MB/s Jul 10 00:19:34.245203 kernel: raid6: int64x2 gen() 6054 MB/s Jul 10 00:19:34.262205 kernel: raid6: int64x1 gen() 5021 MB/s Jul 10 00:19:34.262220 kernel: raid6: using algorithm neonx8 gen() 15540 MB/s Jul 10 00:19:34.279205 kernel: raid6: .... xor() 11769 MB/s, rmw enabled Jul 10 00:19:34.279217 kernel: raid6: using neon recovery algorithm Jul 10 00:19:34.285275 kernel: xor: measuring software checksum speed Jul 10 00:19:34.285304 kernel: 8regs : 19750 MB/sec Jul 10 00:19:34.285323 kernel: 32regs : 19650 MB/sec Jul 10 00:19:34.286200 kernel: arm64_neon : 27123 MB/sec Jul 10 00:19:34.286212 kernel: xor: using function: arm64_neon (27123 MB/sec) Jul 10 00:19:34.338217 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 10 00:19:34.348852 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 10 00:19:34.360367 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:34.371286 systemd-udevd[460]: Using default interface naming scheme 'v255'. Jul 10 00:19:34.374398 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:34.386324 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 10 00:19:34.397478 dracut-pre-trigger[468]: rd.md=0: removing MD RAID activation Jul 10 00:19:34.422602 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 00:19:34.436312 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 00:19:34.474375 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:34.483340 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 10 00:19:34.494706 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 10 00:19:34.497322 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 00:19:34.498158 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:34.500938 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 00:19:34.508317 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 10 00:19:34.518620 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 10 00:19:34.529418 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 10 00:19:34.529562 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jul 10 00:19:34.532795 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 10 00:19:34.532918 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:34.538301 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 10 00:19:34.538329 kernel: GPT:9289727 != 19775487 Jul 10 00:19:34.538344 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 10 00:19:34.538354 kernel: GPT:9289727 != 19775487 Jul 10 00:19:34.538363 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 10 00:19:34.538379 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:34.538772 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 10 00:19:34.540207 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 00:19:34.540346 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:34.541945 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:34.554450 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:34.558342 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by (udev-worker) (514) Jul 10 00:19:34.558363 kernel: BTRFS: device fsid e18a5201-bc0c-484b-ba1b-be3c0a720c32 devid 1 transid 40 /dev/vda3 scanned by (udev-worker) (524) Jul 10 00:19:34.567197 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:34.574422 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 10 00:19:34.578593 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 10 00:19:34.582752 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 00:19:34.586301 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 10 00:19:34.587142 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 10 00:19:34.607385 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 10 00:19:34.609311 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 10 00:19:34.612790 disk-uuid[552]: Primary Header is updated. Jul 10 00:19:34.612790 disk-uuid[552]: Secondary Entries is updated. Jul 10 00:19:34.612790 disk-uuid[552]: Secondary Header is updated. Jul 10 00:19:34.615207 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:34.627221 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:34.632543 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:35.631026 disk-uuid[553]: The operation has completed successfully. Jul 10 00:19:35.632283 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:35.651766 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 10 00:19:35.651861 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 10 00:19:35.676364 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 10 00:19:35.679125 sh[575]: Success Jul 10 00:19:35.689217 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Jul 10 00:19:35.726539 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 10 00:19:35.727977 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 10 00:19:35.728709 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 10 00:19:35.738288 kernel: BTRFS info (device dm-0): first mount of filesystem e18a5201-bc0c-484b-ba1b-be3c0a720c32 Jul 10 00:19:35.738334 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 10 00:19:35.738346 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 10 00:19:35.739579 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 10 00:19:35.739592 kernel: BTRFS info (device dm-0): using free space tree Jul 10 00:19:35.743427 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 10 00:19:35.744478 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 10 00:19:35.755351 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 10 00:19:35.756696 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 10 00:19:35.763296 kernel: BTRFS info (device vda6): first mount of filesystem 8ce7827a-be35-4e5a-9c5c-f9bfd6370ac0 Jul 10 00:19:35.763333 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 00:19:35.763343 kernel: BTRFS info (device vda6): using free space tree Jul 10 00:19:35.765206 kernel: BTRFS info (device vda6): auto enabling async discard Jul 10 00:19:35.772635 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 10 00:19:35.774219 kernel: BTRFS info (device vda6): last unmount of filesystem 8ce7827a-be35-4e5a-9c5c-f9bfd6370ac0 Jul 10 00:19:35.779640 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 10 00:19:35.786355 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 10 00:19:35.847745 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 00:19:35.863486 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 00:19:35.874895 ignition[664]: Ignition 2.19.0 Jul 10 00:19:35.874912 ignition[664]: Stage: fetch-offline Jul 10 00:19:35.874953 ignition[664]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:35.874961 ignition[664]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:35.875114 ignition[664]: parsed url from cmdline: "" Jul 10 00:19:35.875117 ignition[664]: no config URL provided Jul 10 00:19:35.875122 ignition[664]: reading system config file "/usr/lib/ignition/user.ign" Jul 10 00:19:35.875129 ignition[664]: no config at "/usr/lib/ignition/user.ign" Jul 10 00:19:35.875151 ignition[664]: op(1): [started] loading QEMU firmware config module Jul 10 00:19:35.875156 ignition[664]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 10 00:19:35.886474 ignition[664]: op(1): [finished] loading QEMU firmware config module Jul 10 00:19:35.889350 systemd-networkd[767]: lo: Link UP Jul 10 00:19:35.889359 systemd-networkd[767]: lo: Gained carrier Jul 10 00:19:35.890432 systemd-networkd[767]: Enumeration completed Jul 10 00:19:35.890800 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 00:19:35.891000 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:35.891004 systemd-networkd[767]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 00:19:35.891987 systemd-networkd[767]: eth0: Link UP Jul 10 00:19:35.891990 systemd-networkd[767]: eth0: Gained carrier Jul 10 00:19:35.891997 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:35.893559 systemd[1]: Reached target network.target - Network. Jul 10 00:19:35.899311 ignition[664]: parsing config with SHA512: de3e84982db5a9f9ba122ff60ec579a9f5c2d6b0f562f72d192cd823df56da3dfcf65b25d0ff50b73693a06890800f24f8d115f55835164956028f4e2386656a Jul 10 00:19:35.902537 unknown[664]: fetched base config from "system" Jul 10 00:19:35.902548 unknown[664]: fetched user config from "qemu" Jul 10 00:19:35.902861 ignition[664]: fetch-offline: fetch-offline passed Jul 10 00:19:35.904228 systemd-networkd[767]: eth0: DHCPv4 address 10.0.0.24/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 00:19:35.902937 ignition[664]: Ignition finished successfully Jul 10 00:19:35.904989 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 00:19:35.906090 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 10 00:19:35.915340 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 10 00:19:35.927582 ignition[775]: Ignition 2.19.0 Jul 10 00:19:35.927593 ignition[775]: Stage: kargs Jul 10 00:19:35.927753 ignition[775]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:35.927762 ignition[775]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:35.928475 ignition[775]: kargs: kargs passed Jul 10 00:19:35.928521 ignition[775]: Ignition finished successfully Jul 10 00:19:35.930961 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 10 00:19:35.940379 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 10 00:19:35.949682 ignition[784]: Ignition 2.19.0 Jul 10 00:19:35.949693 ignition[784]: Stage: disks Jul 10 00:19:35.949853 ignition[784]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:35.949862 ignition[784]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:35.950572 ignition[784]: disks: disks passed Jul 10 00:19:35.952425 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 10 00:19:35.950614 ignition[784]: Ignition finished successfully Jul 10 00:19:35.953973 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 10 00:19:35.954943 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 10 00:19:35.956393 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 00:19:35.957490 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 00:19:35.958825 systemd[1]: Reached target basic.target - Basic System. Jul 10 00:19:35.967335 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 10 00:19:35.977200 systemd-fsck[796]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 10 00:19:35.980532 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 10 00:19:35.989295 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 10 00:19:36.031212 kernel: EXT4-fs (vda9): mounted filesystem c566fdd5-af6f-4008-858c-a2aed765f9b4 r/w with ordered data mode. Quota mode: none. Jul 10 00:19:36.031263 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 10 00:19:36.032278 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 10 00:19:36.039256 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 00:19:36.040645 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 10 00:19:36.041789 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 10 00:19:36.041828 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 10 00:19:36.049228 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (804) Jul 10 00:19:36.049250 kernel: BTRFS info (device vda6): first mount of filesystem 8ce7827a-be35-4e5a-9c5c-f9bfd6370ac0 Jul 10 00:19:36.049261 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 00:19:36.049271 kernel: BTRFS info (device vda6): using free space tree Jul 10 00:19:36.041848 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 00:19:36.048266 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 10 00:19:36.050466 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 10 00:19:36.054392 kernel: BTRFS info (device vda6): auto enabling async discard Jul 10 00:19:36.055212 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 00:19:36.089640 initrd-setup-root[829]: cut: /sysroot/etc/passwd: No such file or directory Jul 10 00:19:36.093555 initrd-setup-root[836]: cut: /sysroot/etc/group: No such file or directory Jul 10 00:19:36.097023 initrd-setup-root[843]: cut: /sysroot/etc/shadow: No such file or directory Jul 10 00:19:36.100704 initrd-setup-root[850]: cut: /sysroot/etc/gshadow: No such file or directory Jul 10 00:19:36.170683 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 10 00:19:36.179271 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 10 00:19:36.181355 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 10 00:19:36.185206 kernel: BTRFS info (device vda6): last unmount of filesystem 8ce7827a-be35-4e5a-9c5c-f9bfd6370ac0 Jul 10 00:19:36.201503 ignition[919]: INFO : Ignition 2.19.0 Jul 10 00:19:36.201503 ignition[919]: INFO : Stage: mount Jul 10 00:19:36.204067 ignition[919]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:36.204067 ignition[919]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:36.204067 ignition[919]: INFO : mount: mount passed Jul 10 00:19:36.204067 ignition[919]: INFO : Ignition finished successfully Jul 10 00:19:36.206662 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 10 00:19:36.207560 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 10 00:19:36.217266 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 10 00:19:36.737951 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 10 00:19:36.747339 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 00:19:36.753603 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by mount (933) Jul 10 00:19:36.753631 kernel: BTRFS info (device vda6): first mount of filesystem 8ce7827a-be35-4e5a-9c5c-f9bfd6370ac0 Jul 10 00:19:36.753642 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 10 00:19:36.754286 kernel: BTRFS info (device vda6): using free space tree Jul 10 00:19:36.757221 kernel: BTRFS info (device vda6): auto enabling async discard Jul 10 00:19:36.757579 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 00:19:36.778055 ignition[950]: INFO : Ignition 2.19.0 Jul 10 00:19:36.778055 ignition[950]: INFO : Stage: files Jul 10 00:19:36.779262 ignition[950]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:36.779262 ignition[950]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:36.779262 ignition[950]: DEBUG : files: compiled without relabeling support, skipping Jul 10 00:19:36.781605 ignition[950]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 10 00:19:36.781605 ignition[950]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 10 00:19:36.783611 ignition[950]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 10 00:19:36.783611 ignition[950]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 10 00:19:36.785530 ignition[950]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Jul 10 00:19:36.785530 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-arm64.raw: attempt #1 Jul 10 00:19:36.783747 unknown[950]: wrote ssh authorized keys file for user: core Jul 10 00:19:37.350984 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Jul 10 00:19:37.578619 systemd-networkd[767]: eth0: Gained IPv6LL Jul 10 00:19:37.757394 ignition[950]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Jul 10 00:19:37.757394 ignition[950]: INFO : files: op(8): [started] processing unit "containerd.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(8): [finished] processing unit "containerd.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Jul 10 00:19:37.760117 ignition[950]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Jul 10 00:19:37.786188 ignition[950]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 00:19:37.790009 ignition[950]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 00:19:37.792097 ignition[950]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Jul 10 00:19:37.792097 ignition[950]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 10 00:19:37.792097 ignition[950]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 10 00:19:37.792097 ignition[950]: INFO : files: files passed Jul 10 00:19:37.792097 ignition[950]: INFO : Ignition finished successfully Jul 10 00:19:37.792748 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 10 00:19:37.799389 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 10 00:19:37.801427 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 10 00:19:37.803996 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 10 00:19:37.804082 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 10 00:19:37.808707 initrd-setup-root-after-ignition[978]: grep: /sysroot/oem/oem-release: No such file or directory Jul 10 00:19:37.811118 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:37.811118 initrd-setup-root-after-ignition[980]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:37.813830 initrd-setup-root-after-ignition[984]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:37.813783 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 00:19:37.814818 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 10 00:19:37.826365 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 10 00:19:37.843732 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 10 00:19:37.843843 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 10 00:19:37.845411 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 10 00:19:37.846716 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 10 00:19:37.847991 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 10 00:19:37.848651 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 10 00:19:37.862638 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 00:19:37.864583 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 10 00:19:37.874830 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:37.875767 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:37.877221 systemd[1]: Stopped target timers.target - Timer Units. Jul 10 00:19:37.878502 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 10 00:19:37.878608 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 00:19:37.880432 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 10 00:19:37.881863 systemd[1]: Stopped target basic.target - Basic System. Jul 10 00:19:37.883034 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 10 00:19:37.884251 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 00:19:37.885806 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 10 00:19:37.887233 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 10 00:19:37.888748 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 00:19:37.890122 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 10 00:19:37.891590 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 10 00:19:37.892847 systemd[1]: Stopped target swap.target - Swaps. Jul 10 00:19:37.893939 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 10 00:19:37.894048 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 10 00:19:37.895743 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:37.897096 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:37.898490 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 10 00:19:37.899851 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:37.901616 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 10 00:19:37.901729 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 10 00:19:37.903645 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 10 00:19:37.903755 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 00:19:37.905193 systemd[1]: Stopped target paths.target - Path Units. Jul 10 00:19:37.906383 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 10 00:19:37.907650 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:37.909558 systemd[1]: Stopped target slices.target - Slice Units. Jul 10 00:19:37.910302 systemd[1]: Stopped target sockets.target - Socket Units. Jul 10 00:19:37.911441 systemd[1]: iscsid.socket: Deactivated successfully. Jul 10 00:19:37.911527 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 00:19:37.912624 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 10 00:19:37.912701 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 00:19:37.913808 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 10 00:19:37.913917 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 00:19:37.915148 systemd[1]: ignition-files.service: Deactivated successfully. Jul 10 00:19:37.915257 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 10 00:19:37.928367 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 10 00:19:37.929698 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 10 00:19:37.930375 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 10 00:19:37.930493 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:37.931867 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 10 00:19:37.931980 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 00:19:37.936107 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 10 00:19:37.936922 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 10 00:19:37.940689 ignition[1004]: INFO : Ignition 2.19.0 Jul 10 00:19:37.940689 ignition[1004]: INFO : Stage: umount Jul 10 00:19:37.944274 ignition[1004]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:37.944274 ignition[1004]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:37.944274 ignition[1004]: INFO : umount: umount passed Jul 10 00:19:37.944274 ignition[1004]: INFO : Ignition finished successfully Jul 10 00:19:37.943579 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 10 00:19:37.946513 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 10 00:19:37.946603 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 10 00:19:37.947968 systemd[1]: Stopped target network.target - Network. Jul 10 00:19:37.949082 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 10 00:19:37.949137 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 10 00:19:37.950422 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 10 00:19:37.950466 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 10 00:19:37.951765 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 10 00:19:37.951806 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 10 00:19:37.952874 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 10 00:19:37.952919 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 10 00:19:37.954287 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 10 00:19:37.955644 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 10 00:19:37.961292 systemd-networkd[767]: eth0: DHCPv6 lease lost Jul 10 00:19:37.963024 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 10 00:19:37.963132 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 10 00:19:37.966136 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 10 00:19:37.966268 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 10 00:19:37.968451 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 10 00:19:37.968506 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:37.978277 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 10 00:19:37.978947 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 10 00:19:37.979002 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 00:19:37.979987 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 10 00:19:37.980025 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:37.980841 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 10 00:19:37.980877 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:37.982171 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 10 00:19:37.982220 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:37.983805 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:37.992221 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 10 00:19:37.992317 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 10 00:19:37.998881 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 10 00:19:37.999021 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:38.000955 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 10 00:19:38.001033 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 10 00:19:38.002404 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 10 00:19:38.002459 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:38.003279 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 10 00:19:38.003307 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:38.004489 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 10 00:19:38.004530 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 10 00:19:38.006529 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 10 00:19:38.006569 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 10 00:19:38.008558 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 10 00:19:38.008600 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:38.010755 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 10 00:19:38.010794 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 10 00:19:38.018303 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 10 00:19:38.019042 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 10 00:19:38.019087 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:38.020703 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 10 00:19:38.020740 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:38.022119 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 10 00:19:38.022153 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:38.023726 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 00:19:38.023761 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:38.025521 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 10 00:19:38.025590 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 10 00:19:38.029494 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 10 00:19:38.031343 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 10 00:19:38.039742 systemd[1]: Switching root. Jul 10 00:19:38.069951 systemd-journald[238]: Journal stopped Jul 10 00:19:38.748154 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Jul 10 00:19:38.748250 kernel: SELinux: policy capability network_peer_controls=1 Jul 10 00:19:38.748264 kernel: SELinux: policy capability open_perms=1 Jul 10 00:19:38.748273 kernel: SELinux: policy capability extended_socket_class=1 Jul 10 00:19:38.748286 kernel: SELinux: policy capability always_check_network=0 Jul 10 00:19:38.748296 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 10 00:19:38.748305 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 10 00:19:38.748315 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 10 00:19:38.748324 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 10 00:19:38.748334 kernel: audit: type=1403 audit(1752106778.239:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 10 00:19:38.748345 systemd[1]: Successfully loaded SELinux policy in 32.747ms. Jul 10 00:19:38.748364 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 8.832ms. Jul 10 00:19:38.748378 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 10 00:19:38.748389 systemd[1]: Detected virtualization kvm. Jul 10 00:19:38.748400 systemd[1]: Detected architecture arm64. Jul 10 00:19:38.748411 systemd[1]: Detected first boot. Jul 10 00:19:38.748422 systemd[1]: Initializing machine ID from VM UUID. Jul 10 00:19:38.748433 zram_generator::config[1069]: No configuration found. Jul 10 00:19:38.748446 systemd[1]: Populated /etc with preset unit settings. Jul 10 00:19:38.748456 systemd[1]: Queued start job for default target multi-user.target. Jul 10 00:19:38.748467 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 10 00:19:38.748478 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 10 00:19:38.748490 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 10 00:19:38.748501 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 10 00:19:38.748511 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 10 00:19:38.748522 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 10 00:19:38.748534 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 10 00:19:38.748571 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 10 00:19:38.748585 systemd[1]: Created slice user.slice - User and Session Slice. Jul 10 00:19:38.748596 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:38.748606 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:38.748617 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 10 00:19:38.748627 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 10 00:19:38.748638 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 10 00:19:38.748649 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 00:19:38.748662 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 10 00:19:38.748672 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:38.748684 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 10 00:19:38.748695 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:38.748705 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 00:19:38.748716 systemd[1]: Reached target slices.target - Slice Units. Jul 10 00:19:38.748727 systemd[1]: Reached target swap.target - Swaps. Jul 10 00:19:38.748737 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 10 00:19:38.748750 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 10 00:19:38.748760 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 10 00:19:38.748771 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 10 00:19:38.748782 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:38.748792 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:38.748803 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:38.748817 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 10 00:19:38.748828 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 10 00:19:38.748838 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 10 00:19:38.748850 systemd[1]: Mounting media.mount - External Media Directory... Jul 10 00:19:38.748860 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 10 00:19:38.748875 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 10 00:19:38.748886 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 10 00:19:38.748904 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 10 00:19:38.748916 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:38.748929 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 00:19:38.748940 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 10 00:19:38.748951 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:38.748964 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 00:19:38.748975 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:38.748987 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 10 00:19:38.748997 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:38.749008 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 10 00:19:38.749019 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Jul 10 00:19:38.749030 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.) Jul 10 00:19:38.749041 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 00:19:38.749053 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 00:19:38.749063 kernel: fuse: init (API version 7.39) Jul 10 00:19:38.749073 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 10 00:19:38.749083 kernel: loop: module loaded Jul 10 00:19:38.749093 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 10 00:19:38.749104 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 00:19:38.749114 kernel: ACPI: bus type drm_connector registered Jul 10 00:19:38.749124 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 10 00:19:38.749138 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 10 00:19:38.749150 systemd[1]: Mounted media.mount - External Media Directory. Jul 10 00:19:38.749180 systemd-journald[1147]: Collecting audit messages is disabled. Jul 10 00:19:38.749208 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 10 00:19:38.749220 systemd-journald[1147]: Journal started Jul 10 00:19:38.749241 systemd-journald[1147]: Runtime Journal (/run/log/journal/75837fbbfcc84bedb1ef2c37e611aa30) is 5.9M, max 47.3M, 41.4M free. Jul 10 00:19:38.751216 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 00:19:38.752019 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 10 00:19:38.753237 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 10 00:19:38.754425 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:38.755529 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 10 00:19:38.755682 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 10 00:19:38.756808 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:38.756971 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:38.758120 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 10 00:19:38.759548 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 00:19:38.759696 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 00:19:38.760710 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:38.760864 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:38.762105 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 10 00:19:38.762276 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 10 00:19:38.763274 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:38.763469 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:38.764549 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:38.765822 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 00:19:38.767228 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 10 00:19:38.777904 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 10 00:19:38.787300 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 10 00:19:38.789143 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 10 00:19:38.790024 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 10 00:19:38.792369 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 10 00:19:38.794353 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 10 00:19:38.796330 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 00:19:38.798635 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 10 00:19:38.799538 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 00:19:38.803360 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 00:19:38.804927 systemd-journald[1147]: Time spent on flushing to /var/log/journal/75837fbbfcc84bedb1ef2c37e611aa30 is 19.017ms for 828 entries. Jul 10 00:19:38.804927 systemd-journald[1147]: System Journal (/var/log/journal/75837fbbfcc84bedb1ef2c37e611aa30) is 8.0M, max 195.6M, 187.6M free. Jul 10 00:19:38.836342 systemd-journald[1147]: Received client request to flush runtime journal. Jul 10 00:19:38.807350 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 00:19:38.809777 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:38.812436 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 10 00:19:38.814510 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 10 00:19:38.815616 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 10 00:19:38.818946 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 10 00:19:38.833399 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 10 00:19:38.834681 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:38.836245 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Jul 10 00:19:38.836258 systemd-tmpfiles[1200]: ACLs are not supported, ignoring. Jul 10 00:19:38.838308 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 10 00:19:38.844818 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:38.856456 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 10 00:19:38.857471 udevadm[1208]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 10 00:19:38.877602 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 10 00:19:38.889413 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 00:19:38.900674 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Jul 10 00:19:38.900696 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Jul 10 00:19:38.904853 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:39.215446 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 10 00:19:39.228467 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:39.248267 systemd-udevd[1228]: Using default interface naming scheme 'v255'. Jul 10 00:19:39.260161 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:39.272317 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 00:19:39.284331 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 10 00:19:39.289325 systemd[1]: Found device dev-ttyAMA0.device - /dev/ttyAMA0. Jul 10 00:19:39.319253 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1248) Jul 10 00:19:39.335687 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 10 00:19:39.347039 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 00:19:39.386005 systemd-networkd[1235]: lo: Link UP Jul 10 00:19:39.386018 systemd-networkd[1235]: lo: Gained carrier Jul 10 00:19:39.386431 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:39.386768 systemd-networkd[1235]: Enumeration completed Jul 10 00:19:39.387379 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 00:19:39.387445 systemd-networkd[1235]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:39.387448 systemd-networkd[1235]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 00:19:39.388232 systemd-networkd[1235]: eth0: Link UP Jul 10 00:19:39.388284 systemd-networkd[1235]: eth0: Gained carrier Jul 10 00:19:39.388348 systemd-networkd[1235]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:39.389845 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 10 00:19:39.396369 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 10 00:19:39.398720 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 10 00:19:39.416461 systemd-networkd[1235]: eth0: DHCPv4 address 10.0.0.24/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 00:19:39.422173 lvm[1266]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 10 00:19:39.437969 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:39.454660 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 10 00:19:39.455780 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:39.469385 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 10 00:19:39.472701 lvm[1274]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 10 00:19:39.501433 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 10 00:19:39.502507 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 10 00:19:39.503423 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). Jul 10 00:19:39.503453 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 00:19:39.504162 systemd[1]: Reached target machines.target - Containers. Jul 10 00:19:39.505864 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jul 10 00:19:39.518307 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 10 00:19:39.520161 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 10 00:19:39.521004 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:39.521858 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 10 00:19:39.523706 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jul 10 00:19:39.526363 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 10 00:19:39.527820 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 10 00:19:39.536480 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 10 00:19:39.544221 kernel: loop0: detected capacity change from 0 to 114328 Jul 10 00:19:39.550613 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 10 00:19:39.551704 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jul 10 00:19:39.554209 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 10 00:19:39.580200 kernel: loop1: detected capacity change from 0 to 203944 Jul 10 00:19:39.619212 kernel: loop2: detected capacity change from 0 to 114432 Jul 10 00:19:39.664215 kernel: loop3: detected capacity change from 0 to 114328 Jul 10 00:19:39.669224 kernel: loop4: detected capacity change from 0 to 203944 Jul 10 00:19:39.674203 kernel: loop5: detected capacity change from 0 to 114432 Jul 10 00:19:39.679070 (sd-merge)[1295]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jul 10 00:19:39.679444 (sd-merge)[1295]: Merged extensions into '/usr'. Jul 10 00:19:39.690612 systemd[1]: Reloading requested from client PID 1282 ('systemd-sysext') (unit systemd-sysext.service)... Jul 10 00:19:39.690626 systemd[1]: Reloading... Jul 10 00:19:39.724236 zram_generator::config[1324]: No configuration found. Jul 10 00:19:39.756616 ldconfig[1278]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 10 00:19:39.816980 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:39.864792 systemd[1]: Reloading finished in 173 ms. Jul 10 00:19:39.882038 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 10 00:19:39.883492 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 10 00:19:39.899339 systemd[1]: Starting ensure-sysext.service... Jul 10 00:19:39.901122 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 00:19:39.905866 systemd[1]: Reloading requested from client PID 1365 ('systemctl') (unit ensure-sysext.service)... Jul 10 00:19:39.905881 systemd[1]: Reloading... Jul 10 00:19:39.916741 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 10 00:19:39.917013 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 10 00:19:39.917757 systemd-tmpfiles[1366]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 10 00:19:39.917990 systemd-tmpfiles[1366]: ACLs are not supported, ignoring. Jul 10 00:19:39.918044 systemd-tmpfiles[1366]: ACLs are not supported, ignoring. Jul 10 00:19:39.920231 systemd-tmpfiles[1366]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 00:19:39.920243 systemd-tmpfiles[1366]: Skipping /boot Jul 10 00:19:39.926996 systemd-tmpfiles[1366]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 00:19:39.927009 systemd-tmpfiles[1366]: Skipping /boot Jul 10 00:19:39.948260 zram_generator::config[1396]: No configuration found. Jul 10 00:19:40.034978 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:40.082670 systemd[1]: Reloading finished in 176 ms. Jul 10 00:19:40.096921 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:40.108966 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 10 00:19:40.111248 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 10 00:19:40.113327 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 10 00:19:40.116400 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 00:19:40.120370 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 10 00:19:40.129564 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:40.131462 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:40.135639 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:40.142403 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:40.143314 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:40.144078 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:40.144231 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:40.146859 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:40.147007 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:40.150955 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:40.154787 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:40.156364 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 10 00:19:40.160879 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:40.176451 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:40.179423 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:40.182421 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:40.183264 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:40.186464 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 10 00:19:40.188625 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 10 00:19:40.190310 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 10 00:19:40.191704 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:40.191844 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:40.193369 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:40.193547 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:40.194965 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:40.198173 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:40.199987 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 10 00:19:40.202009 systemd-resolved[1441]: Positive Trust Anchors: Jul 10 00:19:40.205667 systemd-resolved[1441]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 00:19:40.205761 systemd-resolved[1441]: 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 Jul 10 00:19:40.205949 augenrules[1480]: No rules Jul 10 00:19:40.209760 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 10 00:19:40.211809 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:40.212332 systemd-resolved[1441]: Defaulting to hostname 'linux'. Jul 10 00:19:40.217397 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:40.219151 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 00:19:40.220851 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:40.224352 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:40.225162 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:40.225330 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). Jul 10 00:19:40.225930 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 00:19:40.227369 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:40.227513 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:40.228806 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 00:19:40.228973 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 00:19:40.230153 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:40.230301 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:40.231585 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:40.231778 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:40.235422 systemd[1]: Finished ensure-sysext.service. Jul 10 00:19:40.238088 systemd[1]: Reached target network.target - Network. Jul 10 00:19:40.238999 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:40.239904 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 00:19:40.239969 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 00:19:40.254326 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 10 00:19:40.298725 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 10 00:19:40.299448 systemd-timesyncd[1509]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 10 00:19:40.299500 systemd-timesyncd[1509]: Initial clock synchronization to Thu 2025-07-10 00:19:40.277975 UTC. Jul 10 00:19:40.299973 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 00:19:40.300820 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 10 00:19:40.301727 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 10 00:19:40.302667 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 10 00:19:40.303569 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 10 00:19:40.303598 systemd[1]: Reached target paths.target - Path Units. Jul 10 00:19:40.304242 systemd[1]: Reached target time-set.target - System Time Set. Jul 10 00:19:40.305081 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 10 00:19:40.305974 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 10 00:19:40.306874 systemd[1]: Reached target timers.target - Timer Units. Jul 10 00:19:40.308230 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 10 00:19:40.310284 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 10 00:19:40.312016 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 10 00:19:40.325092 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 10 00:19:40.326172 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 00:19:40.327102 systemd[1]: Reached target basic.target - Basic System. Jul 10 00:19:40.328172 systemd[1]: System is tainted: cgroupsv1 Jul 10 00:19:40.328230 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 10 00:19:40.328248 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 10 00:19:40.329284 systemd[1]: Starting containerd.service - containerd container runtime... Jul 10 00:19:40.331274 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 10 00:19:40.333212 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 10 00:19:40.336202 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 10 00:19:40.337436 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). Jul 10 00:19:40.341094 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 10 00:19:40.342968 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 10 00:19:40.344144 jq[1515]: false Jul 10 00:19:40.346875 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 10 00:19:40.352180 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 10 00:19:40.354248 extend-filesystems[1517]: Found loop3 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found loop4 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found loop5 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda1 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda2 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda3 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found usr Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda4 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda6 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda7 Jul 10 00:19:40.354248 extend-filesystems[1517]: Found vda9 Jul 10 00:19:40.354248 extend-filesystems[1517]: Checking size of /dev/vda9 Jul 10 00:19:40.357474 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 10 00:19:40.361332 systemd[1]: Starting update-engine.service - Update Engine... Jul 10 00:19:40.365065 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 10 00:19:40.367599 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 10 00:19:40.367800 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 10 00:19:40.368048 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 10 00:19:40.368261 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 10 00:19:40.370905 dbus-daemon[1514]: [system] SELinux support is enabled Jul 10 00:19:40.373373 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 10 00:19:40.380672 jq[1534]: true Jul 10 00:19:40.378208 systemd[1]: motdgen.service: Deactivated successfully. Jul 10 00:19:40.378470 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 10 00:19:40.381956 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). Jul 10 00:19:40.381997 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 10 00:19:40.383615 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). Jul 10 00:19:40.383644 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 10 00:19:40.389272 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 40 scanned by (udev-worker) (1232) Jul 10 00:19:40.395793 extend-filesystems[1517]: Resized partition /dev/vda9 Jul 10 00:19:40.403190 extend-filesystems[1550]: resize2fs 1.47.1 (20-May-2024) Jul 10 00:19:40.404482 (ntainerd)[1548]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 10 00:19:40.412654 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jul 10 00:19:40.418084 jq[1552]: true Jul 10 00:19:40.422295 update_engine[1531]: I20250710 00:19:40.421901 1531 main.cc:92] Flatcar Update Engine starting Jul 10 00:19:40.426489 update_engine[1531]: I20250710 00:19:40.426373 1531 update_check_scheduler.cc:74] Next update check in 11m53s Jul 10 00:19:40.437199 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jul 10 00:19:40.439870 systemd[1]: Started update-engine.service - Update Engine. Jul 10 00:19:40.441788 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 10 00:19:40.442882 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 10 00:19:40.451667 systemd-logind[1524]: Watching system buttons on /dev/input/event0 (Power Button) Jul 10 00:19:40.452300 systemd-logind[1524]: New seat seat0. Jul 10 00:19:40.452868 extend-filesystems[1550]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jul 10 00:19:40.452868 extend-filesystems[1550]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 10 00:19:40.452868 extend-filesystems[1550]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jul 10 00:19:40.460932 extend-filesystems[1517]: Resized filesystem in /dev/vda9 Jul 10 00:19:40.454881 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 10 00:19:40.455325 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 10 00:19:40.463337 systemd[1]: Started systemd-logind.service - User Login Management. Jul 10 00:19:40.490274 bash[1573]: Updated "/home/core/.ssh/authorized_keys" Jul 10 00:19:40.492663 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 10 00:19:40.494408 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 10 00:19:40.514101 locksmithd[1556]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 10 00:19:40.604438 containerd[1548]: time="2025-07-10T00:19:40.604310200Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jul 10 00:19:40.627669 containerd[1548]: time="2025-07-10T00:19:40.627630120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629155840Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.95-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629197720Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629213560Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629355120Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629370680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629418560Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629430960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629633600Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629649720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629661720Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630346 containerd[1548]: time="2025-07-10T00:19:40.629671480Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.629743520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.629931560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.630063440Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.630078040Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.630160920Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 10 00:19:40.630591 containerd[1548]: time="2025-07-10T00:19:40.630219360Z" level=info msg="metadata content store policy set" policy=shared Jul 10 00:19:40.633721 containerd[1548]: time="2025-07-10T00:19:40.633695840Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 10 00:19:40.633843 containerd[1548]: time="2025-07-10T00:19:40.633828080Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 10 00:19:40.633930 containerd[1548]: time="2025-07-10T00:19:40.633916280Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 10 00:19:40.634013 containerd[1548]: time="2025-07-10T00:19:40.633999400Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 10 00:19:40.634108 containerd[1548]: time="2025-07-10T00:19:40.634095200Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 10 00:19:40.634306 containerd[1548]: time="2025-07-10T00:19:40.634285920Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 10 00:19:40.634694 containerd[1548]: time="2025-07-10T00:19:40.634675760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 10 00:19:40.634895 containerd[1548]: time="2025-07-10T00:19:40.634868720Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 10 00:19:40.634976 containerd[1548]: time="2025-07-10T00:19:40.634962680Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 10 00:19:40.635059 containerd[1548]: time="2025-07-10T00:19:40.635044200Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 10 00:19:40.635125 containerd[1548]: time="2025-07-10T00:19:40.635102040Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635180 containerd[1548]: time="2025-07-10T00:19:40.635166680Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635250 containerd[1548]: time="2025-07-10T00:19:40.635237960Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635324 containerd[1548]: time="2025-07-10T00:19:40.635312680Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635390 containerd[1548]: time="2025-07-10T00:19:40.635367880Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635463 containerd[1548]: time="2025-07-10T00:19:40.635442960Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635524 containerd[1548]: time="2025-07-10T00:19:40.635512600Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635583 containerd[1548]: time="2025-07-10T00:19:40.635561800Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 10 00:19:40.635645 containerd[1548]: time="2025-07-10T00:19:40.635631600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.635709 containerd[1548]: time="2025-07-10T00:19:40.635696440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.635782 containerd[1548]: time="2025-07-10T00:19:40.635770400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.635863 containerd[1548]: time="2025-07-10T00:19:40.635850320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.635936 containerd[1548]: time="2025-07-10T00:19:40.635924360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.635989 containerd[1548]: time="2025-07-10T00:19:40.635977400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636050 containerd[1548]: time="2025-07-10T00:19:40.636039240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636121 containerd[1548]: time="2025-07-10T00:19:40.636109080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636174 containerd[1548]: time="2025-07-10T00:19:40.636162760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636271 containerd[1548]: time="2025-07-10T00:19:40.636257840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636347 containerd[1548]: time="2025-07-10T00:19:40.636335040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636417 containerd[1548]: time="2025-07-10T00:19:40.636405360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636472 containerd[1548]: time="2025-07-10T00:19:40.636459840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636545 containerd[1548]: time="2025-07-10T00:19:40.636533120Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 10 00:19:40.636631 containerd[1548]: time="2025-07-10T00:19:40.636619320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636693 containerd[1548]: time="2025-07-10T00:19:40.636682240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.636750 containerd[1548]: time="2025-07-10T00:19:40.636731960Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 10 00:19:40.636942 containerd[1548]: time="2025-07-10T00:19:40.636920120Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 10 00:19:40.637028 containerd[1548]: time="2025-07-10T00:19:40.637011160Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jul 10 00:19:40.637091 containerd[1548]: time="2025-07-10T00:19:40.637079400Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 10 00:19:40.637164 containerd[1548]: time="2025-07-10T00:19:40.637150800Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jul 10 00:19:40.637237 containerd[1548]: time="2025-07-10T00:19:40.637222720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.637307 containerd[1548]: time="2025-07-10T00:19:40.637295000Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 10 00:19:40.637363 containerd[1548]: time="2025-07-10T00:19:40.637346000Z" level=info msg="NRI interface is disabled by configuration." Jul 10 00:19:40.637415 containerd[1548]: time="2025-07-10T00:19:40.637404040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 10 00:19:40.637865 containerd[1548]: time="2025-07-10T00:19:40.637804000Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:false] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 10 00:19:40.638059 containerd[1548]: time="2025-07-10T00:19:40.638041120Z" level=info msg="Connect containerd service" Jul 10 00:19:40.638199 containerd[1548]: time="2025-07-10T00:19:40.638131840Z" level=info msg="using legacy CRI server" Jul 10 00:19:40.638199 containerd[1548]: time="2025-07-10T00:19:40.638143040Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 10 00:19:40.639151 containerd[1548]: time="2025-07-10T00:19:40.638470440Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 10 00:19:40.639971 containerd[1548]: time="2025-07-10T00:19:40.639936320Z" 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" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640171640Z" level=info msg="Start subscribing containerd event" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640298000Z" level=info msg="Start recovering state" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640363080Z" level=info msg="Start event monitor" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640373520Z" level=info msg="Start snapshots syncer" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640381920Z" level=info msg="Start cni network conf syncer for default" Jul 10 00:19:40.640505 containerd[1548]: time="2025-07-10T00:19:40.640388760Z" level=info msg="Start streaming server" Jul 10 00:19:40.641130 containerd[1548]: time="2025-07-10T00:19:40.641108360Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 10 00:19:40.641280 containerd[1548]: time="2025-07-10T00:19:40.641263280Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 10 00:19:40.641400 containerd[1548]: time="2025-07-10T00:19:40.641387320Z" level=info msg="containerd successfully booted in 0.038467s" Jul 10 00:19:40.641499 systemd[1]: Started containerd.service - containerd container runtime. Jul 10 00:19:41.189611 sshd_keygen[1543]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 10 00:19:41.208303 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 10 00:19:41.217447 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 10 00:19:41.222720 systemd[1]: issuegen.service: Deactivated successfully. Jul 10 00:19:41.222959 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 10 00:19:41.225247 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 10 00:19:41.226335 systemd-networkd[1235]: eth0: Gained IPv6LL Jul 10 00:19:41.229252 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 10 00:19:41.230891 systemd[1]: Reached target network-online.target - Network is Online. Jul 10 00:19:41.232989 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 10 00:19:41.234899 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:41.238549 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 10 00:19:41.239946 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 10 00:19:41.247002 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 10 00:19:41.251528 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 10 00:19:41.252716 systemd[1]: Reached target getty.target - Login Prompts. Jul 10 00:19:41.258726 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 10 00:19:41.260811 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 10 00:19:41.261124 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 10 00:19:41.262627 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 10 00:19:41.777443 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:41.778622 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 10 00:19:41.779631 systemd[1]: Startup finished in 5.075s (kernel) + 3.573s (userspace) = 8.648s. Jul 10 00:19:41.780998 (kubelet)[1640]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jul 10 00:19:42.190371 kubelet[1640]: E0710 00:19:42.190101 1640 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" Jul 10 00:19:42.192400 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jul 10 00:19:42.192583 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jul 10 00:19:46.594176 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 10 00:19:46.605471 systemd[1]: Started sshd@0-10.0.0.24:22-10.0.0.1:44252.service - OpenSSH per-connection server daemon (10.0.0.1:44252). Jul 10 00:19:46.653025 sshd[1654]: Accepted publickey for core from 10.0.0.1 port 44252 ssh2: RSA SHA256:6ip12YJRxsd1pENU5FRdLlGNHGMqkKNn+D5B7RGN6xs Jul 10 00:19:46.654805 sshd[1654]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:46.664912 systemd-logind[1524]: New session 1 of user core. Jul 10 00:19:46.665731 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 10 00:19:46.674386 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 10 00:19:46.683860 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 10 00:19:46.685861 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 10 00:19:46.692035 (systemd)[1660]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 10 00:19:46.762972 systemd[1660]: Queued start job for default target default.target. Jul 10 00:19:46.763336 systemd[1660]: Created slice app.slice - User Application Slice. Jul 10 00:19:46.763358 systemd[1660]: Reached target paths.target - Paths. Jul 10 00:19:46.763370 systemd[1660]: Reached target timers.target - Timers. Jul 10 00:19:46.772337 systemd[1660]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 10 00:19:46.777509 systemd[1660]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 10 00:19:46.777561 systemd[1660]: Reached target sockets.target - Sockets. Jul 10 00:19:46.777572 systemd[1660]: Reached target basic.target - Basic System. Jul 10 00:19:46.777605 systemd[1660]: Reached target default.target - Main User Target. Jul 10 00:19:46.777628 systemd[1660]: Startup finished in 80ms. Jul 10 00:19:46.777974 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 10 00:19:46.779906 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 10 00:19:46.837429 systemd[1]: Started sshd@1-10.0.0.24:22-10.0.0.1:44260.service - OpenSSH per-connection server daemon (10.0.0.1:44260). Jul 10 00:19:46.873602 sshd[1672]: Accepted publickey for core from 10.0.0.1 port 44260 ssh2: RSA SHA256:6ip12YJRxsd1pENU5FRdLlGNHGMqkKNn+D5B7RGN6xs Jul 10 00:19:46.874802 sshd[1672]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:46.879248 systemd-logind[1524]: New session 2 of user core. Jul 10 00:19:46.905495 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 10 00:19:46.957474 sshd[1672]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:46.971441 systemd[1]: Started sshd@2-10.0.0.24:22-10.0.0.1:44264.service - OpenSSH per-connection server daemon (10.0.0.1:44264). Jul 10 00:19:46.971831 systemd[1]: sshd@1-10.0.0.24:22-10.0.0.1:44260.service: Deactivated successfully. Jul 10 00:19:46.973630 systemd-logind[1524]: Session 2 logged out. Waiting for processes to exit. Jul 10 00:19:46.974106 systemd[1]: session-2.scope: Deactivated successfully. Jul 10 00:19:46.975529 systemd-logind[1524]: Removed session 2. Jul 10 00:19:47.000676 sshd[1677]: Accepted publickey for core from 10.0.0.1 port 44264 ssh2: RSA SHA256:6ip12YJRxsd1pENU5FRdLlGNHGMqkKNn+D5B7RGN6xs Jul 10 00:19:47.001922 sshd[1677]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:47.006106 systemd-logind[1524]: New session 3 of user core. Jul 10 00:19:47.021447 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 10 00:19:47.069796 sshd[1677]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:47.078541 systemd[1]: Started sshd@3-10.0.0.24:22-10.0.0.1:44270.service - OpenSSH per-connection server daemon (10.0.0.1:44270). Jul 10 00:19:47.078910 systemd[1]: sshd@2-10.0.0.24:22-10.0.0.1:44264.service: Deactivated successfully. Jul 10 00:19:47.081319 systemd[1]: session-3.scope: Deactivated successfully. Jul 10 00:19:47.081866 systemd-logind[1524]: Session 3 logged out. Waiting for processes to exit. Jul 10 00:19:47.082682 systemd-logind[1524]: Removed session 3. Jul 10 00:19:47.107229 sshd[1685]: Accepted publickey for core from 10.0.0.1 port 44270 ssh2: RSA SHA256:6ip12YJRxsd1pENU5FRdLlGNHGMqkKNn+D5B7RGN6xs Jul 10 00:19:47.108353 sshd[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:47.111761 systemd-logind[1524]: New session 4 of user core. Jul 10 00:19:47.123513 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 10 00:19:47.177307 sshd[1685]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:47.193511 systemd[1]: Started sshd@4-10.0.0.24:22-10.0.0.1:44282.service - OpenSSH per-connection server daemon (10.0.0.1:44282). Jul 10 00:19:47.194013 systemd[1]: sshd@3-10.0.0.24:22-10.0.0.1:44270.service: Deactivated successfully. Jul 10 00:19:47.195488 systemd[1]: session-4.scope: Deactivated successfully. Jul 10 00:19:47.196057 systemd-logind[1524]: Session 4 logged out. Waiting for processes to exit. Jul 10 00:19:47.197203 systemd-logind[1524]: Removed session 4. Jul 10 00:19:47.225563 sshd[1694]: Accepted publickey for core from 10.0.0.1 port 44282 ssh2: RSA SHA256:6ip12YJRxsd1pENU5FRdLlGNHGMqkKNn+D5B7RGN6xs Jul 10 00:19:47.226681 sshd[1694]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:47.230700 systemd-logind[1524]: New session 5 of user core. Jul 10 00:19:47.241477 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 10 00:19:47.304578 sudo[1700]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jul 10 00:19:47.304859 sudo[1700]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 00:19:47.324462 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 10 00:19:47.339281 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 10 00:19:47.339514 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 10 00:19:47.726497 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:47.736394 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:47.757851 systemd[1]: Reloading requested from client PID 1747 ('systemctl') (unit session-5.scope)... Jul 10 00:19:47.757865 systemd[1]: Reloading... Jul 10 00:19:47.813213 zram_generator::config[1788]: No configuration found. Jul 10 00:19:47.935094 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:47.991038 systemd[1]: Reloading finished in 232 ms. Jul 10 00:19:48.035152 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jul 10 00:19:48.035238 systemd[1]: kubelet.service: Failed with result 'signal'. Jul 10 00:19:48.035473 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:48.037485 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:48.141765 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:48.146572 (kubelet)[1843]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jul 10 00:19:48.182157 kubelet[1843]: 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. Jul 10 00:19:48.182157 kubelet[1843]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI. Jul 10 00:19:48.182157 kubelet[1843]: 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. Jul 10 00:19:48.182532 kubelet[1843]: I0710 00:19:48.182228 1843 server.go:211] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jul 10 00:19:49.599775 kubelet[1843]: I0710 00:19:49.599716 1843 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Jul 10 00:19:49.599775 kubelet[1843]: I0710 00:19:49.599758 1843 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jul 10 00:19:49.600113 kubelet[1843]: I0710 00:19:49.599986 1843 server.go:934] "Client rotation is on, will bootstrap in background" Jul 10 00:19:49.645008 kubelet[1843]: I0710 00:19:49.644967 1843 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jul 10 00:19:49.655901 kubelet[1843]: E0710 00:19:49.655860 1843 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Jul 10 00:19:49.655901 kubelet[1843]: I0710 00:19:49.655898 1843 server.go:1408] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Jul 10 00:19:49.659507 kubelet[1843]: I0710 00:19:49.659470 1843 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jul 10 00:19:49.660550 kubelet[1843]: I0710 00:19:49.660522 1843 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Jul 10 00:19:49.660713 kubelet[1843]: I0710 00:19:49.660672 1843 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jul 10 00:19:49.660877 kubelet[1843]: I0710 00:19:49.660709 1843 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.24","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":1} Jul 10 00:19:49.661288 kubelet[1843]: I0710 00:19:49.660941 1843 topology_manager.go:138] "Creating topology manager with none policy" Jul 10 00:19:49.661288 kubelet[1843]: I0710 00:19:49.661290 1843 container_manager_linux.go:300] "Creating device plugin manager" Jul 10 00:19:49.661554 kubelet[1843]: I0710 00:19:49.661530 1843 state_mem.go:36] "Initialized new in-memory state store" Jul 10 00:19:49.663201 kubelet[1843]: I0710 00:19:49.663045 1843 kubelet.go:408] "Attempting to sync node with API server" Jul 10 00:19:49.663201 kubelet[1843]: I0710 00:19:49.663071 1843 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Jul 10 00:19:49.663201 kubelet[1843]: I0710 00:19:49.663097 1843 kubelet.go:314] "Adding apiserver pod source" Jul 10 00:19:49.663201 kubelet[1843]: I0710 00:19:49.663173 1843 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jul 10 00:19:49.663313 kubelet[1843]: E0710 00:19:49.663218 1843 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:49.663377 kubelet[1843]: E0710 00:19:49.663351 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:49.666115 kubelet[1843]: I0710 00:19:49.666096 1843 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Jul 10 00:19:49.666887 kubelet[1843]: I0710 00:19:49.666872 1843 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Jul 10 00:19:49.667047 kubelet[1843]: W0710 00:19:49.667035 1843 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.667918 1843 server.go:1274] "Started kubelet" Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.668660 1843 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.668728 1843 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.669077 1843 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.669315 1843 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jul 10 00:19:49.670090 kubelet[1843]: I0710 00:19:49.669793 1843 server.go:449] "Adding debug handlers to kubelet server" Jul 10 00:19:49.670799 kubelet[1843]: I0710 00:19:49.670756 1843 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jul 10 00:19:49.674589 kubelet[1843]: W0710 00:19:49.672396 1843 reflector.go:561] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.24" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Jul 10 00:19:49.674589 kubelet[1843]: E0710 00:19:49.672432 1843 reflector.go:158] "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.24\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Jul 10 00:19:49.674589 kubelet[1843]: W0710 00:19:49.672562 1843 reflector.go:561] 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 Jul 10 00:19:49.674589 kubelet[1843]: E0710 00:19:49.672578 1843 reflector.go:158] "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" Jul 10 00:19:49.674589 kubelet[1843]: I0710 00:19:49.672732 1843 volume_manager.go:289] "Starting Kubelet Volume Manager" Jul 10 00:19:49.674589 kubelet[1843]: I0710 00:19:49.673067 1843 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Jul 10 00:19:49.674589 kubelet[1843]: I0710 00:19:49.673144 1843 reconciler.go:26] "Reconciler: start to sync state" Jul 10 00:19:49.674589 kubelet[1843]: E0710 00:19:49.673481 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:49.674589 kubelet[1843]: I0710 00:19:49.673950 1843 factory.go:221] Registration of the systemd container factory successfully Jul 10 00:19:49.674589 kubelet[1843]: I0710 00:19:49.674081 1843 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 Jul 10 00:19:49.682219 kubelet[1843]: I0710 00:19:49.681650 1843 factory.go:221] Registration of the containerd container factory successfully Jul 10 00:19:49.682219 kubelet[1843]: E0710 00:19:49.682147 1843 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jul 10 00:19:49.687961 kubelet[1843]: E0710 00:19:49.687916 1843 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.24\" not found" node="10.0.0.24" Jul 10 00:19:49.697372 kubelet[1843]: I0710 00:19:49.697350 1843 cpu_manager.go:214] "Starting CPU manager" policy="none" Jul 10 00:19:49.697372 kubelet[1843]: I0710 00:19:49.697367 1843 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Jul 10 00:19:49.697509 kubelet[1843]: I0710 00:19:49.697400 1843 state_mem.go:36] "Initialized new in-memory state store" Jul 10 00:19:49.774085 kubelet[1843]: I0710 00:19:49.773883 1843 policy_none.go:49] "None policy: Start" Jul 10 00:19:49.774085 kubelet[1843]: E0710 00:19:49.774069 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:49.774951 kubelet[1843]: I0710 00:19:49.774657 1843 memory_manager.go:170] "Starting memorymanager" policy="None" Jul 10 00:19:49.774951 kubelet[1843]: I0710 00:19:49.774686 1843 state_mem.go:35] "Initializing new in-memory state store" Jul 10 00:19:49.778708 kubelet[1843]: I0710 00:19:49.778659 1843 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Jul 10 00:19:49.779325 kubelet[1843]: I0710 00:19:49.778878 1843 eviction_manager.go:189] "Eviction manager: starting control loop" Jul 10 00:19:49.779325 kubelet[1843]: I0710 00:19:49.778896 1843 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jul 10 00:19:49.780273 kubelet[1843]: I0710 00:19:49.779955 1843 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jul 10 00:19:49.781329 kubelet[1843]: E0710 00:19:49.781304 1843 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.24\" not found" Jul 10 00:19:49.800966 kubelet[1843]: I0710 00:19:49.800921 1843 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Jul 10 00:19:49.801942 kubelet[1843]: I0710 00:19:49.801903 1843 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Jul 10 00:19:49.801942 kubelet[1843]: I0710 00:19:49.801926 1843 status_manager.go:217] "Starting to sync pod status with apiserver" Jul 10 00:19:49.801942 kubelet[1843]: I0710 00:19:49.801941 1843 kubelet.go:2321] "Starting kubelet main sync loop" Jul 10 00:19:49.802046 kubelet[1843]: E0710 00:19:49.801979 1843 kubelet.go:2345] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jul 10 00:19:49.880427 kubelet[1843]: I0710 00:19:49.880334 1843 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.24" Jul 10 00:19:49.884398 kubelet[1843]: I0710 00:19:49.884364 1843 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.24" Jul 10 00:19:49.884398 kubelet[1843]: E0710 00:19:49.884398 1843 kubelet_node_status.go:535] "Error updating node status, will retry" err="error getting node \"10.0.0.24\": node \"10.0.0.24\" not found" Jul 10 00:19:49.890776 kubelet[1843]: E0710 00:19:49.890750 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:49.991011 kubelet[1843]: E0710 00:19:49.990956 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.091340 kubelet[1843]: E0710 00:19:50.091309 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.167766 sudo[1700]: pam_unix(sudo:session): session closed for user root Jul 10 00:19:50.171496 sshd[1694]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:50.174967 systemd[1]: sshd@4-10.0.0.24:22-10.0.0.1:44282.service: Deactivated successfully. Jul 10 00:19:50.176962 systemd-logind[1524]: Session 5 logged out. Waiting for processes to exit. Jul 10 00:19:50.177419 systemd[1]: session-5.scope: Deactivated successfully. Jul 10 00:19:50.178406 systemd-logind[1524]: Removed session 5. Jul 10 00:19:50.191745 kubelet[1843]: E0710 00:19:50.191711 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.292177 kubelet[1843]: E0710 00:19:50.292142 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.392583 kubelet[1843]: E0710 00:19:50.392556 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.493460 kubelet[1843]: E0710 00:19:50.492998 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.593551 kubelet[1843]: E0710 00:19:50.593515 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.601703 kubelet[1843]: I0710 00:19:50.601677 1843 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jul 10 00:19:50.601996 kubelet[1843]: W0710 00:19:50.601864 1843 reflector.go:484] 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 Jul 10 00:19:50.601996 kubelet[1843]: W0710 00:19:50.601874 1843 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver 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 Jul 10 00:19:50.664080 kubelet[1843]: E0710 00:19:50.664047 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:50.694355 kubelet[1843]: E0710 00:19:50.694325 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.795063 kubelet[1843]: E0710 00:19:50.794985 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.895462 kubelet[1843]: E0710 00:19:50.895429 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:50.996266 kubelet[1843]: E0710 00:19:50.996234 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:51.096792 kubelet[1843]: E0710 00:19:51.096722 1843 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.24\" not found" Jul 10 00:19:51.197657 kubelet[1843]: I0710 00:19:51.197635 1843 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jul 10 00:19:51.198003 containerd[1548]: time="2025-07-10T00:19:51.197916998Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jul 10 00:19:51.198302 kubelet[1843]: I0710 00:19:51.198079 1843 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jul 10 00:19:51.665094 kubelet[1843]: I0710 00:19:51.665061 1843 apiserver.go:52] "Watching apiserver" Jul 10 00:19:51.665094 kubelet[1843]: E0710 00:19:51.665087 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:51.673368 kubelet[1843]: I0710 00:19:51.673289 1843 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Jul 10 00:19:51.682264 kubelet[1843]: I0710 00:19:51.682173 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-run\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.682344 kubelet[1843]: I0710 00:19:51.682260 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gbzps\" (UniqueName: \"kubernetes.io/projected/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-kube-api-access-gbzps\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.682344 kubelet[1843]: I0710 00:19:51.682303 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-xtables-lock\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.682344 kubelet[1843]: I0710 00:19:51.682322 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/757148ef-384e-4ed6-8255-a557cbc599c9-kube-proxy\") pod \"kube-proxy-rdp2w\" (UID: \"757148ef-384e-4ed6-8255-a557cbc599c9\") " pod="kube-system/kube-proxy-rdp2w" Jul 10 00:19:51.682344 kubelet[1843]: I0710 00:19:51.682338 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/757148ef-384e-4ed6-8255-a557cbc599c9-xtables-lock\") pod \"kube-proxy-rdp2w\" (UID: \"757148ef-384e-4ed6-8255-a557cbc599c9\") " pod="kube-system/kube-proxy-rdp2w" Jul 10 00:19:51.682440 kubelet[1843]: I0710 00:19:51.682352 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/757148ef-384e-4ed6-8255-a557cbc599c9-lib-modules\") pod \"kube-proxy-rdp2w\" (UID: \"757148ef-384e-4ed6-8255-a557cbc599c9\") " pod="kube-system/kube-proxy-rdp2w" Jul 10 00:19:51.682440 kubelet[1843]: I0710 00:19:51.682367 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-644xw\" (UniqueName: \"kubernetes.io/projected/757148ef-384e-4ed6-8255-a557cbc599c9-kube-api-access-644xw\") pod \"kube-proxy-rdp2w\" (UID: \"757148ef-384e-4ed6-8255-a557cbc599c9\") " pod="kube-system/kube-proxy-rdp2w" Jul 10 00:19:51.682440 kubelet[1843]: I0710 00:19:51.682383 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-cni-plugin\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.682440 kubelet[1843]: I0710 00:19:51.682398 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-cni\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.682440 kubelet[1843]: I0710 00:19:51.682412 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/ac80f1ce-07a4-4f28-9f91-e5d235c8163a-flannel-cfg\") pod \"kube-flannel-ds-xszhc\" (UID: \"ac80f1ce-07a4-4f28-9f91-e5d235c8163a\") " pod="kube-flannel/kube-flannel-ds-xszhc" Jul 10 00:19:51.971828 kubelet[1843]: E0710 00:19:51.971657 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:51.972841 containerd[1548]: time="2025-07-10T00:19:51.972785085Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-xszhc,Uid:ac80f1ce-07a4-4f28-9f91-e5d235c8163a,Namespace:kube-flannel,Attempt:0,}" Jul 10 00:19:51.973883 kubelet[1843]: E0710 00:19:51.973853 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:51.974293 containerd[1548]: time="2025-07-10T00:19:51.974263168Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-rdp2w,Uid:757148ef-384e-4ed6-8255-a557cbc599c9,Namespace:kube-system,Attempt:0,}" Jul 10 00:19:52.522734 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1595666505.mount: Deactivated successfully. Jul 10 00:19:52.527755 containerd[1548]: time="2025-07-10T00:19:52.527714078Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 10 00:19:52.528766 containerd[1548]: time="2025-07-10T00:19:52.528734887Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 10 00:19:52.529310 containerd[1548]: time="2025-07-10T00:19:52.529282607Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269175" Jul 10 00:19:52.530017 containerd[1548]: time="2025-07-10T00:19:52.529971394Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 10 00:19:52.532848 containerd[1548]: time="2025-07-10T00:19:52.531813623Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Jul 10 00:19:52.534114 containerd[1548]: time="2025-07-10T00:19:52.534083370Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 10 00:19:52.535017 containerd[1548]: time="2025-07-10T00:19:52.534987416Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 560.659693ms" Jul 10 00:19:52.535791 containerd[1548]: time="2025-07-10T00:19:52.535762866Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 562.889283ms" Jul 10 00:19:52.633592 containerd[1548]: time="2025-07-10T00:19:52.633507443Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 10 00:19:52.633592 containerd[1548]: time="2025-07-10T00:19:52.633555771Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 10 00:19:52.633592 containerd[1548]: time="2025-07-10T00:19:52.633567323Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:19:52.633788 containerd[1548]: time="2025-07-10T00:19:52.633653587Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:19:52.633788 containerd[1548]: time="2025-07-10T00:19:52.633042109Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 10 00:19:52.633788 containerd[1548]: time="2025-07-10T00:19:52.633723061Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 10 00:19:52.633788 containerd[1548]: time="2025-07-10T00:19:52.633735893Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:19:52.633872 containerd[1548]: time="2025-07-10T00:19:52.633804328Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:19:52.665343 kubelet[1843]: E0710 00:19:52.665296 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:52.736426 containerd[1548]: time="2025-07-10T00:19:52.736284551Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-rdp2w,Uid:757148ef-384e-4ed6-8255-a557cbc599c9,Namespace:kube-system,Attempt:0,} returns sandbox id \"145b5ea3d48dacea4c78ffcff3b681f20ef52d907fc7f9412c26f9e95a591f01\"" Jul 10 00:19:52.739783 kubelet[1843]: E0710 00:19:52.739757 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:52.740857 containerd[1548]: time="2025-07-10T00:19:52.740831601Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.10\"" Jul 10 00:19:52.743212 containerd[1548]: time="2025-07-10T00:19:52.743167905Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-xszhc,Uid:ac80f1ce-07a4-4f28-9f91-e5d235c8163a,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\"" Jul 10 00:19:52.743871 kubelet[1843]: E0710 00:19:52.743796 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:53.666172 kubelet[1843]: E0710 00:19:53.666128 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:53.739796 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3351655637.mount: Deactivated successfully. Jul 10 00:19:53.949759 containerd[1548]: time="2025-07-10T00:19:53.949648862Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:53.950452 containerd[1548]: time="2025-07-10T00:19:53.950416589Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.10: active requests=0, bytes read=26915959" Jul 10 00:19:53.951372 containerd[1548]: time="2025-07-10T00:19:53.951323789Z" level=info msg="ImageCreate event name:\"sha256:dde5ff0da443b455e81aefc7bf6a216fdd659d1cbe13b8e8ac8129c3ecd27f89\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:53.953274 containerd[1548]: time="2025-07-10T00:19:53.953238569Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:bcbb293812bdf587b28ea98369a8c347ca84884160046296761acdf12b27029d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:53.954010 containerd[1548]: time="2025-07-10T00:19:53.953919949Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.10\" with image id \"sha256:dde5ff0da443b455e81aefc7bf6a216fdd659d1cbe13b8e8ac8129c3ecd27f89\", repo tag \"registry.k8s.io/kube-proxy:v1.31.10\", repo digest \"registry.k8s.io/kube-proxy@sha256:bcbb293812bdf587b28ea98369a8c347ca84884160046296761acdf12b27029d\", size \"26914976\" in 1.213052531s" Jul 10 00:19:53.954010 containerd[1548]: time="2025-07-10T00:19:53.953949051Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.10\" returns image reference \"sha256:dde5ff0da443b455e81aefc7bf6a216fdd659d1cbe13b8e8ac8129c3ecd27f89\"" Jul 10 00:19:53.954758 containerd[1548]: time="2025-07-10T00:19:53.954721975Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Jul 10 00:19:53.955898 containerd[1548]: time="2025-07-10T00:19:53.955774766Z" level=info msg="CreateContainer within sandbox \"145b5ea3d48dacea4c78ffcff3b681f20ef52d907fc7f9412c26f9e95a591f01\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jul 10 00:19:53.965015 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1784786251.mount: Deactivated successfully. Jul 10 00:19:53.967220 containerd[1548]: time="2025-07-10T00:19:53.967142040Z" level=info msg="CreateContainer within sandbox \"145b5ea3d48dacea4c78ffcff3b681f20ef52d907fc7f9412c26f9e95a591f01\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"186c37a2f9c769f8caa4291405a2988ca613a564afb347ce5a2f725ac8c40280\"" Jul 10 00:19:53.967774 containerd[1548]: time="2025-07-10T00:19:53.967709850Z" level=info msg="StartContainer for \"186c37a2f9c769f8caa4291405a2988ca613a564afb347ce5a2f725ac8c40280\"" Jul 10 00:19:54.009853 containerd[1548]: time="2025-07-10T00:19:54.009794283Z" level=info msg="StartContainer for \"186c37a2f9c769f8caa4291405a2988ca613a564afb347ce5a2f725ac8c40280\" returns successfully" Jul 10 00:19:54.666682 kubelet[1843]: E0710 00:19:54.666646 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:54.812885 kubelet[1843]: E0710 00:19:54.812422 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:54.820249 kubelet[1843]: I0710 00:19:54.820153 1843 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-rdp2w" podStartSLOduration=4.605994145 podStartE2EDuration="5.820139305s" podCreationTimestamp="2025-07-10 00:19:49 +0000 UTC" firstStartedPulling="2025-07-10 00:19:52.740435302 +0000 UTC m=+4.590678299" lastFinishedPulling="2025-07-10 00:19:53.954580462 +0000 UTC m=+5.804823459" observedRunningTime="2025-07-10 00:19:54.820037164 +0000 UTC m=+6.670280161" watchObservedRunningTime="2025-07-10 00:19:54.820139305 +0000 UTC m=+6.670382302" Jul 10 00:19:55.018579 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount70092562.mount: Deactivated successfully. Jul 10 00:19:55.041388 containerd[1548]: time="2025-07-10T00:19:55.041339186Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:55.041797 containerd[1548]: time="2025-07-10T00:19:55.041768713Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532" Jul 10 00:19:55.042673 containerd[1548]: time="2025-07-10T00:19:55.042645638Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:55.044761 containerd[1548]: time="2025-07-10T00:19:55.044712559Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:55.045682 containerd[1548]: time="2025-07-10T00:19:55.045647372Z" 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.090892817s" Jul 10 00:19:55.045682 containerd[1548]: time="2025-07-10T00:19:55.045678915Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Jul 10 00:19:55.047745 containerd[1548]: time="2025-07-10T00:19:55.047699940Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jul 10 00:19:55.056721 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4241806842.mount: Deactivated successfully. Jul 10 00:19:55.057594 containerd[1548]: time="2025-07-10T00:19:55.057560919Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217\"" Jul 10 00:19:55.058079 containerd[1548]: time="2025-07-10T00:19:55.057997922Z" level=info msg="StartContainer for \"f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217\"" Jul 10 00:19:55.095992 containerd[1548]: time="2025-07-10T00:19:55.095957121Z" level=info msg="StartContainer for \"f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217\" returns successfully" Jul 10 00:19:55.262808 containerd[1548]: time="2025-07-10T00:19:55.262727707Z" level=info msg="shim disconnected" id=f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217 namespace=k8s.io Jul 10 00:19:55.262808 containerd[1548]: time="2025-07-10T00:19:55.262774761Z" level=warning msg="cleaning up after shim disconnected" id=f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217 namespace=k8s.io Jul 10 00:19:55.262808 containerd[1548]: time="2025-07-10T00:19:55.262782517Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 10 00:19:55.666874 kubelet[1843]: E0710 00:19:55.666821 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:55.814774 kubelet[1843]: E0710 00:19:55.814702 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:55.814774 kubelet[1843]: E0710 00:19:55.814752 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:55.815415 containerd[1548]: time="2025-07-10T00:19:55.815389427Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Jul 10 00:19:55.970223 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-f0d1bde606e65998874743481d631f9eac2213c71a7160348ba024ecd81a9217-rootfs.mount: Deactivated successfully. Jul 10 00:19:56.667695 kubelet[1843]: E0710 00:19:56.667645 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:56.952506 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2212706907.mount: Deactivated successfully. Jul 10 00:19:57.412618 containerd[1548]: time="2025-07-10T00:19:57.412499732Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:57.414568 containerd[1548]: time="2025-07-10T00:19:57.413345569Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261" Jul 10 00:19:57.416265 containerd[1548]: time="2025-07-10T00:19:57.415848418Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:57.419399 containerd[1548]: time="2025-07-10T00:19:57.419364064Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:57.420492 containerd[1548]: time="2025-07-10T00:19:57.420464540Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26863435\" in 1.605038893s" Jul 10 00:19:57.420549 containerd[1548]: time="2025-07-10T00:19:57.420497205Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Jul 10 00:19:57.422911 containerd[1548]: time="2025-07-10T00:19:57.422794831Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jul 10 00:19:57.433071 containerd[1548]: time="2025-07-10T00:19:57.432980862Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335\"" Jul 10 00:19:57.433732 containerd[1548]: time="2025-07-10T00:19:57.433468110Z" level=info msg="StartContainer for \"bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335\"" Jul 10 00:19:57.476763 containerd[1548]: time="2025-07-10T00:19:57.476722279Z" level=info msg="StartContainer for \"bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335\" returns successfully" Jul 10 00:19:57.508299 kubelet[1843]: I0710 00:19:57.508261 1843 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Jul 10 00:19:57.597181 containerd[1548]: time="2025-07-10T00:19:57.597074786Z" level=info msg="shim disconnected" id=bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335 namespace=k8s.io Jul 10 00:19:57.597181 containerd[1548]: time="2025-07-10T00:19:57.597130599Z" level=warning msg="cleaning up after shim disconnected" id=bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335 namespace=k8s.io Jul 10 00:19:57.597181 containerd[1548]: time="2025-07-10T00:19:57.597142234Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 10 00:19:57.668147 kubelet[1843]: E0710 00:19:57.667996 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:57.820161 kubelet[1843]: E0710 00:19:57.820123 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:57.821862 containerd[1548]: time="2025-07-10T00:19:57.821818998Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jul 10 00:19:57.831656 containerd[1548]: time="2025-07-10T00:19:57.831603860Z" level=info msg="CreateContainer within sandbox \"e5af436cf1b23c7f877a85b3c7e5ee1d326705b2607576925f496b859e5f86bb\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"6b2c0c8225f42aafecfec65073bc1c681fcbde634ba58d0e8a6c3242d84fde5e\"" Jul 10 00:19:57.832058 containerd[1548]: time="2025-07-10T00:19:57.832031096Z" level=info msg="StartContainer for \"6b2c0c8225f42aafecfec65073bc1c681fcbde634ba58d0e8a6c3242d84fde5e\"" Jul 10 00:19:57.887868 containerd[1548]: time="2025-07-10T00:19:57.887814621Z" level=info msg="StartContainer for \"6b2c0c8225f42aafecfec65073bc1c681fcbde634ba58d0e8a6c3242d84fde5e\" returns successfully" Jul 10 00:19:58.429346 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-bb97869de13a8d9b72e2393c1f0688cedea147c67ab9df873e91dfaff1dd4335-rootfs.mount: Deactivated successfully. Jul 10 00:19:58.668791 kubelet[1843]: E0710 00:19:58.668734 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:58.823853 kubelet[1843]: E0710 00:19:58.823749 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:19:58.976937 systemd-networkd[1235]: flannel.1: Link UP Jul 10 00:19:58.976950 systemd-networkd[1235]: flannel.1: Gained carrier Jul 10 00:19:59.669704 kubelet[1843]: E0710 00:19:59.669624 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:59.825939 kubelet[1843]: E0710 00:19:59.825906 1843 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 10 00:20:00.490392 systemd-networkd[1235]: flannel.1: Gained IPv6LL Jul 10 00:20:00.670493 kubelet[1843]: E0710 00:20:00.670431 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:00.967342 kubelet[1843]: I0710 00:20:00.965502 1843 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-xszhc" podStartSLOduration=7.288171511 podStartE2EDuration="11.965482624s" podCreationTimestamp="2025-07-10 00:19:49 +0000 UTC" firstStartedPulling="2025-07-10 00:19:52.744292965 +0000 UTC m=+4.594535962" lastFinishedPulling="2025-07-10 00:19:57.421604078 +0000 UTC m=+9.271847075" observedRunningTime="2025-07-10 00:19:58.838239842 +0000 UTC m=+10.688482839" watchObservedRunningTime="2025-07-10 00:20:00.965482624 +0000 UTC m=+12.815725621" Jul 10 00:20:01.042033 kubelet[1843]: I0710 00:20:01.041981 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hc4km\" (UniqueName: \"kubernetes.io/projected/efefb900-77ba-495f-8578-240a6365b55e-kube-api-access-hc4km\") pod \"nginx-deployment-8587fbcb89-6g52l\" (UID: \"efefb900-77ba-495f-8578-240a6365b55e\") " pod="default/nginx-deployment-8587fbcb89-6g52l" Jul 10 00:20:01.271385 containerd[1548]: time="2025-07-10T00:20:01.270939259Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6g52l,Uid:efefb900-77ba-495f-8578-240a6365b55e,Namespace:default,Attempt:0,}" Jul 10 00:20:01.320737 systemd-networkd[1235]: cni0: Link UP Jul 10 00:20:01.320742 systemd-networkd[1235]: cni0: Gained carrier Jul 10 00:20:01.321145 systemd-networkd[1235]: cni0: Lost carrier Jul 10 00:20:01.327566 systemd-networkd[1235]: veth6cb7cbb2: Link UP Jul 10 00:20:01.332211 kernel: cni0: port 1(veth6cb7cbb2) entered blocking state Jul 10 00:20:01.332281 kernel: cni0: port 1(veth6cb7cbb2) entered disabled state Jul 10 00:20:01.332299 kernel: veth6cb7cbb2: entered allmulticast mode Jul 10 00:20:01.332315 kernel: veth6cb7cbb2: entered promiscuous mode Jul 10 00:20:01.332327 kernel: cni0: port 1(veth6cb7cbb2) entered blocking state Jul 10 00:20:01.332570 kernel: cni0: port 1(veth6cb7cbb2) entered forwarding state Jul 10 00:20:01.336233 kernel: cni0: port 1(veth6cb7cbb2) entered disabled state Jul 10 00:20:01.352059 kernel: cni0: port 1(veth6cb7cbb2) entered blocking state Jul 10 00:20:01.352125 kernel: cni0: port 1(veth6cb7cbb2) entered forwarding state Jul 10 00:20:01.352110 systemd-networkd[1235]: veth6cb7cbb2: Gained carrier Jul 10 00:20:01.352375 systemd-networkd[1235]: cni0: Gained carrier Jul 10 00:20:01.353620 containerd[1548]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400001c938), "name":"cbr0", "type":"bridge"} Jul 10 00:20:01.353620 containerd[1548]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:01.378434 containerd[1548]: {"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-07-10T00:20:01.378355322Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 10 00:20:01.378434 containerd[1548]: time="2025-07-10T00:20:01.378402945Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 10 00:20:01.378434 containerd[1548]: time="2025-07-10T00:20:01.378413701Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:01.378640 containerd[1548]: time="2025-07-10T00:20:01.378491032Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:01.402106 systemd-resolved[1441]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:01.419213 containerd[1548]: time="2025-07-10T00:20:01.419141126Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6g52l,Uid:efefb900-77ba-495f-8578-240a6365b55e,Namespace:default,Attempt:0,} returns sandbox id \"af3207c614a136ea2d4b54bacf1cbb59adecb3ab72442173ae50b1921a9526ea\"" Jul 10 00:20:01.421204 containerd[1548]: time="2025-07-10T00:20:01.421155785Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 10 00:20:01.671104 kubelet[1843]: E0710 00:20:01.670983 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:02.666460 systemd-networkd[1235]: veth6cb7cbb2: Gained IPv6LL Jul 10 00:20:02.671645 kubelet[1843]: E0710 00:20:02.671597 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:02.730716 systemd-networkd[1235]: cni0: Gained IPv6LL Jul 10 00:20:03.529854 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1150741316.mount: Deactivated successfully. Jul 10 00:20:03.672271 kubelet[1843]: E0710 00:20:03.672235 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:04.182686 containerd[1548]: time="2025-07-10T00:20:04.182641177Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:04.183794 containerd[1548]: time="2025-07-10T00:20:04.183721770Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69964585" Jul 10 00:20:04.184351 containerd[1548]: time="2025-07-10T00:20:04.184319589Z" level=info msg="ImageCreate event name:\"sha256:cd8b38a4e22587134e82fff3512a99b84799274d989a1ec20f58c7f8c89b8511\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:04.188475 containerd[1548]: time="2025-07-10T00:20:04.188414269Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:04.189396 containerd[1548]: time="2025-07-10T00:20:04.189351225Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:cd8b38a4e22587134e82fff3512a99b84799274d989a1ec20f58c7f8c89b8511\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"69964463\" in 2.768160533s" Jul 10 00:20:04.189396 containerd[1548]: time="2025-07-10T00:20:04.189381376Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:cd8b38a4e22587134e82fff3512a99b84799274d989a1ec20f58c7f8c89b8511\"" Jul 10 00:20:04.191254 containerd[1548]: time="2025-07-10T00:20:04.191224537Z" level=info msg="CreateContainer within sandbox \"af3207c614a136ea2d4b54bacf1cbb59adecb3ab72442173ae50b1921a9526ea\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jul 10 00:20:04.200310 containerd[1548]: time="2025-07-10T00:20:04.200270717Z" level=info msg="CreateContainer within sandbox \"af3207c614a136ea2d4b54bacf1cbb59adecb3ab72442173ae50b1921a9526ea\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"726201100b5b7cf61a65fe4a0dff475c427e67a2125e4bffa2b2abaf04fefe66\"" Jul 10 00:20:04.200745 containerd[1548]: time="2025-07-10T00:20:04.200671155Z" level=info msg="StartContainer for \"726201100b5b7cf61a65fe4a0dff475c427e67a2125e4bffa2b2abaf04fefe66\"" Jul 10 00:20:04.243726 containerd[1548]: time="2025-07-10T00:20:04.243681725Z" level=info msg="StartContainer for \"726201100b5b7cf61a65fe4a0dff475c427e67a2125e4bffa2b2abaf04fefe66\" returns successfully" Jul 10 00:20:04.672986 kubelet[1843]: E0710 00:20:04.672876 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:05.673846 kubelet[1843]: E0710 00:20:05.673803 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:06.674148 kubelet[1843]: E0710 00:20:06.674106 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:07.674854 kubelet[1843]: E0710 00:20:07.674743 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:07.853006 kubelet[1843]: I0710 00:20:07.852849 1843 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-6g52l" podStartSLOduration=5.083385602 podStartE2EDuration="7.852829752s" podCreationTimestamp="2025-07-10 00:20:00 +0000 UTC" firstStartedPulling="2025-07-10 00:20:01.420656568 +0000 UTC m=+13.270899565" lastFinishedPulling="2025-07-10 00:20:04.190100718 +0000 UTC m=+16.040343715" observedRunningTime="2025-07-10 00:20:04.843476377 +0000 UTC m=+16.693719374" watchObservedRunningTime="2025-07-10 00:20:07.852829752 +0000 UTC m=+19.703072749" Jul 10 00:20:07.878486 kubelet[1843]: I0710 00:20:07.878434 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/8821d3bc-d0f3-44c3-abc9-1946f6476704-data\") pod \"nfs-server-provisioner-0\" (UID: \"8821d3bc-d0f3-44c3-abc9-1946f6476704\") " pod="default/nfs-server-provisioner-0" Jul 10 00:20:07.878486 kubelet[1843]: I0710 00:20:07.878480 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-28qp4\" (UniqueName: \"kubernetes.io/projected/8821d3bc-d0f3-44c3-abc9-1946f6476704-kube-api-access-28qp4\") pod \"nfs-server-provisioner-0\" (UID: \"8821d3bc-d0f3-44c3-abc9-1946f6476704\") " pod="default/nfs-server-provisioner-0" Jul 10 00:20:08.156875 containerd[1548]: time="2025-07-10T00:20:08.156753837Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:8821d3bc-d0f3-44c3-abc9-1946f6476704,Namespace:default,Attempt:0,}" Jul 10 00:20:08.186061 systemd-networkd[1235]: veth2cf354c5: Link UP Jul 10 00:20:08.188506 kernel: cni0: port 2(veth2cf354c5) entered blocking state Jul 10 00:20:08.188572 kernel: cni0: port 2(veth2cf354c5) entered disabled state Jul 10 00:20:08.188593 kernel: veth2cf354c5: entered allmulticast mode Jul 10 00:20:08.188616 kernel: veth2cf354c5: entered promiscuous mode Jul 10 00:20:08.194824 kernel: cni0: port 2(veth2cf354c5) entered blocking state Jul 10 00:20:08.194874 kernel: cni0: port 2(veth2cf354c5) entered forwarding state Jul 10 00:20:08.194773 systemd-networkd[1235]: veth2cf354c5: Gained carrier Jul 10 00:20:08.198848 containerd[1548]: 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)(0x400009e8e8), "name":"cbr0", "type":"bridge"} Jul 10 00:20:08.198848 containerd[1548]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:08.228541 containerd[1548]: {"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-07-10T00:20:08.228412909Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 10 00:20:08.228541 containerd[1548]: time="2025-07-10T00:20:08.228534960Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 10 00:20:08.228541 containerd[1548]: time="2025-07-10T00:20:08.228552036Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:08.228779 containerd[1548]: time="2025-07-10T00:20:08.228713438Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:08.256749 systemd-resolved[1441]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:08.275396 containerd[1548]: time="2025-07-10T00:20:08.275273783Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:8821d3bc-d0f3-44c3-abc9-1946f6476704,Namespace:default,Attempt:0,} returns sandbox id \"8d8d8dc49b82380bee6ef4e3515499fc3afe879ae937586aa6033c57f8802247\"" Jul 10 00:20:08.277625 containerd[1548]: time="2025-07-10T00:20:08.277586282Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jul 10 00:20:08.675364 kubelet[1843]: E0710 00:20:08.675317 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:09.450349 systemd-networkd[1235]: veth2cf354c5: Gained IPv6LL Jul 10 00:20:09.663617 kubelet[1843]: E0710 00:20:09.663560 1843 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:09.676070 kubelet[1843]: E0710 00:20:09.676014 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:10.376514 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2320940225.mount: Deactivated successfully. Jul 10 00:20:10.676860 kubelet[1843]: E0710 00:20:10.676667 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:11.677276 kubelet[1843]: E0710 00:20:11.677240 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:11.699003 containerd[1548]: time="2025-07-10T00:20:11.698950914Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:11.700097 containerd[1548]: time="2025-07-10T00:20:11.700062660Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625" Jul 10 00:20:11.700847 containerd[1548]: time="2025-07-10T00:20:11.700653146Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:11.703312 containerd[1548]: time="2025-07-10T00:20:11.703276760Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:11.704503 containerd[1548]: time="2025-07-10T00:20:11.704463691Z" 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.42683046s" Jul 10 00:20:11.704567 containerd[1548]: time="2025-07-10T00:20:11.704503723Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Jul 10 00:20:11.706594 containerd[1548]: time="2025-07-10T00:20:11.706566206Z" level=info msg="CreateContainer within sandbox \"8d8d8dc49b82380bee6ef4e3515499fc3afe879ae937586aa6033c57f8802247\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jul 10 00:20:11.718275 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount481068181.mount: Deactivated successfully. Jul 10 00:20:11.723202 containerd[1548]: time="2025-07-10T00:20:11.723137971Z" level=info msg="CreateContainer within sandbox \"8d8d8dc49b82380bee6ef4e3515499fc3afe879ae937586aa6033c57f8802247\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"014daa2e1e55d6f549a0a16367632dd59508ee3be31ad914a635dfb961857594\"" Jul 10 00:20:11.723861 containerd[1548]: time="2025-07-10T00:20:11.723641274Z" level=info msg="StartContainer for \"014daa2e1e55d6f549a0a16367632dd59508ee3be31ad914a635dfb961857594\"" Jul 10 00:20:11.770595 containerd[1548]: time="2025-07-10T00:20:11.770508237Z" level=info msg="StartContainer for \"014daa2e1e55d6f549a0a16367632dd59508ee3be31ad914a635dfb961857594\" returns successfully" Jul 10 00:20:11.859581 kubelet[1843]: I0710 00:20:11.859510 1843 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.4309029149999999 podStartE2EDuration="4.85949316s" podCreationTimestamp="2025-07-10 00:20:07 +0000 UTC" firstStartedPulling="2025-07-10 00:20:08.276770193 +0000 UTC m=+20.127013190" lastFinishedPulling="2025-07-10 00:20:11.705360438 +0000 UTC m=+23.555603435" observedRunningTime="2025-07-10 00:20:11.859404697 +0000 UTC m=+23.709647694" watchObservedRunningTime="2025-07-10 00:20:11.85949316 +0000 UTC m=+23.709736157" Jul 10 00:20:12.678267 kubelet[1843]: E0710 00:20:12.678211 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:13.678716 kubelet[1843]: E0710 00:20:13.678619 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:14.679697 kubelet[1843]: E0710 00:20:14.679624 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:15.680311 kubelet[1843]: E0710 00:20:15.680264 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:16.680772 kubelet[1843]: E0710 00:20:16.680706 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:17.681781 kubelet[1843]: E0710 00:20:17.681722 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:18.682328 kubelet[1843]: E0710 00:20:18.682273 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:19.682703 kubelet[1843]: E0710 00:20:19.682629 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:20.683769 kubelet[1843]: E0710 00:20:20.683701 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:21.684211 kubelet[1843]: E0710 00:20:21.684141 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:21.756708 kubelet[1843]: I0710 00:20:21.756650 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-cd50c8d7-b852-4fd2-a0da-b866c93db6c2\" (UniqueName: \"kubernetes.io/nfs/4537f719-3477-4697-bdeb-af7a9a1fd899-pvc-cd50c8d7-b852-4fd2-a0da-b866c93db6c2\") pod \"test-pod-1\" (UID: \"4537f719-3477-4697-bdeb-af7a9a1fd899\") " pod="default/test-pod-1" Jul 10 00:20:21.756708 kubelet[1843]: I0710 00:20:21.756698 1843 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2c4tj\" (UniqueName: \"kubernetes.io/projected/4537f719-3477-4697-bdeb-af7a9a1fd899-kube-api-access-2c4tj\") pod \"test-pod-1\" (UID: \"4537f719-3477-4697-bdeb-af7a9a1fd899\") " pod="default/test-pod-1" Jul 10 00:20:21.877252 kernel: FS-Cache: Loaded Jul 10 00:20:21.902554 kernel: RPC: Registered named UNIX socket transport module. Jul 10 00:20:21.902651 kernel: RPC: Registered udp transport module. Jul 10 00:20:21.902672 kernel: RPC: Registered tcp transport module. Jul 10 00:20:21.902699 kernel: RPC: Registered tcp-with-tls transport module. Jul 10 00:20:21.903622 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jul 10 00:20:22.079400 kernel: NFS: Registering the id_resolver key type Jul 10 00:20:22.079520 kernel: Key type id_resolver registered Jul 10 00:20:22.079541 kernel: Key type id_legacy registered Jul 10 00:20:22.105626 nfsidmap[2882]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 10 00:20:22.108935 nfsidmap[2885]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 10 00:20:22.302468 containerd[1548]: time="2025-07-10T00:20:22.302423120Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4537f719-3477-4697-bdeb-af7a9a1fd899,Namespace:default,Attempt:0,}" Jul 10 00:20:22.318894 systemd-networkd[1235]: veth1fd1eb7c: Link UP Jul 10 00:20:22.321425 kernel: cni0: port 3(veth1fd1eb7c) entered blocking state Jul 10 00:20:22.321470 kernel: cni0: port 3(veth1fd1eb7c) entered disabled state Jul 10 00:20:22.321483 kernel: veth1fd1eb7c: entered allmulticast mode Jul 10 00:20:22.322323 kernel: veth1fd1eb7c: entered promiscuous mode Jul 10 00:20:22.328892 systemd-networkd[1235]: veth1fd1eb7c: Gained carrier Jul 10 00:20:22.329200 kernel: cni0: port 3(veth1fd1eb7c) entered blocking state Jul 10 00:20:22.329285 kernel: cni0: port 3(veth1fd1eb7c) entered forwarding state Jul 10 00:20:22.330295 containerd[1548]: 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)(0x400001a938), "name":"cbr0", "type":"bridge"} Jul 10 00:20:22.330295 containerd[1548]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:22.346380 containerd[1548]: {"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-07-10T00:20:22.345979431Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 10 00:20:22.346380 containerd[1548]: time="2025-07-10T00:20:22.346326718Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 10 00:20:22.346380 containerd[1548]: time="2025-07-10T00:20:22.346339557Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:22.346659 containerd[1548]: time="2025-07-10T00:20:22.346427829Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 10 00:20:22.368895 systemd-resolved[1441]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:22.385434 containerd[1548]: time="2025-07-10T00:20:22.385342740Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4537f719-3477-4697-bdeb-af7a9a1fd899,Namespace:default,Attempt:0,} returns sandbox id \"bf688a6c58ceb3900ff5f7d12bb28454d4ced3398f3dd81da24b7867cfb9c030\"" Jul 10 00:20:22.386881 containerd[1548]: time="2025-07-10T00:20:22.386855117Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 10 00:20:22.639114 containerd[1548]: time="2025-07-10T00:20:22.639004375Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:22.639621 containerd[1548]: time="2025-07-10T00:20:22.639590480Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jul 10 00:20:22.643033 containerd[1548]: time="2025-07-10T00:20:22.642997317Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:cd8b38a4e22587134e82fff3512a99b84799274d989a1ec20f58c7f8c89b8511\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"69964463\" in 256.107804ms" Jul 10 00:20:22.643033 containerd[1548]: time="2025-07-10T00:20:22.643032473Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:cd8b38a4e22587134e82fff3512a99b84799274d989a1ec20f58c7f8c89b8511\"" Jul 10 00:20:22.644796 containerd[1548]: time="2025-07-10T00:20:22.644758070Z" level=info msg="CreateContainer within sandbox \"bf688a6c58ceb3900ff5f7d12bb28454d4ced3398f3dd81da24b7867cfb9c030\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jul 10 00:20:22.654830 containerd[1548]: time="2025-07-10T00:20:22.654769321Z" level=info msg="CreateContainer within sandbox \"bf688a6c58ceb3900ff5f7d12bb28454d4ced3398f3dd81da24b7867cfb9c030\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"fd069aa4607d503e687a5385dab5c80ac264287dd1a175d164d10938d4649d1e\"" Jul 10 00:20:22.655369 containerd[1548]: time="2025-07-10T00:20:22.655326588Z" level=info msg="StartContainer for \"fd069aa4607d503e687a5385dab5c80ac264287dd1a175d164d10938d4649d1e\"" Jul 10 00:20:22.684531 kubelet[1843]: E0710 00:20:22.684481 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:22.695179 containerd[1548]: time="2025-07-10T00:20:22.695138174Z" level=info msg="StartContainer for \"fd069aa4607d503e687a5385dab5c80ac264287dd1a175d164d10938d4649d1e\" returns successfully" Jul 10 00:20:22.882526 kubelet[1843]: I0710 00:20:22.882463 1843 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=14.625379266 podStartE2EDuration="14.882446939s" podCreationTimestamp="2025-07-10 00:20:08 +0000 UTC" firstStartedPulling="2025-07-10 00:20:22.386574303 +0000 UTC m=+34.236817300" lastFinishedPulling="2025-07-10 00:20:22.643641976 +0000 UTC m=+34.493884973" observedRunningTime="2025-07-10 00:20:22.882282595 +0000 UTC m=+34.732525552" watchObservedRunningTime="2025-07-10 00:20:22.882446939 +0000 UTC m=+34.732689936" Jul 10 00:20:23.530351 systemd-networkd[1235]: veth1fd1eb7c: Gained IPv6LL Jul 10 00:20:23.684946 kubelet[1843]: E0710 00:20:23.684892 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:24.685343 kubelet[1843]: E0710 00:20:24.685274 1843 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"