Aug 12 23:33:07.801577 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 12 23:33:07.801599 kernel: Linux version 6.12.40-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Tue Aug 12 21:51:24 -00 2025 Aug 12 23:33:07.801608 kernel: KASLR enabled Aug 12 23:33:07.801614 kernel: efi: EFI v2.7 by EDK II Aug 12 23:33:07.801619 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Aug 12 23:33:07.801633 kernel: random: crng init done Aug 12 23:33:07.801640 kernel: secureboot: Secure boot disabled Aug 12 23:33:07.801646 kernel: ACPI: Early table checksum verification disabled Aug 12 23:33:07.801651 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Aug 12 23:33:07.801659 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 12 23:33:07.801665 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801671 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801676 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801682 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801689 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801697 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801703 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801709 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801715 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 12 23:33:07.801720 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 12 23:33:07.801726 kernel: ACPI: Use ACPI SPCR as default console: Yes Aug 12 23:33:07.801733 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 12 23:33:07.801739 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Aug 12 23:33:07.801744 kernel: Zone ranges: Aug 12 23:33:07.801750 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 12 23:33:07.801758 kernel: DMA32 empty Aug 12 23:33:07.801764 kernel: Normal empty Aug 12 23:33:07.801769 kernel: Device empty Aug 12 23:33:07.801775 kernel: Movable zone start for each node Aug 12 23:33:07.801781 kernel: Early memory node ranges Aug 12 23:33:07.801787 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Aug 12 23:33:07.801793 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Aug 12 23:33:07.801799 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Aug 12 23:33:07.801806 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Aug 12 23:33:07.801812 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Aug 12 23:33:07.801817 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Aug 12 23:33:07.801823 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Aug 12 23:33:07.801831 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Aug 12 23:33:07.801836 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Aug 12 23:33:07.801842 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 12 23:33:07.801851 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 12 23:33:07.801857 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 12 23:33:07.801864 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 12 23:33:07.801872 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 12 23:33:07.801878 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 12 23:33:07.801884 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Aug 12 23:33:07.801891 kernel: psci: probing for conduit method from ACPI. Aug 12 23:33:07.801897 kernel: psci: PSCIv1.1 detected in firmware. Aug 12 23:33:07.801903 kernel: psci: Using standard PSCI v0.2 function IDs Aug 12 23:33:07.801909 kernel: psci: Trusted OS migration not required Aug 12 23:33:07.801916 kernel: psci: SMC Calling Convention v1.1 Aug 12 23:33:07.801922 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 12 23:33:07.801929 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Aug 12 23:33:07.801936 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Aug 12 23:33:07.801943 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 12 23:33:07.801949 kernel: Detected PIPT I-cache on CPU0 Aug 12 23:33:07.801955 kernel: CPU features: detected: GIC system register CPU interface Aug 12 23:33:07.801962 kernel: CPU features: detected: Spectre-v4 Aug 12 23:33:07.801968 kernel: CPU features: detected: Spectre-BHB Aug 12 23:33:07.801974 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 12 23:33:07.801981 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 12 23:33:07.801987 kernel: CPU features: detected: ARM erratum 1418040 Aug 12 23:33:07.801993 kernel: CPU features: detected: SSBS not fully self-synchronizing Aug 12 23:33:07.801999 kernel: alternatives: applying boot alternatives Aug 12 23:33:07.802007 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=ce82f1ef836ba8581e59ce9db4eef4240d287b2b5f9937c28f0cd024f4dc9107 Aug 12 23:33:07.802015 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 12 23:33:07.802021 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 12 23:33:07.802028 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 12 23:33:07.802034 kernel: Fallback order for Node 0: 0 Aug 12 23:33:07.802040 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Aug 12 23:33:07.802047 kernel: Policy zone: DMA Aug 12 23:33:07.802053 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 12 23:33:07.802059 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Aug 12 23:33:07.802066 kernel: software IO TLB: area num 4. Aug 12 23:33:07.802072 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Aug 12 23:33:07.802079 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Aug 12 23:33:07.802087 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 12 23:33:07.802093 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 12 23:33:07.802100 kernel: rcu: RCU event tracing is enabled. Aug 12 23:33:07.802107 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 12 23:33:07.802113 kernel: Trampoline variant of Tasks RCU enabled. Aug 12 23:33:07.802120 kernel: Tracing variant of Tasks RCU enabled. Aug 12 23:33:07.802127 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 12 23:33:07.802133 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 12 23:33:07.802139 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 12 23:33:07.802146 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 12 23:33:07.802152 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 12 23:33:07.802160 kernel: GICv3: 256 SPIs implemented Aug 12 23:33:07.802167 kernel: GICv3: 0 Extended SPIs implemented Aug 12 23:33:07.802173 kernel: Root IRQ handler: gic_handle_irq Aug 12 23:33:07.802179 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 12 23:33:07.802185 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Aug 12 23:33:07.802192 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 12 23:33:07.802198 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 12 23:33:07.802204 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Aug 12 23:33:07.802211 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Aug 12 23:33:07.802217 kernel: GICv3: using LPI property table @0x0000000040130000 Aug 12 23:33:07.802224 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Aug 12 23:33:07.802230 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 12 23:33:07.802238 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 12 23:33:07.802244 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 12 23:33:07.802251 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 12 23:33:07.802257 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 12 23:33:07.802263 kernel: arm-pv: using stolen time PV Aug 12 23:33:07.802270 kernel: Console: colour dummy device 80x25 Aug 12 23:33:07.802277 kernel: ACPI: Core revision 20240827 Aug 12 23:33:07.802284 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 12 23:33:07.802291 kernel: pid_max: default: 32768 minimum: 301 Aug 12 23:33:07.802297 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Aug 12 23:33:07.802305 kernel: landlock: Up and running. Aug 12 23:33:07.802311 kernel: SELinux: Initializing. Aug 12 23:33:07.802318 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 12 23:33:07.802324 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 12 23:33:07.802331 kernel: rcu: Hierarchical SRCU implementation. Aug 12 23:33:07.802338 kernel: rcu: Max phase no-delay instances is 400. Aug 12 23:33:07.802344 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Aug 12 23:33:07.802351 kernel: Remapping and enabling EFI services. Aug 12 23:33:07.802369 kernel: smp: Bringing up secondary CPUs ... Aug 12 23:33:07.802383 kernel: Detected PIPT I-cache on CPU1 Aug 12 23:33:07.802390 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 12 23:33:07.802397 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Aug 12 23:33:07.802406 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 12 23:33:07.802412 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 12 23:33:07.802419 kernel: Detected PIPT I-cache on CPU2 Aug 12 23:33:07.802426 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 12 23:33:07.802433 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Aug 12 23:33:07.802442 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 12 23:33:07.802448 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 12 23:33:07.802455 kernel: Detected PIPT I-cache on CPU3 Aug 12 23:33:07.802462 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 12 23:33:07.802469 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Aug 12 23:33:07.802476 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 12 23:33:07.802483 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 12 23:33:07.802490 kernel: smp: Brought up 1 node, 4 CPUs Aug 12 23:33:07.802496 kernel: SMP: Total of 4 processors activated. Aug 12 23:33:07.802505 kernel: CPU: All CPU(s) started at EL1 Aug 12 23:33:07.802512 kernel: CPU features: detected: 32-bit EL0 Support Aug 12 23:33:07.802518 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 12 23:33:07.802526 kernel: CPU features: detected: Common not Private translations Aug 12 23:33:07.802532 kernel: CPU features: detected: CRC32 instructions Aug 12 23:33:07.802539 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 12 23:33:07.802546 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 12 23:33:07.802553 kernel: CPU features: detected: LSE atomic instructions Aug 12 23:33:07.802560 kernel: CPU features: detected: Privileged Access Never Aug 12 23:33:07.802568 kernel: CPU features: detected: RAS Extension Support Aug 12 23:33:07.802575 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 12 23:33:07.802582 kernel: alternatives: applying system-wide alternatives Aug 12 23:33:07.802589 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Aug 12 23:33:07.802596 kernel: Memory: 2423968K/2572288K available (11136K kernel code, 2436K rwdata, 9080K rodata, 39488K init, 1038K bss, 125984K reserved, 16384K cma-reserved) Aug 12 23:33:07.802603 kernel: devtmpfs: initialized Aug 12 23:33:07.802610 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 12 23:33:07.802617 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 12 23:33:07.802632 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 12 23:33:07.802642 kernel: 0 pages in range for non-PLT usage Aug 12 23:33:07.802649 kernel: 508432 pages in range for PLT usage Aug 12 23:33:07.802655 kernel: pinctrl core: initialized pinctrl subsystem Aug 12 23:33:07.802662 kernel: SMBIOS 3.0.0 present. Aug 12 23:33:07.802669 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Aug 12 23:33:07.802676 kernel: DMI: Memory slots populated: 1/1 Aug 12 23:33:07.802682 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 12 23:33:07.802689 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 12 23:33:07.802696 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 12 23:33:07.802705 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 12 23:33:07.802712 kernel: audit: initializing netlink subsys (disabled) Aug 12 23:33:07.802719 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Aug 12 23:33:07.802726 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 12 23:33:07.802733 kernel: cpuidle: using governor menu Aug 12 23:33:07.802740 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 12 23:33:07.802746 kernel: ASID allocator initialised with 32768 entries Aug 12 23:33:07.802753 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 12 23:33:07.802760 kernel: Serial: AMBA PL011 UART driver Aug 12 23:33:07.802768 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 12 23:33:07.802775 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 12 23:33:07.802782 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 12 23:33:07.802789 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 12 23:33:07.802796 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 12 23:33:07.802803 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 12 23:33:07.802810 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 12 23:33:07.802817 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 12 23:33:07.802823 kernel: ACPI: Added _OSI(Module Device) Aug 12 23:33:07.802832 kernel: ACPI: Added _OSI(Processor Device) Aug 12 23:33:07.802839 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 12 23:33:07.802846 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 12 23:33:07.802853 kernel: ACPI: Interpreter enabled Aug 12 23:33:07.802859 kernel: ACPI: Using GIC for interrupt routing Aug 12 23:33:07.802866 kernel: ACPI: MCFG table detected, 1 entries Aug 12 23:33:07.802873 kernel: ACPI: CPU0 has been hot-added Aug 12 23:33:07.802880 kernel: ACPI: CPU1 has been hot-added Aug 12 23:33:07.802886 kernel: ACPI: CPU2 has been hot-added Aug 12 23:33:07.802893 kernel: ACPI: CPU3 has been hot-added Aug 12 23:33:07.802901 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 12 23:33:07.802908 kernel: printk: legacy console [ttyAMA0] enabled Aug 12 23:33:07.802915 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 12 23:33:07.803060 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 12 23:33:07.803124 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 12 23:33:07.803181 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 12 23:33:07.803237 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 12 23:33:07.803295 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 12 23:33:07.803304 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 12 23:33:07.803311 kernel: PCI host bridge to bus 0000:00 Aug 12 23:33:07.803392 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 12 23:33:07.803449 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 12 23:33:07.803501 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 12 23:33:07.803551 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 12 23:33:07.803642 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Aug 12 23:33:07.803721 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Aug 12 23:33:07.803783 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Aug 12 23:33:07.803842 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Aug 12 23:33:07.803900 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Aug 12 23:33:07.803958 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Aug 12 23:33:07.804016 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Aug 12 23:33:07.804078 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Aug 12 23:33:07.804131 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 12 23:33:07.804183 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 12 23:33:07.804236 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 12 23:33:07.804245 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 12 23:33:07.804252 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 12 23:33:07.804259 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 12 23:33:07.804268 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 12 23:33:07.804275 kernel: iommu: Default domain type: Translated Aug 12 23:33:07.804282 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 12 23:33:07.804289 kernel: efivars: Registered efivars operations Aug 12 23:33:07.804296 kernel: vgaarb: loaded Aug 12 23:33:07.804303 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 12 23:33:07.804310 kernel: VFS: Disk quotas dquot_6.6.0 Aug 12 23:33:07.804317 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 12 23:33:07.804323 kernel: pnp: PnP ACPI init Aug 12 23:33:07.804406 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 12 23:33:07.804417 kernel: pnp: PnP ACPI: found 1 devices Aug 12 23:33:07.804425 kernel: NET: Registered PF_INET protocol family Aug 12 23:33:07.804432 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 12 23:33:07.804439 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 12 23:33:07.804446 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 12 23:33:07.804453 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 12 23:33:07.804460 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 12 23:33:07.804469 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 12 23:33:07.804477 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 12 23:33:07.804484 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 12 23:33:07.804491 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 12 23:33:07.804498 kernel: PCI: CLS 0 bytes, default 64 Aug 12 23:33:07.804505 kernel: kvm [1]: HYP mode not available Aug 12 23:33:07.804512 kernel: Initialise system trusted keyrings Aug 12 23:33:07.804519 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 12 23:33:07.804526 kernel: Key type asymmetric registered Aug 12 23:33:07.804534 kernel: Asymmetric key parser 'x509' registered Aug 12 23:33:07.804541 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Aug 12 23:33:07.804548 kernel: io scheduler mq-deadline registered Aug 12 23:33:07.804555 kernel: io scheduler kyber registered Aug 12 23:33:07.804563 kernel: io scheduler bfq registered Aug 12 23:33:07.804569 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 12 23:33:07.804576 kernel: ACPI: button: Power Button [PWRB] Aug 12 23:33:07.804584 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 12 23:33:07.804654 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 12 23:33:07.804666 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 12 23:33:07.804673 kernel: thunder_xcv, ver 1.0 Aug 12 23:33:07.804680 kernel: thunder_bgx, ver 1.0 Aug 12 23:33:07.804687 kernel: nicpf, ver 1.0 Aug 12 23:33:07.804694 kernel: nicvf, ver 1.0 Aug 12 23:33:07.804761 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 12 23:33:07.804816 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-12T23:33:07 UTC (1755041587) Aug 12 23:33:07.804826 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 12 23:33:07.804835 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Aug 12 23:33:07.804842 kernel: watchdog: NMI not fully supported Aug 12 23:33:07.804848 kernel: watchdog: Hard watchdog permanently disabled Aug 12 23:33:07.804855 kernel: NET: Registered PF_INET6 protocol family Aug 12 23:33:07.804862 kernel: Segment Routing with IPv6 Aug 12 23:33:07.804869 kernel: In-situ OAM (IOAM) with IPv6 Aug 12 23:33:07.804876 kernel: NET: Registered PF_PACKET protocol family Aug 12 23:33:07.804883 kernel: Key type dns_resolver registered Aug 12 23:33:07.804890 kernel: registered taskstats version 1 Aug 12 23:33:07.804897 kernel: Loading compiled-in X.509 certificates Aug 12 23:33:07.804905 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.40-flatcar: e74bfacfa68399ed7282bf533dd5901fdb84b882' Aug 12 23:33:07.804912 kernel: Demotion targets for Node 0: null Aug 12 23:33:07.804919 kernel: Key type .fscrypt registered Aug 12 23:33:07.804926 kernel: Key type fscrypt-provisioning registered Aug 12 23:33:07.804933 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 12 23:33:07.804939 kernel: ima: Allocated hash algorithm: sha1 Aug 12 23:33:07.804946 kernel: ima: No architecture policies found Aug 12 23:33:07.804953 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 12 23:33:07.804962 kernel: clk: Disabling unused clocks Aug 12 23:33:07.804969 kernel: PM: genpd: Disabling unused power domains Aug 12 23:33:07.804976 kernel: Warning: unable to open an initial console. Aug 12 23:33:07.804983 kernel: Freeing unused kernel memory: 39488K Aug 12 23:33:07.804990 kernel: Run /init as init process Aug 12 23:33:07.804997 kernel: with arguments: Aug 12 23:33:07.805004 kernel: /init Aug 12 23:33:07.805011 kernel: with environment: Aug 12 23:33:07.805017 kernel: HOME=/ Aug 12 23:33:07.805026 kernel: TERM=linux Aug 12 23:33:07.805033 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 12 23:33:07.805041 systemd[1]: Successfully made /usr/ read-only. Aug 12 23:33:07.805051 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Aug 12 23:33:07.805059 systemd[1]: Detected virtualization kvm. Aug 12 23:33:07.805066 systemd[1]: Detected architecture arm64. Aug 12 23:33:07.805073 systemd[1]: Running in initrd. Aug 12 23:33:07.805080 systemd[1]: No hostname configured, using default hostname. Aug 12 23:33:07.805089 systemd[1]: Hostname set to . Aug 12 23:33:07.805096 systemd[1]: Initializing machine ID from VM UUID. Aug 12 23:33:07.805104 systemd[1]: Queued start job for default target initrd.target. Aug 12 23:33:07.805111 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 12 23:33:07.805119 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 12 23:33:07.805126 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 12 23:33:07.805134 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 12 23:33:07.805142 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 12 23:33:07.805152 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 12 23:33:07.805160 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 12 23:33:07.805168 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 12 23:33:07.805175 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 12 23:33:07.805183 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 12 23:33:07.805190 systemd[1]: Reached target paths.target - Path Units. Aug 12 23:33:07.805198 systemd[1]: Reached target slices.target - Slice Units. Aug 12 23:33:07.805206 systemd[1]: Reached target swap.target - Swaps. Aug 12 23:33:07.805214 systemd[1]: Reached target timers.target - Timer Units. Aug 12 23:33:07.805221 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 12 23:33:07.805229 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 12 23:33:07.805236 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 12 23:33:07.805243 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Aug 12 23:33:07.805251 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 12 23:33:07.805259 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 12 23:33:07.805268 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 12 23:33:07.805275 systemd[1]: Reached target sockets.target - Socket Units. Aug 12 23:33:07.805283 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 12 23:33:07.805290 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 12 23:33:07.805297 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 12 23:33:07.805306 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Aug 12 23:33:07.805313 systemd[1]: Starting systemd-fsck-usr.service... Aug 12 23:33:07.805321 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 12 23:33:07.805328 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 12 23:33:07.805337 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 12 23:33:07.805345 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 12 23:33:07.805353 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 12 23:33:07.805439 systemd[1]: Finished systemd-fsck-usr.service. Aug 12 23:33:07.805450 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 12 23:33:07.805479 systemd-journald[244]: Collecting audit messages is disabled. Aug 12 23:33:07.805499 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 12 23:33:07.805508 systemd-journald[244]: Journal started Aug 12 23:33:07.805529 systemd-journald[244]: Runtime Journal (/run/log/journal/6c5f0cd962e04896bdc4d7dd235bdb06) is 6M, max 48.5M, 42.4M free. Aug 12 23:33:07.792650 systemd-modules-load[245]: Inserted module 'overlay' Aug 12 23:33:07.807395 systemd[1]: Started systemd-journald.service - Journal Service. Aug 12 23:33:07.808510 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 12 23:33:07.812038 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 12 23:33:07.814525 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 12 23:33:07.815503 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 12 23:33:07.817523 systemd-modules-load[245]: Inserted module 'br_netfilter' Aug 12 23:33:07.818395 kernel: Bridge firewalling registered Aug 12 23:33:07.824104 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 12 23:33:07.825475 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 12 23:33:07.828261 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 12 23:33:07.833457 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 12 23:33:07.835310 systemd-tmpfiles[270]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Aug 12 23:33:07.838325 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 12 23:33:07.840638 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 12 23:33:07.842992 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 12 23:33:07.845429 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 12 23:33:07.847485 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 12 23:33:07.871746 dracut-cmdline[292]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=ce82f1ef836ba8581e59ce9db4eef4240d287b2b5f9937c28f0cd024f4dc9107 Aug 12 23:33:07.886523 systemd-resolved[291]: Positive Trust Anchors: Aug 12 23:33:07.886544 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 12 23:33:07.886575 systemd-resolved[291]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Aug 12 23:33:07.891496 systemd-resolved[291]: Defaulting to hostname 'linux'. Aug 12 23:33:07.892580 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 12 23:33:07.893453 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 12 23:33:07.952392 kernel: SCSI subsystem initialized Aug 12 23:33:07.956389 kernel: Loading iSCSI transport class v2.0-870. Aug 12 23:33:07.964386 kernel: iscsi: registered transport (tcp) Aug 12 23:33:07.977409 kernel: iscsi: registered transport (qla4xxx) Aug 12 23:33:07.977449 kernel: QLogic iSCSI HBA Driver Aug 12 23:33:07.994394 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 12 23:33:08.011326 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 12 23:33:08.013868 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 12 23:33:08.061104 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 12 23:33:08.063322 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 12 23:33:08.134396 kernel: raid6: neonx8 gen() 15791 MB/s Aug 12 23:33:08.151387 kernel: raid6: neonx4 gen() 15817 MB/s Aug 12 23:33:08.168383 kernel: raid6: neonx2 gen() 13236 MB/s Aug 12 23:33:08.185376 kernel: raid6: neonx1 gen() 10457 MB/s Aug 12 23:33:08.202382 kernel: raid6: int64x8 gen() 6895 MB/s Aug 12 23:33:08.219378 kernel: raid6: int64x4 gen() 7347 MB/s Aug 12 23:33:08.236377 kernel: raid6: int64x2 gen() 6102 MB/s Aug 12 23:33:08.253384 kernel: raid6: int64x1 gen() 5049 MB/s Aug 12 23:33:08.253399 kernel: raid6: using algorithm neonx4 gen() 15817 MB/s Aug 12 23:33:08.270381 kernel: raid6: .... xor() 12333 MB/s, rmw enabled Aug 12 23:33:08.270397 kernel: raid6: using neon recovery algorithm Aug 12 23:33:08.275387 kernel: xor: measuring software checksum speed Aug 12 23:33:08.275403 kernel: 8regs : 21641 MB/sec Aug 12 23:33:08.276815 kernel: 32regs : 21693 MB/sec Aug 12 23:33:08.276832 kernel: arm64_neon : 28013 MB/sec Aug 12 23:33:08.276841 kernel: xor: using function: arm64_neon (28013 MB/sec) Aug 12 23:33:08.333429 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 12 23:33:08.340247 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 12 23:33:08.342748 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 12 23:33:08.373168 systemd-udevd[500]: Using default interface naming scheme 'v255'. Aug 12 23:33:08.377723 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 12 23:33:08.379486 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 12 23:33:08.415575 dracut-pre-trigger[507]: rd.md=0: removing MD RAID activation Aug 12 23:33:08.440219 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 12 23:33:08.442456 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 12 23:33:08.494120 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 12 23:33:08.497450 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 12 23:33:08.541381 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 12 23:33:08.543381 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 12 23:33:08.547715 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 12 23:33:08.547736 kernel: GPT:9289727 != 19775487 Aug 12 23:33:08.547745 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 12 23:33:08.547754 kernel: GPT:9289727 != 19775487 Aug 12 23:33:08.547762 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 12 23:33:08.547771 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 12 23:33:08.555919 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 12 23:33:08.556045 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 12 23:33:08.559461 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 12 23:33:08.561224 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 12 23:33:08.585736 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 12 23:33:08.593711 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 12 23:33:08.594938 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 12 23:33:08.604673 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 12 23:33:08.612110 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 12 23:33:08.618147 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 12 23:33:08.619070 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 12 23:33:08.621312 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 12 23:33:08.622936 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 12 23:33:08.624449 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 12 23:33:08.626674 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 12 23:33:08.628279 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 12 23:33:08.657677 disk-uuid[592]: Primary Header is updated. Aug 12 23:33:08.657677 disk-uuid[592]: Secondary Entries is updated. Aug 12 23:33:08.657677 disk-uuid[592]: Secondary Header is updated. Aug 12 23:33:08.661390 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 12 23:33:08.662838 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 12 23:33:09.680393 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 12 23:33:09.680829 disk-uuid[597]: The operation has completed successfully. Aug 12 23:33:09.703354 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 12 23:33:09.703468 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 12 23:33:09.734493 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 12 23:33:09.759513 sh[612]: Success Aug 12 23:33:09.773373 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 12 23:33:09.773433 kernel: device-mapper: uevent: version 1.0.3 Aug 12 23:33:09.776383 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Aug 12 23:33:09.786434 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Aug 12 23:33:09.815430 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 12 23:33:09.817315 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 12 23:33:09.830409 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 12 23:33:09.836080 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Aug 12 23:33:09.836135 kernel: BTRFS: device fsid 7658cdd8-2ee4-4f84-82be-1f808605c89c devid 1 transid 42 /dev/mapper/usr (253:0) scanned by mount (624) Aug 12 23:33:09.836430 kernel: BTRFS info (device dm-0): first mount of filesystem 7658cdd8-2ee4-4f84-82be-1f808605c89c Aug 12 23:33:09.837818 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 12 23:33:09.837836 kernel: BTRFS info (device dm-0): using free-space-tree Aug 12 23:33:09.841894 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 12 23:33:09.843013 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Aug 12 23:33:09.843923 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 12 23:33:09.844791 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 12 23:33:09.847255 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 12 23:33:09.877379 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (657) Aug 12 23:33:09.879675 kernel: BTRFS info (device vda6): first mount of filesystem cff59a55-3bd9-4c36-9f7f-aabedbf210fb Aug 12 23:33:09.879778 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 12 23:33:09.879815 kernel: BTRFS info (device vda6): using free-space-tree Aug 12 23:33:09.885376 kernel: BTRFS info (device vda6): last unmount of filesystem cff59a55-3bd9-4c36-9f7f-aabedbf210fb Aug 12 23:33:09.885726 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 12 23:33:09.887988 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 12 23:33:09.961576 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 12 23:33:09.964186 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 12 23:33:10.012453 systemd-networkd[800]: lo: Link UP Aug 12 23:33:10.012465 systemd-networkd[800]: lo: Gained carrier Aug 12 23:33:10.013238 systemd-networkd[800]: Enumeration completed Aug 12 23:33:10.013345 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 12 23:33:10.014280 systemd[1]: Reached target network.target - Network. Aug 12 23:33:10.015892 systemd-networkd[800]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 12 23:33:10.015896 systemd-networkd[800]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 12 23:33:10.016406 systemd-networkd[800]: eth0: Link UP Aug 12 23:33:10.016748 systemd-networkd[800]: eth0: Gained carrier Aug 12 23:33:10.016759 systemd-networkd[800]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 12 23:33:10.025891 ignition[700]: Ignition 2.21.0 Aug 12 23:33:10.025904 ignition[700]: Stage: fetch-offline Aug 12 23:33:10.026436 systemd-networkd[800]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 12 23:33:10.025945 ignition[700]: no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:10.025957 ignition[700]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:10.026159 ignition[700]: parsed url from cmdline: "" Aug 12 23:33:10.026163 ignition[700]: no config URL provided Aug 12 23:33:10.026167 ignition[700]: reading system config file "/usr/lib/ignition/user.ign" Aug 12 23:33:10.026174 ignition[700]: no config at "/usr/lib/ignition/user.ign" Aug 12 23:33:10.026199 ignition[700]: op(1): [started] loading QEMU firmware config module Aug 12 23:33:10.026204 ignition[700]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 12 23:33:10.038349 ignition[700]: op(1): [finished] loading QEMU firmware config module Aug 12 23:33:10.044157 ignition[700]: parsing config with SHA512: 9c7e39b09d6ac8bd382777dd67e89bf2bd5b919a642f046dc7172307336c17b8a01ef842a085b72b01b9f5ac7af22b7a3909fcbd449874bc0e1ebec73bd8f5cf Aug 12 23:33:10.047258 unknown[700]: fetched base config from "system" Aug 12 23:33:10.047270 unknown[700]: fetched user config from "qemu" Aug 12 23:33:10.047550 ignition[700]: fetch-offline: fetch-offline passed Aug 12 23:33:10.048949 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 12 23:33:10.047608 ignition[700]: Ignition finished successfully Aug 12 23:33:10.050551 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 12 23:33:10.051517 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 12 23:33:10.097211 ignition[812]: Ignition 2.21.0 Aug 12 23:33:10.097231 ignition[812]: Stage: kargs Aug 12 23:33:10.097409 ignition[812]: no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:10.097418 ignition[812]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:10.098790 ignition[812]: kargs: kargs passed Aug 12 23:33:10.099328 ignition[812]: Ignition finished successfully Aug 12 23:33:10.101766 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 12 23:33:10.103660 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 12 23:33:10.138408 ignition[820]: Ignition 2.21.0 Aug 12 23:33:10.138426 ignition[820]: Stage: disks Aug 12 23:33:10.138578 ignition[820]: no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:10.138587 ignition[820]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:10.140105 ignition[820]: disks: disks passed Aug 12 23:33:10.140165 ignition[820]: Ignition finished successfully Aug 12 23:33:10.141773 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 12 23:33:10.142863 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 12 23:33:10.144015 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 12 23:33:10.145568 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 12 23:33:10.146936 systemd[1]: Reached target sysinit.target - System Initialization. Aug 12 23:33:10.148162 systemd[1]: Reached target basic.target - Basic System. Aug 12 23:33:10.150390 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 12 23:33:10.181930 systemd-resolved[291]: Detected conflict on linux IN A 10.0.0.17 Aug 12 23:33:10.181942 systemd-resolved[291]: Hostname conflict, changing published hostname from 'linux' to 'linux6'. Aug 12 23:33:10.184228 systemd-fsck[830]: ROOT: clean, 15/553520 files, 52789/553472 blocks Aug 12 23:33:10.187837 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 12 23:33:10.191122 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 12 23:33:10.263379 kernel: EXT4-fs (vda9): mounted filesystem d634334e-91a3-4b77-89ab-775bdd78a572 r/w with ordered data mode. Quota mode: none. Aug 12 23:33:10.263891 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 12 23:33:10.265025 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 12 23:33:10.267126 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 12 23:33:10.268759 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 12 23:33:10.269570 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 12 23:33:10.269624 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 12 23:33:10.269653 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 12 23:33:10.288531 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 12 23:33:10.291509 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 12 23:33:10.294770 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (838) Aug 12 23:33:10.294795 kernel: BTRFS info (device vda6): first mount of filesystem cff59a55-3bd9-4c36-9f7f-aabedbf210fb Aug 12 23:33:10.294805 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 12 23:33:10.295393 kernel: BTRFS info (device vda6): using free-space-tree Aug 12 23:33:10.298408 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 12 23:33:10.337108 initrd-setup-root[862]: cut: /sysroot/etc/passwd: No such file or directory Aug 12 23:33:10.340290 initrd-setup-root[869]: cut: /sysroot/etc/group: No such file or directory Aug 12 23:33:10.343747 initrd-setup-root[876]: cut: /sysroot/etc/shadow: No such file or directory Aug 12 23:33:10.346776 initrd-setup-root[883]: cut: /sysroot/etc/gshadow: No such file or directory Aug 12 23:33:10.422030 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 12 23:33:10.423927 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 12 23:33:10.425389 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 12 23:33:10.441387 kernel: BTRFS info (device vda6): last unmount of filesystem cff59a55-3bd9-4c36-9f7f-aabedbf210fb Aug 12 23:33:10.456498 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 12 23:33:10.469294 ignition[952]: INFO : Ignition 2.21.0 Aug 12 23:33:10.469294 ignition[952]: INFO : Stage: mount Aug 12 23:33:10.470600 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:10.470600 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:10.470600 ignition[952]: INFO : mount: mount passed Aug 12 23:33:10.470600 ignition[952]: INFO : Ignition finished successfully Aug 12 23:33:10.472052 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 12 23:33:10.475133 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 12 23:33:10.835575 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 12 23:33:10.837149 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 12 23:33:10.855132 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (965) Aug 12 23:33:10.855179 kernel: BTRFS info (device vda6): first mount of filesystem cff59a55-3bd9-4c36-9f7f-aabedbf210fb Aug 12 23:33:10.855189 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 12 23:33:10.856364 kernel: BTRFS info (device vda6): using free-space-tree Aug 12 23:33:10.859099 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 12 23:33:10.889427 ignition[983]: INFO : Ignition 2.21.0 Aug 12 23:33:10.889427 ignition[983]: INFO : Stage: files Aug 12 23:33:10.891338 ignition[983]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:10.891338 ignition[983]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:10.891338 ignition[983]: DEBUG : files: compiled without relabeling support, skipping Aug 12 23:33:10.894047 ignition[983]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 12 23:33:10.894047 ignition[983]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 12 23:33:10.896570 ignition[983]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 12 23:33:10.897529 ignition[983]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 12 23:33:10.897529 ignition[983]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 12 23:33:10.897170 unknown[983]: wrote ssh authorized keys file for user: core Aug 12 23:33:10.900324 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Aug 12 23:33:10.900324 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Aug 12 23:33:10.903133 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 12 23:33:10.904472 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 12 23:33:10.904472 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 12 23:33:10.907618 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 12 23:33:10.909546 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 12 23:33:10.909546 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-arm64.raw: attempt #1 Aug 12 23:33:11.207608 systemd-networkd[800]: eth0: Gained IPv6LL Aug 12 23:33:11.223226 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Aug 12 23:33:11.586569 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 12 23:33:11.586569 ignition[983]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Aug 12 23:33:11.589332 ignition[983]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 12 23:33:11.590794 ignition[983]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 12 23:33:11.590794 ignition[983]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Aug 12 23:33:11.590794 ignition[983]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Aug 12 23:33:11.608329 ignition[983]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 12 23:33:11.611979 ignition[983]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 12 23:33:11.614299 ignition[983]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Aug 12 23:33:11.614299 ignition[983]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 12 23:33:11.614299 ignition[983]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 12 23:33:11.614299 ignition[983]: INFO : files: files passed Aug 12 23:33:11.614299 ignition[983]: INFO : Ignition finished successfully Aug 12 23:33:11.615065 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 12 23:33:11.617299 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 12 23:33:11.621570 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 12 23:33:11.643800 initrd-setup-root-after-ignition[1010]: grep: /sysroot/oem/oem-release: No such file or directory Aug 12 23:33:11.644961 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 12 23:33:11.645070 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 12 23:33:11.648301 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 12 23:33:11.648301 initrd-setup-root-after-ignition[1014]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 12 23:33:11.651440 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 12 23:33:11.652523 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 12 23:33:11.653774 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 12 23:33:11.656030 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 12 23:33:11.699079 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 12 23:33:11.699202 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 12 23:33:11.700888 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 12 23:33:11.702076 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 12 23:33:11.703387 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 12 23:33:11.704281 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 12 23:33:11.735435 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 12 23:33:11.737774 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 12 23:33:11.759956 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 12 23:33:11.761838 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 12 23:33:11.762955 systemd[1]: Stopped target timers.target - Timer Units. Aug 12 23:33:11.764352 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 12 23:33:11.764501 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 12 23:33:11.766478 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 12 23:33:11.768052 systemd[1]: Stopped target basic.target - Basic System. Aug 12 23:33:11.769308 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 12 23:33:11.770658 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 12 23:33:11.772160 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 12 23:33:11.773714 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Aug 12 23:33:11.775217 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 12 23:33:11.776711 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 12 23:33:11.778242 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 12 23:33:11.779741 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 12 23:33:11.781106 systemd[1]: Stopped target swap.target - Swaps. Aug 12 23:33:11.782285 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 12 23:33:11.782442 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 12 23:33:11.784222 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 12 23:33:11.785644 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 12 23:33:11.787022 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 12 23:33:11.790428 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 12 23:33:11.791410 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 12 23:33:11.791548 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 12 23:33:11.793548 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 12 23:33:11.793676 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 12 23:33:11.795114 systemd[1]: Stopped target paths.target - Path Units. Aug 12 23:33:11.796215 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 12 23:33:11.799426 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 12 23:33:11.800398 systemd[1]: Stopped target slices.target - Slice Units. Aug 12 23:33:11.801938 systemd[1]: Stopped target sockets.target - Socket Units. Aug 12 23:33:11.803112 systemd[1]: iscsid.socket: Deactivated successfully. Aug 12 23:33:11.803214 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 12 23:33:11.804412 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 12 23:33:11.804491 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 12 23:33:11.805603 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 12 23:33:11.805863 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 12 23:33:11.807169 systemd[1]: ignition-files.service: Deactivated successfully. Aug 12 23:33:11.807280 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 12 23:33:11.809239 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 12 23:33:11.811380 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 12 23:33:11.812707 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 12 23:33:11.812830 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 12 23:33:11.814397 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 12 23:33:11.814504 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 12 23:33:11.823517 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 12 23:33:11.823639 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 12 23:33:11.830801 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 12 23:33:11.835710 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 12 23:33:11.835819 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 12 23:33:11.838052 ignition[1038]: INFO : Ignition 2.21.0 Aug 12 23:33:11.838052 ignition[1038]: INFO : Stage: umount Aug 12 23:33:11.838052 ignition[1038]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 12 23:33:11.838052 ignition[1038]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 12 23:33:11.838052 ignition[1038]: INFO : umount: umount passed Aug 12 23:33:11.838052 ignition[1038]: INFO : Ignition finished successfully Aug 12 23:33:11.839567 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 12 23:33:11.839689 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 12 23:33:11.841012 systemd[1]: Stopped target network.target - Network. Aug 12 23:33:11.842269 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 12 23:33:11.842337 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 12 23:33:11.843265 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 12 23:33:11.843312 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 12 23:33:11.844437 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 12 23:33:11.844484 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 12 23:33:11.845764 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 12 23:33:11.845803 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 12 23:33:11.847213 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 12 23:33:11.847261 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 12 23:33:11.848838 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 12 23:33:11.849930 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 12 23:33:11.854072 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 12 23:33:11.854213 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 12 23:33:11.857850 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Aug 12 23:33:11.858128 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 12 23:33:11.858169 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 12 23:33:11.861555 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Aug 12 23:33:11.861854 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 12 23:33:11.861986 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 12 23:33:11.866274 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Aug 12 23:33:11.866759 systemd[1]: Stopped target network-pre.target - Preparation for Network. Aug 12 23:33:11.868422 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 12 23:33:11.868475 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 12 23:33:11.870951 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 12 23:33:11.872166 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 12 23:33:11.872230 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 12 23:33:11.873788 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 12 23:33:11.873833 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 12 23:33:11.875880 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 12 23:33:11.875923 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 12 23:33:11.877347 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 12 23:33:11.880582 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Aug 12 23:33:11.889272 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 12 23:33:11.891674 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 12 23:33:11.894222 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 12 23:33:11.894290 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 12 23:33:11.896273 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 12 23:33:11.896314 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 12 23:33:11.897767 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 12 23:33:11.897821 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 12 23:33:11.899920 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 12 23:33:11.899971 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 12 23:33:11.902078 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 12 23:33:11.902136 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 12 23:33:11.905209 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 12 23:33:11.906692 systemd[1]: systemd-network-generator.service: Deactivated successfully. Aug 12 23:33:11.906760 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Aug 12 23:33:11.909009 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 12 23:33:11.909062 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 12 23:33:11.911574 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 12 23:33:11.911631 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 12 23:33:11.914063 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 12 23:33:11.914106 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 12 23:33:11.916177 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 12 23:33:11.916223 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 12 23:33:11.919712 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Aug 12 23:33:11.919772 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev\x2dearly.service.mount: Deactivated successfully. Aug 12 23:33:11.919802 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Aug 12 23:33:11.919834 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 12 23:33:11.920153 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 12 23:33:11.920241 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 12 23:33:11.922240 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 12 23:33:11.922328 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 12 23:33:11.924702 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 12 23:33:11.926680 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 12 23:33:11.943580 systemd[1]: Switching root. Aug 12 23:33:11.970619 systemd-journald[244]: Journal stopped Aug 12 23:33:12.757894 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Aug 12 23:33:12.757946 kernel: SELinux: policy capability network_peer_controls=1 Aug 12 23:33:12.757963 kernel: SELinux: policy capability open_perms=1 Aug 12 23:33:12.757972 kernel: SELinux: policy capability extended_socket_class=1 Aug 12 23:33:12.757986 kernel: SELinux: policy capability always_check_network=0 Aug 12 23:33:12.757997 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 12 23:33:12.758011 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 12 23:33:12.758020 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 12 23:33:12.758030 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 12 23:33:12.758040 kernel: SELinux: policy capability userspace_initial_context=0 Aug 12 23:33:12.758049 kernel: audit: type=1403 audit(1755041592.138:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 12 23:33:12.758064 systemd[1]: Successfully loaded SELinux policy in 52.478ms. Aug 12 23:33:12.758081 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 10.223ms. Aug 12 23:33:12.758093 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Aug 12 23:33:12.758105 systemd[1]: Detected virtualization kvm. Aug 12 23:33:12.758116 systemd[1]: Detected architecture arm64. Aug 12 23:33:12.758127 systemd[1]: Detected first boot. Aug 12 23:33:12.758137 systemd[1]: Initializing machine ID from VM UUID. Aug 12 23:33:12.758147 zram_generator::config[1085]: No configuration found. Aug 12 23:33:12.758159 kernel: NET: Registered PF_VSOCK protocol family Aug 12 23:33:12.758169 systemd[1]: Populated /etc with preset unit settings. Aug 12 23:33:12.758180 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Aug 12 23:33:12.758191 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 12 23:33:12.758203 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 12 23:33:12.758213 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 12 23:33:12.758224 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 12 23:33:12.758234 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 12 23:33:12.758246 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 12 23:33:12.758256 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 12 23:33:12.758266 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 12 23:33:12.758276 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 12 23:33:12.758286 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 12 23:33:12.758298 systemd[1]: Created slice user.slice - User and Session Slice. Aug 12 23:33:12.758308 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 12 23:33:12.758318 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 12 23:33:12.758328 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 12 23:33:12.758338 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 12 23:33:12.758348 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 12 23:33:12.758374 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 12 23:33:12.758386 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 12 23:33:12.758397 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 12 23:33:12.758410 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 12 23:33:12.758421 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 12 23:33:12.758430 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 12 23:33:12.758440 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 12 23:33:12.758450 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 12 23:33:12.758460 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 12 23:33:12.758475 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 12 23:33:12.758484 systemd[1]: Reached target slices.target - Slice Units. Aug 12 23:33:12.758497 systemd[1]: Reached target swap.target - Swaps. Aug 12 23:33:12.758507 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 12 23:33:12.758517 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 12 23:33:12.758527 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Aug 12 23:33:12.758538 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 12 23:33:12.758549 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 12 23:33:12.758559 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 12 23:33:12.758569 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 12 23:33:12.758579 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 12 23:33:12.758591 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 12 23:33:12.758601 systemd[1]: Mounting media.mount - External Media Directory... Aug 12 23:33:12.758617 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 12 23:33:12.758629 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 12 23:33:12.758639 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 12 23:33:12.758650 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Aug 12 23:33:12.758660 systemd[1]: Reached target machines.target - Containers. Aug 12 23:33:12.758670 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 12 23:33:12.758681 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 12 23:33:12.758692 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 12 23:33:12.758702 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 12 23:33:12.758713 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 12 23:33:12.758723 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 12 23:33:12.758733 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 12 23:33:12.758743 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 12 23:33:12.758753 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 12 23:33:12.758764 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 12 23:33:12.758777 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 12 23:33:12.758787 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 12 23:33:12.758797 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 12 23:33:12.758807 systemd[1]: Stopped systemd-fsck-usr.service. Aug 12 23:33:12.758818 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Aug 12 23:33:12.758828 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 12 23:33:12.758838 kernel: fuse: init (API version 7.41) Aug 12 23:33:12.758848 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 12 23:33:12.758859 kernel: loop: module loaded Aug 12 23:33:12.758869 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 12 23:33:12.758879 kernel: ACPI: bus type drm_connector registered Aug 12 23:33:12.758888 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 12 23:33:12.758898 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Aug 12 23:33:12.758912 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 12 23:33:12.758925 systemd[1]: verity-setup.service: Deactivated successfully. Aug 12 23:33:12.758935 systemd[1]: Stopped verity-setup.service. Aug 12 23:33:12.758945 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 12 23:33:12.758955 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 12 23:33:12.758965 systemd[1]: Mounted media.mount - External Media Directory. Aug 12 23:33:12.758978 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 12 23:33:12.758989 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 12 23:33:12.758999 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 12 23:33:12.759009 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 12 23:33:12.759019 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 12 23:33:12.759052 systemd-journald[1156]: Collecting audit messages is disabled. Aug 12 23:33:12.759080 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 12 23:33:12.759092 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 12 23:33:12.759103 systemd-journald[1156]: Journal started Aug 12 23:33:12.759124 systemd-journald[1156]: Runtime Journal (/run/log/journal/6c5f0cd962e04896bdc4d7dd235bdb06) is 6M, max 48.5M, 42.4M free. Aug 12 23:33:12.539835 systemd[1]: Queued start job for default target multi-user.target. Aug 12 23:33:12.563469 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 12 23:33:12.563928 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 12 23:33:12.761401 systemd[1]: Started systemd-journald.service - Journal Service. Aug 12 23:33:12.762040 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 12 23:33:12.762215 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 12 23:33:12.763578 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 12 23:33:12.763772 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 12 23:33:12.765008 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 12 23:33:12.765235 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 12 23:33:12.766597 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 12 23:33:12.766788 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 12 23:33:12.767876 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 12 23:33:12.768050 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 12 23:33:12.769326 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 12 23:33:12.770548 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 12 23:33:12.771796 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 12 23:33:12.773081 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Aug 12 23:33:12.786593 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 12 23:33:12.789172 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 12 23:33:12.791189 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 12 23:33:12.792251 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 12 23:33:12.792287 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 12 23:33:12.794059 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Aug 12 23:33:12.799710 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 12 23:33:12.800595 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 12 23:33:12.802007 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 12 23:33:12.804072 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 12 23:33:12.804966 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 12 23:33:12.808578 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 12 23:33:12.809504 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 12 23:33:12.811746 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 12 23:33:12.815722 systemd-journald[1156]: Time spent on flushing to /var/log/journal/6c5f0cd962e04896bdc4d7dd235bdb06 is 27.243ms for 872 entries. Aug 12 23:33:12.815722 systemd-journald[1156]: System Journal (/var/log/journal/6c5f0cd962e04896bdc4d7dd235bdb06) is 8M, max 195.6M, 187.6M free. Aug 12 23:33:12.850871 systemd-journald[1156]: Received client request to flush runtime journal. Aug 12 23:33:12.850908 kernel: loop0: detected capacity change from 0 to 138376 Aug 12 23:33:12.817486 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 12 23:33:12.819900 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 12 23:33:12.827257 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 12 23:33:12.832845 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 12 23:33:12.835787 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 12 23:33:12.840222 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 12 23:33:12.846258 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 12 23:33:12.852878 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Aug 12 23:33:12.854392 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 12 23:33:12.854558 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 12 23:33:12.856481 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 12 23:33:12.859847 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Aug 12 23:33:12.859866 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Aug 12 23:33:12.864724 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 12 23:33:12.869596 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 12 23:33:12.872388 kernel: loop1: detected capacity change from 0 to 107312 Aug 12 23:33:12.884560 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Aug 12 23:33:12.910906 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 12 23:33:12.911786 kernel: loop2: detected capacity change from 0 to 203944 Aug 12 23:33:12.913546 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 12 23:33:12.942397 kernel: loop3: detected capacity change from 0 to 138376 Aug 12 23:33:12.945049 systemd-tmpfiles[1223]: ACLs are not supported, ignoring. Aug 12 23:33:12.945068 systemd-tmpfiles[1223]: ACLs are not supported, ignoring. Aug 12 23:33:12.952430 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 12 23:33:12.955386 kernel: loop4: detected capacity change from 0 to 107312 Aug 12 23:33:12.961409 kernel: loop5: detected capacity change from 0 to 203944 Aug 12 23:33:12.966642 (sd-merge)[1226]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Aug 12 23:33:12.967043 (sd-merge)[1226]: Merged extensions into '/usr'. Aug 12 23:33:12.973180 systemd[1]: Reload requested from client PID 1201 ('systemd-sysext') (unit systemd-sysext.service)... Aug 12 23:33:12.973197 systemd[1]: Reloading... Aug 12 23:33:13.036387 zram_generator::config[1256]: No configuration found. Aug 12 23:33:13.111785 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. Aug 12 23:33:13.113954 ldconfig[1196]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 12 23:33:13.173829 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 12 23:33:13.174042 systemd[1]: Reloading finished in 200 ms. Aug 12 23:33:13.206003 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 12 23:33:13.207181 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 12 23:33:13.220814 systemd[1]: Starting ensure-sysext.service... Aug 12 23:33:13.225511 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 12 23:33:13.234732 systemd[1]: Reload requested from client PID 1287 ('systemctl') (unit ensure-sysext.service)... Aug 12 23:33:13.234753 systemd[1]: Reloading... Aug 12 23:33:13.245788 systemd-tmpfiles[1288]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Aug 12 23:33:13.245952 systemd-tmpfiles[1288]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Aug 12 23:33:13.246196 systemd-tmpfiles[1288]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 12 23:33:13.246436 systemd-tmpfiles[1288]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 12 23:33:13.247075 systemd-tmpfiles[1288]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 12 23:33:13.247276 systemd-tmpfiles[1288]: ACLs are not supported, ignoring. Aug 12 23:33:13.247322 systemd-tmpfiles[1288]: ACLs are not supported, ignoring. Aug 12 23:33:13.249757 systemd-tmpfiles[1288]: Detected autofs mount point /boot during canonicalization of boot. Aug 12 23:33:13.249771 systemd-tmpfiles[1288]: Skipping /boot Aug 12 23:33:13.258881 systemd-tmpfiles[1288]: Detected autofs mount point /boot during canonicalization of boot. Aug 12 23:33:13.258899 systemd-tmpfiles[1288]: Skipping /boot Aug 12 23:33:13.282878 zram_generator::config[1315]: No configuration found. Aug 12 23:33:13.351430 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. Aug 12 23:33:13.412788 systemd[1]: Reloading finished in 177 ms. Aug 12 23:33:13.434004 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 12 23:33:13.440400 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 12 23:33:13.451616 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 12 23:33:13.453910 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 12 23:33:13.455841 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 12 23:33:13.458206 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 12 23:33:13.463464 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 12 23:33:13.465265 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 12 23:33:13.469946 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 12 23:33:13.471023 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 12 23:33:13.486897 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 12 23:33:13.489142 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 12 23:33:13.490187 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 12 23:33:13.490311 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Aug 12 23:33:13.493516 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 12 23:33:13.495400 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 12 23:33:13.495560 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 12 23:33:13.496895 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 12 23:33:13.497073 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 12 23:33:13.498601 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 12 23:33:13.498765 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 12 23:33:13.506166 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 12 23:33:13.506350 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 12 23:33:13.508458 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 12 23:33:13.512574 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 12 23:33:13.515696 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 12 23:33:13.519847 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 12 23:33:13.523461 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 12 23:33:13.526179 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 12 23:33:13.527169 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 12 23:33:13.527285 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Aug 12 23:33:13.528404 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 12 23:33:13.531042 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 12 23:33:13.533002 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 12 23:33:13.533541 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 12 23:33:13.534339 systemd-udevd[1356]: Using default interface naming scheme 'v255'. Aug 12 23:33:13.535461 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 12 23:33:13.535613 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 12 23:33:13.537108 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 12 23:33:13.537254 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 12 23:33:13.539581 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 12 23:33:13.548928 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 12 23:33:13.549776 augenrules[1394]: No rules Aug 12 23:33:13.550652 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 12 23:33:13.553458 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 12 23:33:13.556383 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 12 23:33:13.560003 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 12 23:33:13.560873 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 12 23:33:13.560985 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Aug 12 23:33:13.561097 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 12 23:33:13.561782 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 12 23:33:13.563174 systemd[1]: audit-rules.service: Deactivated successfully. Aug 12 23:33:13.569398 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 12 23:33:13.573846 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 12 23:33:13.574006 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 12 23:33:13.578708 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 12 23:33:13.583403 systemd[1]: Finished ensure-sysext.service. Aug 12 23:33:13.584772 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 12 23:33:13.585273 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 12 23:33:13.588845 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 12 23:33:13.589025 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 12 23:33:13.590287 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 12 23:33:13.590468 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 12 23:33:13.604949 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 12 23:33:13.605757 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 12 23:33:13.605798 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 12 23:33:13.607484 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 12 23:33:13.619665 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 12 23:33:13.686140 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 12 23:33:13.689221 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 12 23:33:13.729426 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 12 23:33:13.748698 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 12 23:33:13.766049 systemd-networkd[1441]: lo: Link UP Aug 12 23:33:13.766058 systemd-networkd[1441]: lo: Gained carrier Aug 12 23:33:13.767816 systemd-networkd[1441]: Enumeration completed Aug 12 23:33:13.768079 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 12 23:33:13.770150 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Aug 12 23:33:13.774264 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 12 23:33:13.774679 systemd-networkd[1441]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 12 23:33:13.774683 systemd-networkd[1441]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 12 23:33:13.775230 systemd-networkd[1441]: eth0: Link UP Aug 12 23:33:13.775324 systemd-networkd[1441]: eth0: Gained carrier Aug 12 23:33:13.775339 systemd-networkd[1441]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 12 23:33:13.787480 systemd-resolved[1354]: Positive Trust Anchors: Aug 12 23:33:13.787496 systemd-resolved[1354]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 12 23:33:13.787528 systemd-resolved[1354]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Aug 12 23:33:13.792418 systemd-networkd[1441]: eth0: DHCPv4 address 10.0.0.17/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 12 23:33:13.796477 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Aug 12 23:33:13.798873 systemd-resolved[1354]: Defaulting to hostname 'linux'. Aug 12 23:33:13.801048 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 12 23:33:13.803746 systemd[1]: Reached target network.target - Network. Aug 12 23:33:13.804351 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 12 23:33:13.831500 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 12 23:33:13.832450 systemd[1]: Reached target time-set.target - System Time Set. Aug 12 23:33:13.833633 systemd-timesyncd[1442]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 12 23:33:13.833688 systemd-timesyncd[1442]: Initial clock synchronization to Tue 2025-08-12 23:33:13.595468 UTC. Aug 12 23:33:13.838060 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 12 23:33:13.839144 systemd[1]: Reached target sysinit.target - System Initialization. Aug 12 23:33:13.840049 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 12 23:33:13.841027 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 12 23:33:13.842153 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 12 23:33:13.843292 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 12 23:33:13.844328 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 12 23:33:13.845331 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 12 23:33:13.845374 systemd[1]: Reached target paths.target - Path Units. Aug 12 23:33:13.846096 systemd[1]: Reached target timers.target - Timer Units. Aug 12 23:33:13.847784 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 12 23:33:13.849742 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 12 23:33:13.852563 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Aug 12 23:33:13.853799 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Aug 12 23:33:13.854808 systemd[1]: Reached target ssh-access.target - SSH Access Available. Aug 12 23:33:13.859226 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 12 23:33:13.860630 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Aug 12 23:33:13.862008 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 12 23:33:13.862911 systemd[1]: Reached target sockets.target - Socket Units. Aug 12 23:33:13.863620 systemd[1]: Reached target basic.target - Basic System. Aug 12 23:33:13.864304 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 12 23:33:13.864334 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 12 23:33:13.865295 systemd[1]: Starting containerd.service - containerd container runtime... Aug 12 23:33:13.867022 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 12 23:33:13.868617 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 12 23:33:13.870213 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 12 23:33:13.872345 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 12 23:33:13.873160 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Aug 12 23:33:13.874077 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 12 23:33:13.875825 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 12 23:33:13.879489 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 12 23:33:13.882875 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 12 23:33:13.883779 jq[1484]: false Aug 12 23:33:13.884444 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 12 23:33:13.889398 extend-filesystems[1485]: Found /dev/vda6 Aug 12 23:33:13.890655 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 12 23:33:13.891249 systemd[1]: Starting update-engine.service - Update Engine... Aug 12 23:33:13.895566 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 12 23:33:13.896954 extend-filesystems[1485]: Found /dev/vda9 Aug 12 23:33:13.899462 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 12 23:33:13.899544 extend-filesystems[1485]: Checking size of /dev/vda9 Aug 12 23:33:13.902290 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 12 23:33:13.907464 jq[1501]: true Aug 12 23:33:13.902499 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 12 23:33:13.902847 systemd[1]: motdgen.service: Deactivated successfully. Aug 12 23:33:13.903017 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 12 23:33:13.904086 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 12 23:33:13.904236 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 12 23:33:13.909944 extend-filesystems[1485]: Resized partition /dev/vda9 Aug 12 23:33:13.916609 extend-filesystems[1512]: resize2fs 1.47.2 (1-Jan-2025) Aug 12 23:33:13.919584 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 12 23:33:13.923700 (ntainerd)[1511]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 12 23:33:13.935329 jq[1509]: true Aug 12 23:33:13.956650 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 12 23:33:13.967233 update_engine[1499]: I20250812 23:33:13.961659 1499 main.cc:92] Flatcar Update Engine starting Aug 12 23:33:13.968870 extend-filesystems[1512]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 12 23:33:13.968870 extend-filesystems[1512]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 12 23:33:13.968870 extend-filesystems[1512]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 12 23:33:13.981534 extend-filesystems[1485]: Resized filesystem in /dev/vda9 Aug 12 23:33:13.983446 update_engine[1499]: I20250812 23:33:13.977348 1499 update_check_scheduler.cc:74] Next update check in 6m30s Aug 12 23:33:13.971691 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 12 23:33:13.974499 dbus-daemon[1482]: [system] SELinux support is enabled Aug 12 23:33:13.971903 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 12 23:33:13.975528 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 12 23:33:13.984858 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Aug 12 23:33:13.984901 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 12 23:33:13.986572 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Aug 12 23:33:13.986595 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 12 23:33:13.987662 systemd[1]: Started update-engine.service - Update Engine. Aug 12 23:33:13.991126 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 12 23:33:13.997260 systemd-logind[1494]: Watching system buttons on /dev/input/event0 (Power Button) Aug 12 23:33:13.997594 systemd-logind[1494]: New seat seat0. Aug 12 23:33:13.999367 bash[1539]: Updated "/home/core/.ssh/authorized_keys" Aug 12 23:33:13.999193 systemd[1]: Started systemd-logind.service - User Login Management. Aug 12 23:33:14.001417 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 12 23:33:14.003068 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 12 23:33:14.040910 locksmithd[1540]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 12 23:33:14.136622 containerd[1511]: time="2025-08-12T23:33:14Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Aug 12 23:33:14.139702 containerd[1511]: time="2025-08-12T23:33:14.139669690Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Aug 12 23:33:14.147698 containerd[1511]: time="2025-08-12T23:33:14.147666369Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.082µs" Aug 12 23:33:14.147747 containerd[1511]: time="2025-08-12T23:33:14.147697301Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Aug 12 23:33:14.147747 containerd[1511]: time="2025-08-12T23:33:14.147714377Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Aug 12 23:33:14.147860 containerd[1511]: time="2025-08-12T23:33:14.147839538Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Aug 12 23:33:14.147882 containerd[1511]: time="2025-08-12T23:33:14.147859602Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Aug 12 23:33:14.147900 containerd[1511]: time="2025-08-12T23:33:14.147880327Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 12 23:33:14.147940 containerd[1511]: time="2025-08-12T23:33:14.147923173Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 12 23:33:14.147940 containerd[1511]: time="2025-08-12T23:33:14.147937416Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148145 containerd[1511]: time="2025-08-12T23:33:14.148124633Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148145 containerd[1511]: time="2025-08-12T23:33:14.148143184Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148182 containerd[1511]: time="2025-08-12T23:33:14.148154012Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148182 containerd[1511]: time="2025-08-12T23:33:14.148162007Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148240 containerd[1511]: time="2025-08-12T23:33:14.148225034Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148446 containerd[1511]: time="2025-08-12T23:33:14.148426106Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148470 containerd[1511]: time="2025-08-12T23:33:14.148460142Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Aug 12 23:33:14.148494 containerd[1511]: time="2025-08-12T23:33:14.148470427Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Aug 12 23:33:14.148517 containerd[1511]: time="2025-08-12T23:33:14.148504230Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Aug 12 23:33:14.148742 containerd[1511]: time="2025-08-12T23:33:14.148722573Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Aug 12 23:33:14.148799 containerd[1511]: time="2025-08-12T23:33:14.148783892Z" level=info msg="metadata content store policy set" policy=shared Aug 12 23:33:14.151640 containerd[1511]: time="2025-08-12T23:33:14.151602129Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Aug 12 23:33:14.151700 containerd[1511]: time="2025-08-12T23:33:14.151665194Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Aug 12 23:33:14.151700 containerd[1511]: time="2025-08-12T23:33:14.151680214Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Aug 12 23:33:14.151700 containerd[1511]: time="2025-08-12T23:33:14.151691352Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Aug 12 23:33:14.151753 containerd[1511]: time="2025-08-12T23:33:14.151701869Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Aug 12 23:33:14.151753 containerd[1511]: time="2025-08-12T23:33:14.151716229Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Aug 12 23:33:14.151753 containerd[1511]: time="2025-08-12T23:33:14.151727522Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Aug 12 23:33:14.151753 containerd[1511]: time="2025-08-12T23:33:14.151738273Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Aug 12 23:33:14.151810 containerd[1511]: time="2025-08-12T23:33:14.151753525Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Aug 12 23:33:14.151810 containerd[1511]: time="2025-08-12T23:33:14.151763771Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Aug 12 23:33:14.151810 containerd[1511]: time="2025-08-12T23:33:14.151772813Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Aug 12 23:33:14.151810 containerd[1511]: time="2025-08-12T23:33:14.151787716Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151881247Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151906474Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151929410Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151940005Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151949203Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151970238Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151981376Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.151994882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.152005283Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.152014364Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.152023135Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.153929191Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.153946500Z" level=info msg="Start snapshots syncer" Aug 12 23:33:14.153995 containerd[1511]: time="2025-08-12T23:33:14.153980459Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Aug 12 23:33:14.154269 containerd[1511]: time="2025-08-12T23:33:14.154166240Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Aug 12 23:33:14.154269 containerd[1511]: time="2025-08-12T23:33:14.154210173Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154777608Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154916119Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154945615Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154957878Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154979806Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.154996533Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.155012018Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Aug 12 23:33:14.155060 containerd[1511]: time="2025-08-12T23:33:14.155023428Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Aug 12 23:33:14.155222 containerd[1511]: time="2025-08-12T23:33:14.155120335Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Aug 12 23:33:14.155222 containerd[1511]: time="2025-08-12T23:33:14.155173737Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Aug 12 23:33:14.155222 containerd[1511]: time="2025-08-12T23:33:14.155191784Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Aug 12 23:33:14.155267 containerd[1511]: time="2025-08-12T23:33:14.155235251Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Aug 12 23:33:14.155267 containerd[1511]: time="2025-08-12T23:33:14.155253452Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Aug 12 23:33:14.155301 containerd[1511]: time="2025-08-12T23:33:14.155265988Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 12 23:33:14.155301 containerd[1511]: time="2025-08-12T23:33:14.155278795Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 12 23:33:14.155301 containerd[1511]: time="2025-08-12T23:33:14.155287566Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Aug 12 23:33:14.155368 containerd[1511]: time="2025-08-12T23:33:14.155299713Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Aug 12 23:33:14.155368 containerd[1511]: time="2025-08-12T23:33:14.155319739Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Aug 12 23:33:14.155452 containerd[1511]: time="2025-08-12T23:33:14.155419674Z" level=info msg="runtime interface created" Aug 12 23:33:14.155452 containerd[1511]: time="2025-08-12T23:33:14.155436478Z" level=info msg="created NRI interface" Aug 12 23:33:14.155452 containerd[1511]: time="2025-08-12T23:33:14.155447384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Aug 12 23:33:14.155523 containerd[1511]: time="2025-08-12T23:33:14.155468264Z" level=info msg="Connect containerd service" Aug 12 23:33:14.155523 containerd[1511]: time="2025-08-12T23:33:14.155500980Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 12 23:33:14.156502 containerd[1511]: time="2025-08-12T23:33:14.156474053Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.254893028Z" level=info msg="Start subscribing containerd event" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.254959936Z" level=info msg="Start recovering state" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255053001Z" level=info msg="Start event monitor" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255068836Z" level=info msg="Start cni network conf syncer for default" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255081526Z" level=info msg="Start streaming server" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255089676Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255100776Z" level=info msg="runtime interface starting up..." Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255105976Z" level=info msg="starting plugins..." Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255152936Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255201448Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 12 23:33:14.255380 containerd[1511]: time="2025-08-12T23:33:14.255248058Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 12 23:33:14.255416 systemd[1]: Started containerd.service - containerd container runtime. Aug 12 23:33:14.256436 containerd[1511]: time="2025-08-12T23:33:14.256410522Z" level=info msg="containerd successfully booted in 0.120163s" Aug 12 23:33:14.977111 sshd_keygen[1506]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 12 23:33:14.996440 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 12 23:33:14.998875 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 12 23:33:15.021070 systemd[1]: issuegen.service: Deactivated successfully. Aug 12 23:33:15.021297 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 12 23:33:15.023899 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 12 23:33:15.053176 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 12 23:33:15.055655 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 12 23:33:15.057430 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 12 23:33:15.058412 systemd[1]: Reached target getty.target - Login Prompts. Aug 12 23:33:15.175466 systemd-networkd[1441]: eth0: Gained IPv6LL Aug 12 23:33:15.177609 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 12 23:33:15.178885 systemd[1]: Reached target network-online.target - Network is Online. Aug 12 23:33:15.181194 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 12 23:33:15.183198 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 12 23:33:15.184961 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 12 23:33:15.208695 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 12 23:33:15.208933 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 12 23:33:15.210095 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 12 23:33:15.214923 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 12 23:33:15.730348 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 12 23:33:15.731756 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 12 23:33:15.733742 systemd[1]: Startup finished in 2.086s (kernel) + 4.510s (initrd) + 3.657s (userspace) = 10.253s. Aug 12 23:33:15.734463 (kubelet)[1608]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Aug 12 23:33:16.193718 kubelet[1608]: E0812 23:33:16.193608 1608 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Aug 12 23:33:16.195869 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 12 23:33:16.196011 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 12 23:33:16.196602 systemd[1]: kubelet.service: Consumed 889ms CPU time, 257.8M memory peak. Aug 12 23:33:20.822881 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 12 23:33:20.824334 systemd[1]: Started sshd@0-10.0.0.17:22-10.0.0.1:58500.service - OpenSSH per-connection server daemon (10.0.0.1:58500). Aug 12 23:33:20.900207 sshd[1621]: Accepted publickey for core from 10.0.0.1 port 58500 ssh2: RSA SHA256:Y8XhXUp+e0cOxNBsLQ9X5uWw2r4VA0fiDKDQJi7Y+pU Aug 12 23:33:20.902183 sshd-session[1621]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 12 23:33:20.916430 systemd-logind[1494]: New session 1 of user core. Aug 12 23:33:20.917249 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 12 23:33:20.918194 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 12 23:33:20.951750 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 12 23:33:20.954876 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 12 23:33:20.985098 (systemd)[1625]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 12 23:33:20.987229 systemd-logind[1494]: New session c1 of user core. Aug 12 23:33:21.098657 systemd[1625]: Queued start job for default target default.target. Aug 12 23:33:21.118296 systemd[1625]: Created slice app.slice - User Application Slice. Aug 12 23:33:21.118328 systemd[1625]: Reached target paths.target - Paths. Aug 12 23:33:21.118390 systemd[1625]: Reached target timers.target - Timers. Aug 12 23:33:21.119558 systemd[1625]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 12 23:33:21.128340 systemd[1625]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 12 23:33:21.128419 systemd[1625]: Reached target sockets.target - Sockets. Aug 12 23:33:21.128462 systemd[1625]: Reached target basic.target - Basic System. Aug 12 23:33:21.128490 systemd[1625]: Reached target default.target - Main User Target. Aug 12 23:33:21.128516 systemd[1625]: Startup finished in 135ms. Aug 12 23:33:21.128596 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 12 23:33:21.129859 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 12 23:33:21.191455 systemd[1]: Started sshd@1-10.0.0.17:22-10.0.0.1:58508.service - OpenSSH per-connection server daemon (10.0.0.1:58508). Aug 12 23:33:21.230865 sshd[1636]: Accepted publickey for core from 10.0.0.1 port 58508 ssh2: RSA SHA256:Y8XhXUp+e0cOxNBsLQ9X5uWw2r4VA0fiDKDQJi7Y+pU Aug 12 23:33:21.232185 sshd-session[1636]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 12 23:33:21.237007 systemd-logind[1494]: New session 2 of user core. Aug 12 23:33:21.251626 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 12 23:33:21.302844 sshd[1638]: Connection closed by 10.0.0.1 port 58508 Aug 12 23:33:21.303219 sshd-session[1636]: pam_unix(sshd:session): session closed for user core Aug 12 23:33:21.324577 systemd[1]: sshd@1-10.0.0.17:22-10.0.0.1:58508.service: Deactivated successfully. Aug 12 23:33:21.326135 systemd[1]: session-2.scope: Deactivated successfully. Aug 12 23:33:21.326861 systemd-logind[1494]: Session 2 logged out. Waiting for processes to exit. Aug 12 23:33:21.329229 systemd[1]: Started sshd@2-10.0.0.17:22-10.0.0.1:58522.service - OpenSSH per-connection server daemon (10.0.0.1:58522). Aug 12 23:33:21.330754 systemd-logind[1494]: Removed session 2. Aug 12 23:33:21.392022 sshd[1644]: Accepted publickey for core from 10.0.0.1 port 58522 ssh2: RSA SHA256:Y8XhXUp+e0cOxNBsLQ9X5uWw2r4VA0fiDKDQJi7Y+pU Aug 12 23:33:21.392533 sshd-session[1644]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 12 23:33:21.396838 systemd-logind[1494]: New session 3 of user core. Aug 12 23:33:21.407523 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 12 23:33:21.457971 sshd[1646]: Connection closed by 10.0.0.1 port 58522 Aug 12 23:33:21.458540 sshd-session[1644]: pam_unix(sshd:session): session closed for user core Aug 12 23:33:21.469717 systemd[1]: sshd@2-10.0.0.17:22-10.0.0.1:58522.service: Deactivated successfully. Aug 12 23:33:21.472571 systemd[1]: session-3.scope: Deactivated successfully. Aug 12 23:33:21.473506 systemd-logind[1494]: Session 3 logged out. Waiting for processes to exit. Aug 12 23:33:21.476247 systemd[1]: Started sshd@3-10.0.0.17:22-10.0.0.1:58524.service - OpenSSH per-connection server daemon (10.0.0.1:58524). Aug 12 23:33:21.477056 systemd-logind[1494]: Removed session 3. Aug 12 23:33:21.525300 sshd[1652]: Accepted publickey for core from 10.0.0.1 port 58524 ssh2: RSA SHA256:Y8XhXUp+e0cOxNBsLQ9X5uWw2r4VA0fiDKDQJi7Y+pU Aug 12 23:33:21.526663 sshd-session[1652]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 12 23:33:21.538271 systemd-logind[1494]: New session 4 of user core. Aug 12 23:33:21.545524 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 12 23:33:21.596491 sshd[1654]: Connection closed by 10.0.0.1 port 58524 Aug 12 23:33:21.596075 sshd-session[1652]: pam_unix(sshd:session): session closed for user core Aug 12 23:33:21.606287 systemd[1]: sshd@3-10.0.0.17:22-10.0.0.1:58524.service: Deactivated successfully. Aug 12 23:33:21.608580 systemd[1]: session-4.scope: Deactivated successfully. Aug 12 23:33:21.609606 systemd-logind[1494]: Session 4 logged out. Waiting for processes to exit. Aug 12 23:33:21.613460 systemd[1]: Started sshd@4-10.0.0.17:22-10.0.0.1:58528.service - OpenSSH per-connection server daemon (10.0.0.1:58528). Aug 12 23:33:21.614086 systemd-logind[1494]: Removed session 4. Aug 12 23:33:21.663680 sshd[1660]: Accepted publickey for core from 10.0.0.1 port 58528 ssh2: RSA SHA256:Y8XhXUp+e0cOxNBsLQ9X5uWw2r4VA0fiDKDQJi7Y+pU Aug 12 23:33:21.664873 sshd-session[1660]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 12 23:33:21.669216 systemd-logind[1494]: New session 5 of user core. Aug 12 23:33:21.681553 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 12 23:33:21.736159 sudo[1663]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 12 23:33:21.736685 sudo[1663]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 12 23:33:21.747108 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 12 23:33:21.792814 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 12 23:33:21.793009 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 12 23:33:22.216685 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 12 23:33:22.216828 systemd[1]: kubelet.service: Consumed 889ms CPU time, 257.8M memory peak. Aug 12 23:33:22.218755 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 12 23:33:22.239558 systemd[1]: Reload requested from client PID 1704 ('systemctl') (unit session-5.scope)... Aug 12 23:33:22.239665 systemd[1]: Reloading... Aug 12 23:33:22.320427 zram_generator::config[1746]: No configuration found. Aug 12 23:33:22.517663 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. Aug 12 23:33:22.603674 systemd[1]: Reloading finished in 363 ms. Aug 12 23:33:22.653464 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 12 23:33:22.655412 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Aug 12 23:33:22.656890 systemd[1]: kubelet.service: Deactivated successfully. Aug 12 23:33:22.657083 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 12 23:33:22.657123 systemd[1]: kubelet.service: Consumed 95ms CPU time, 95.2M memory peak. Aug 12 23:33:22.658632 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 12 23:33:22.761389 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 12 23:33:22.765081 (kubelet)[1793]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Aug 12 23:33:22.798791 kubelet[1793]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Aug 12 23:33:22.798791 kubelet[1793]: 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. Aug 12 23:33:22.798791 kubelet[1793]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Aug 12 23:33:22.798791 kubelet[1793]: I0812 23:33:22.798769 1793 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" Aug 12 23:33:23.494385 kubelet[1793]: I0812 23:33:23.493812 1793 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Aug 12 23:33:23.494385 kubelet[1793]: I0812 23:33:23.493846 1793 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 12 23:33:23.494385 kubelet[1793]: I0812 23:33:23.494081 1793 server.go:934] "Client rotation is on, will bootstrap in background" Aug 12 23:33:23.530964 kubelet[1793]: I0812 23:33:23.530918 1793 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 12 23:33:23.540878 kubelet[1793]: I0812 23:33:23.540780 1793 server.go:1431] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Aug 12 23:33:23.547662 kubelet[1793]: I0812 23:33:23.547555 1793 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 12 23:33:23.548412 kubelet[1793]: I0812 23:33:23.548374 1793 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Aug 12 23:33:23.548673 kubelet[1793]: I0812 23:33:23.548523 1793 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 12 23:33:23.548734 kubelet[1793]: I0812 23:33:23.548552 1793 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.17","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Aug 12 23:33:23.548734 kubelet[1793]: I0812 23:33:23.548728 1793 topology_manager.go:138] "Creating topology manager with none policy" Aug 12 23:33:23.548734 kubelet[1793]: I0812 23:33:23.548737 1793 container_manager_linux.go:300] "Creating device plugin manager" Aug 12 23:33:23.549757 kubelet[1793]: I0812 23:33:23.548993 1793 state_mem.go:36] "Initialized new in-memory state store" Aug 12 23:33:23.549892 kubelet[1793]: I0812 23:33:23.549820 1793 kubelet.go:408] "Attempting to sync node with API server" Aug 12 23:33:23.549892 kubelet[1793]: I0812 23:33:23.549851 1793 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 12 23:33:23.549945 kubelet[1793]: I0812 23:33:23.549897 1793 kubelet.go:314] "Adding apiserver pod source" Aug 12 23:33:23.550107 kubelet[1793]: I0812 23:33:23.550013 1793 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 12 23:33:23.550692 kubelet[1793]: E0812 23:33:23.550613 1793 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:23.550692 kubelet[1793]: E0812 23:33:23.550659 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:23.553622 kubelet[1793]: I0812 23:33:23.553588 1793 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v2.0.4" apiVersion="v1" Aug 12 23:33:23.554401 kubelet[1793]: I0812 23:33:23.554295 1793 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Aug 12 23:33:23.554513 kubelet[1793]: W0812 23:33:23.554491 1793 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 12 23:33:23.555410 kubelet[1793]: I0812 23:33:23.555376 1793 server.go:1274] "Started kubelet" Aug 12 23:33:23.556846 kubelet[1793]: I0812 23:33:23.556747 1793 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Aug 12 23:33:23.557875 kubelet[1793]: I0812 23:33:23.557713 1793 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 12 23:33:23.558060 kubelet[1793]: I0812 23:33:23.557953 1793 server.go:449] "Adding debug handlers to kubelet server" Aug 12 23:33:23.559248 kubelet[1793]: I0812 23:33:23.559013 1793 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Aug 12 23:33:23.559248 kubelet[1793]: I0812 23:33:23.559216 1793 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 12 23:33:23.559845 kubelet[1793]: I0812 23:33:23.559474 1793 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Aug 12 23:33:23.563379 kubelet[1793]: I0812 23:33:23.560987 1793 volume_manager.go:289] "Starting Kubelet Volume Manager" Aug 12 23:33:23.563379 kubelet[1793]: I0812 23:33:23.561102 1793 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Aug 12 23:33:23.563379 kubelet[1793]: I0812 23:33:23.561150 1793 reconciler.go:26] "Reconciler: start to sync state" Aug 12 23:33:23.563379 kubelet[1793]: E0812 23:33:23.561550 1793 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 12 23:33:23.563379 kubelet[1793]: I0812 23:33:23.563230 1793 factory.go:221] Registration of the containerd container factory successfully Aug 12 23:33:23.563379 kubelet[1793]: I0812 23:33:23.563244 1793 factory.go:221] Registration of the systemd container factory successfully Aug 12 23:33:23.563562 kubelet[1793]: I0812 23:33:23.563392 1793 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Aug 12 23:33:23.563730 kubelet[1793]: E0812 23:33:23.563704 1793 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.17\" not found" Aug 12 23:33:23.572838 kubelet[1793]: E0812 23:33:23.572791 1793 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.17\" not found" node="10.0.0.17" Aug 12 23:33:23.583067 kubelet[1793]: I0812 23:33:23.583044 1793 cpu_manager.go:214] "Starting CPU manager" policy="none" Aug 12 23:33:23.583067 kubelet[1793]: I0812 23:33:23.583057 1793 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Aug 12 23:33:23.583067 kubelet[1793]: I0812 23:33:23.583072 1793 state_mem.go:36] "Initialized new in-memory state store" Aug 12 23:33:23.664024 kubelet[1793]: E0812 23:33:23.663962 1793 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.17\" not found" Aug 12 23:33:23.670414 kubelet[1793]: I0812 23:33:23.670392 1793 policy_none.go:49] "None policy: Start" Aug 12 23:33:23.671272 kubelet[1793]: I0812 23:33:23.671253 1793 memory_manager.go:170] "Starting memorymanager" policy="None" Aug 12 23:33:23.671320 kubelet[1793]: I0812 23:33:23.671278 1793 state_mem.go:35] "Initializing new in-memory state store" Aug 12 23:33:23.678729 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Aug 12 23:33:23.689575 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Aug 12 23:33:23.692591 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Aug 12 23:33:23.695064 kubelet[1793]: I0812 23:33:23.695016 1793 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 12 23:33:23.696340 kubelet[1793]: I0812 23:33:23.696280 1793 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 12 23:33:23.696340 kubelet[1793]: I0812 23:33:23.696302 1793 status_manager.go:217] "Starting to sync pod status with apiserver" Aug 12 23:33:23.696340 kubelet[1793]: I0812 23:33:23.696319 1793 kubelet.go:2321] "Starting kubelet main sync loop" Aug 12 23:33:23.696524 kubelet[1793]: E0812 23:33:23.696507 1793 kubelet.go:2345] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Aug 12 23:33:23.699256 kubelet[1793]: I0812 23:33:23.699216 1793 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 12 23:33:23.699989 kubelet[1793]: I0812 23:33:23.699926 1793 eviction_manager.go:189] "Eviction manager: starting control loop" Aug 12 23:33:23.700175 kubelet[1793]: I0812 23:33:23.699949 1793 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Aug 12 23:33:23.702263 kubelet[1793]: I0812 23:33:23.701698 1793 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 12 23:33:23.702844 kubelet[1793]: E0812 23:33:23.702786 1793 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.17\" not found" Aug 12 23:33:23.802029 kubelet[1793]: I0812 23:33:23.801918 1793 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.17" Aug 12 23:33:23.811787 kubelet[1793]: I0812 23:33:23.811746 1793 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.17" Aug 12 23:33:23.811787 kubelet[1793]: E0812 23:33:23.811784 1793 kubelet_node_status.go:535] "Error updating node status, will retry" err="error getting node \"10.0.0.17\": node \"10.0.0.17\" not found" Aug 12 23:33:23.831627 kubelet[1793]: I0812 23:33:23.831587 1793 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 12 23:33:23.831965 containerd[1511]: time="2025-08-12T23:33:23.831924931Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 12 23:33:23.832215 kubelet[1793]: I0812 23:33:23.832135 1793 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 12 23:33:24.286118 sudo[1663]: pam_unix(sudo:session): session closed for user root Aug 12 23:33:24.287573 sshd[1662]: Connection closed by 10.0.0.1 port 58528 Aug 12 23:33:24.288005 sshd-session[1660]: pam_unix(sshd:session): session closed for user core Aug 12 23:33:24.291515 systemd[1]: sshd@4-10.0.0.17:22-10.0.0.1:58528.service: Deactivated successfully. Aug 12 23:33:24.293207 systemd[1]: session-5.scope: Deactivated successfully. Aug 12 23:33:24.293916 systemd[1]: session-5.scope: Consumed 437ms CPU time, 72.6M memory peak. Aug 12 23:33:24.294835 systemd-logind[1494]: Session 5 logged out. Waiting for processes to exit. Aug 12 23:33:24.295948 systemd-logind[1494]: Removed session 5. Aug 12 23:33:24.496249 kubelet[1793]: I0812 23:33:24.495770 1793 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 12 23:33:24.496249 kubelet[1793]: W0812 23:33:24.495964 1793 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 Aug 12 23:33:24.496438 kubelet[1793]: W0812 23:33:24.496312 1793 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.Service ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Aug 12 23:33:24.496438 kubelet[1793]: W0812 23:33:24.496344 1793 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 Aug 12 23:33:24.551022 kubelet[1793]: E0812 23:33:24.550899 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:24.551022 kubelet[1793]: I0812 23:33:24.550958 1793 apiserver.go:52] "Watching apiserver" Aug 12 23:33:24.561894 kubelet[1793]: I0812 23:33:24.561868 1793 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Aug 12 23:33:24.563630 systemd[1]: Created slice kubepods-besteffort-pod72d74577_511c_46e7_9159_d4eef994f022.slice - libcontainer container kubepods-besteffort-pod72d74577_511c_46e7_9159_d4eef994f022.slice. Aug 12 23:33:24.566258 kubelet[1793]: I0812 23:33:24.565897 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-cni\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566258 kubelet[1793]: I0812 23:33:24.565937 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/72d74577-511c-46e7-9159-d4eef994f022-xtables-lock\") pod \"kube-proxy-tjq9k\" (UID: \"72d74577-511c-46e7-9159-d4eef994f022\") " pod="kube-system/kube-proxy-tjq9k" Aug 12 23:33:24.566258 kubelet[1793]: I0812 23:33:24.565960 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rgllv\" (UniqueName: \"kubernetes.io/projected/72d74577-511c-46e7-9159-d4eef994f022-kube-api-access-rgllv\") pod \"kube-proxy-tjq9k\" (UID: \"72d74577-511c-46e7-9159-d4eef994f022\") " pod="kube-system/kube-proxy-tjq9k" Aug 12 23:33:24.566258 kubelet[1793]: I0812 23:33:24.565987 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-run\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566258 kubelet[1793]: I0812 23:33:24.566039 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-cni-plugin\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566441 kubelet[1793]: I0812 23:33:24.566063 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-flannel-cfg\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566441 kubelet[1793]: I0812 23:33:24.566078 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-xtables-lock\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566441 kubelet[1793]: I0812 23:33:24.566102 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-m6wk9\" (UniqueName: \"kubernetes.io/projected/c0d3233a-1b1a-49fb-8c4a-92d27e5d161a-kube-api-access-m6wk9\") pod \"kube-flannel-ds-lfhxk\" (UID: \"c0d3233a-1b1a-49fb-8c4a-92d27e5d161a\") " pod="kube-flannel/kube-flannel-ds-lfhxk" Aug 12 23:33:24.566441 kubelet[1793]: I0812 23:33:24.566117 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/72d74577-511c-46e7-9159-d4eef994f022-kube-proxy\") pod \"kube-proxy-tjq9k\" (UID: \"72d74577-511c-46e7-9159-d4eef994f022\") " pod="kube-system/kube-proxy-tjq9k" Aug 12 23:33:24.566441 kubelet[1793]: I0812 23:33:24.566131 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/72d74577-511c-46e7-9159-d4eef994f022-lib-modules\") pod \"kube-proxy-tjq9k\" (UID: \"72d74577-511c-46e7-9159-d4eef994f022\") " pod="kube-system/kube-proxy-tjq9k" Aug 12 23:33:24.582156 systemd[1]: Created slice kubepods-burstable-podc0d3233a_1b1a_49fb_8c4a_92d27e5d161a.slice - libcontainer container kubepods-burstable-podc0d3233a_1b1a_49fb_8c4a_92d27e5d161a.slice. Aug 12 23:33:24.881096 containerd[1511]: time="2025-08-12T23:33:24.880986180Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-tjq9k,Uid:72d74577-511c-46e7-9159-d4eef994f022,Namespace:kube-system,Attempt:0,}" Aug 12 23:33:24.895565 containerd[1511]: time="2025-08-12T23:33:24.895525849Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-lfhxk,Uid:c0d3233a-1b1a-49fb-8c4a-92d27e5d161a,Namespace:kube-flannel,Attempt:0,}" Aug 12 23:33:25.383405 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2705084300.mount: Deactivated successfully. Aug 12 23:33:25.389044 containerd[1511]: time="2025-08-12T23:33:25.389002073Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 12 23:33:25.390562 containerd[1511]: time="2025-08-12T23:33:25.390531444Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=268705" Aug 12 23:33:25.391162 containerd[1511]: time="2025-08-12T23:33:25.391134007Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 12 23:33:25.392336 containerd[1511]: time="2025-08-12T23:33:25.392248321Z" level=info msg="ImageCreate event name:\"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 12 23:33:25.392950 containerd[1511]: time="2025-08-12T23:33:25.392888346Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Aug 12 23:33:25.394788 containerd[1511]: time="2025-08-12T23:33:25.394699653Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 12 23:33:25.395971 containerd[1511]: time="2025-08-12T23:33:25.395412774Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 509.965587ms" Aug 12 23:33:25.396129 containerd[1511]: time="2025-08-12T23:33:25.396096934Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 496.801026ms" Aug 12 23:33:25.413888 containerd[1511]: time="2025-08-12T23:33:25.413801414Z" level=info msg="connecting to shim fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962" address="unix:///run/containerd/s/8a4a45b15da31692168809a88f1efa915fd64c1a61a15861b17c9fa40f99dfb1" namespace=k8s.io protocol=ttrpc version=3 Aug 12 23:33:25.420069 containerd[1511]: time="2025-08-12T23:33:25.419962437Z" level=info msg="connecting to shim 552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954" address="unix:///run/containerd/s/243e79266dadc053ebc7888c3c129cb6b422298da00e9a02fbd4d8dd8da70981" namespace=k8s.io protocol=ttrpc version=3 Aug 12 23:33:25.436536 systemd[1]: Started cri-containerd-fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962.scope - libcontainer container fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962. Aug 12 23:33:25.439704 systemd[1]: Started cri-containerd-552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954.scope - libcontainer container 552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954. Aug 12 23:33:25.463011 containerd[1511]: time="2025-08-12T23:33:25.462971213Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-tjq9k,Uid:72d74577-511c-46e7-9159-d4eef994f022,Namespace:kube-system,Attempt:0,} returns sandbox id \"fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962\"" Aug 12 23:33:25.464984 containerd[1511]: time="2025-08-12T23:33:25.464946310Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\"" Aug 12 23:33:25.477063 containerd[1511]: time="2025-08-12T23:33:25.477021856Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-lfhxk,Uid:c0d3233a-1b1a-49fb-8c4a-92d27e5d161a,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\"" Aug 12 23:33:25.551786 kubelet[1793]: E0812 23:33:25.551734 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:26.386331 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount279538578.mount: Deactivated successfully. Aug 12 23:33:26.551952 kubelet[1793]: E0812 23:33:26.551901 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:26.600747 containerd[1511]: time="2025-08-12T23:33:26.600699104Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:26.601390 containerd[1511]: time="2025-08-12T23:33:26.601355387Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.11: active requests=0, bytes read=26915995" Aug 12 23:33:26.602372 containerd[1511]: time="2025-08-12T23:33:26.602309473Z" level=info msg="ImageCreate event name:\"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:26.604736 containerd[1511]: time="2025-08-12T23:33:26.604699660Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:26.605409 containerd[1511]: time="2025-08-12T23:33:26.605222547Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.11\" with image id \"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\", repo tag \"registry.k8s.io/kube-proxy:v1.31.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\", size \"26915012\" in 1.140229784s" Aug 12 23:33:26.605409 containerd[1511]: time="2025-08-12T23:33:26.605258848Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\" returns image reference \"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\"" Aug 12 23:33:26.606547 containerd[1511]: time="2025-08-12T23:33:26.606517776Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 12 23:33:26.608157 containerd[1511]: time="2025-08-12T23:33:26.608126912Z" level=info msg="CreateContainer within sandbox \"fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 12 23:33:26.617387 containerd[1511]: time="2025-08-12T23:33:26.616908795Z" level=info msg="Container 74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:26.623861 containerd[1511]: time="2025-08-12T23:33:26.623816459Z" level=info msg="CreateContainer within sandbox \"fed2f48d33e382ddc5cf6093f029fca10b383ad878a85d480f443103cc18b962\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332\"" Aug 12 23:33:26.626317 containerd[1511]: time="2025-08-12T23:33:26.626271495Z" level=info msg="StartContainer for \"74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332\"" Aug 12 23:33:26.627908 containerd[1511]: time="2025-08-12T23:33:26.627875820Z" level=info msg="connecting to shim 74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332" address="unix:///run/containerd/s/8a4a45b15da31692168809a88f1efa915fd64c1a61a15861b17c9fa40f99dfb1" protocol=ttrpc version=3 Aug 12 23:33:26.651534 systemd[1]: Started cri-containerd-74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332.scope - libcontainer container 74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332. Aug 12 23:33:26.685240 containerd[1511]: time="2025-08-12T23:33:26.684611367Z" level=info msg="StartContainer for \"74970a8b06d8e88c33dbb3f1b93c42a3051f349de7651153378e43827befa332\" returns successfully" Aug 12 23:33:27.552297 kubelet[1793]: E0812 23:33:27.552241 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:27.730986 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2628605876.mount: Deactivated successfully. Aug 12 23:33:27.804964 containerd[1511]: time="2025-08-12T23:33:27.804859593Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:27.805919 containerd[1511]: time="2025-08-12T23:33:27.805704578Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532" Aug 12 23:33:27.806987 containerd[1511]: time="2025-08-12T23:33:27.806935369Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:27.808919 containerd[1511]: time="2025-08-12T23:33:27.808887038Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:27.809494 containerd[1511]: time="2025-08-12T23:33:27.809466264Z" 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.202915721s" Aug 12 23:33:27.809649 containerd[1511]: time="2025-08-12T23:33:27.809495311Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Aug 12 23:33:27.811808 containerd[1511]: time="2025-08-12T23:33:27.811772385Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 12 23:33:27.817974 containerd[1511]: time="2025-08-12T23:33:27.817368042Z" level=info msg="Container b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:27.823613 containerd[1511]: time="2025-08-12T23:33:27.823568311Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\"" Aug 12 23:33:27.824234 containerd[1511]: time="2025-08-12T23:33:27.824212554Z" level=info msg="StartContainer for \"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\"" Aug 12 23:33:27.825001 containerd[1511]: time="2025-08-12T23:33:27.824978038Z" level=info msg="connecting to shim b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7" address="unix:///run/containerd/s/243e79266dadc053ebc7888c3c129cb6b422298da00e9a02fbd4d8dd8da70981" protocol=ttrpc version=3 Aug 12 23:33:27.842562 systemd[1]: Started cri-containerd-b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7.scope - libcontainer container b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7. Aug 12 23:33:27.873698 containerd[1511]: time="2025-08-12T23:33:27.873659084Z" level=info msg="StartContainer for \"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\" returns successfully" Aug 12 23:33:27.876119 systemd[1]: cri-containerd-b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7.scope: Deactivated successfully. Aug 12 23:33:27.877672 containerd[1511]: time="2025-08-12T23:33:27.877564930Z" level=info msg="received exit event container_id:\"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\" id:\"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\" pid:2126 exited_at:{seconds:1755041607 nanos:876974404}" Aug 12 23:33:27.877848 containerd[1511]: time="2025-08-12T23:33:27.877635399Z" level=info msg="TaskExit event in podsandbox handler container_id:\"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\" id:\"b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7\" pid:2126 exited_at:{seconds:1755041607 nanos:876974404}" Aug 12 23:33:27.893318 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b2cbda8a7881ec49b5d27edcddb8c75c3a7ea09aed852965dd379f6d9d1dade7-rootfs.mount: Deactivated successfully. Aug 12 23:33:28.552882 kubelet[1793]: E0812 23:33:28.552837 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:28.714123 containerd[1511]: time="2025-08-12T23:33:28.714088442Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 12 23:33:28.723641 kubelet[1793]: I0812 23:33:28.723579 1793 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-tjq9k" podStartSLOduration=4.581716527 podStartE2EDuration="5.723563876s" podCreationTimestamp="2025-08-12 23:33:23 +0000 UTC" firstStartedPulling="2025-08-12 23:33:25.464470154 +0000 UTC m=+2.695720399" lastFinishedPulling="2025-08-12 23:33:26.606317504 +0000 UTC m=+3.837567748" observedRunningTime="2025-08-12 23:33:26.722427722 +0000 UTC m=+3.953677967" watchObservedRunningTime="2025-08-12 23:33:28.723563876 +0000 UTC m=+5.954814121" Aug 12 23:33:29.553605 kubelet[1793]: E0812 23:33:29.553563 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:29.918501 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4059487233.mount: Deactivated successfully. Aug 12 23:33:30.371858 containerd[1511]: time="2025-08-12T23:33:30.371679969Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:30.372685 containerd[1511]: time="2025-08-12T23:33:30.372651343Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261" Aug 12 23:33:30.373448 containerd[1511]: time="2025-08-12T23:33:30.373428722Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:30.376796 containerd[1511]: time="2025-08-12T23:33:30.376753240Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:30.377965 containerd[1511]: time="2025-08-12T23:33:30.377923115Z" 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.663792176s" Aug 12 23:33:30.378004 containerd[1511]: time="2025-08-12T23:33:30.377970548Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Aug 12 23:33:30.381763 containerd[1511]: time="2025-08-12T23:33:30.381726783Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 12 23:33:30.388939 containerd[1511]: time="2025-08-12T23:33:30.388898296Z" level=info msg="Container 4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:30.394746 containerd[1511]: time="2025-08-12T23:33:30.394690034Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\"" Aug 12 23:33:30.395239 containerd[1511]: time="2025-08-12T23:33:30.395207529Z" level=info msg="StartContainer for \"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\"" Aug 12 23:33:30.396053 containerd[1511]: time="2025-08-12T23:33:30.396019506Z" level=info msg="connecting to shim 4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46" address="unix:///run/containerd/s/243e79266dadc053ebc7888c3c129cb6b422298da00e9a02fbd4d8dd8da70981" protocol=ttrpc version=3 Aug 12 23:33:30.420561 systemd[1]: Started cri-containerd-4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46.scope - libcontainer container 4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46. Aug 12 23:33:30.446914 containerd[1511]: time="2025-08-12T23:33:30.446876341Z" level=info msg="StartContainer for \"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\" returns successfully" Aug 12 23:33:30.452134 systemd[1]: cri-containerd-4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46.scope: Deactivated successfully. Aug 12 23:33:30.453398 containerd[1511]: time="2025-08-12T23:33:30.453344215Z" level=info msg="received exit event container_id:\"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\" id:\"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\" pid:2200 exited_at:{seconds:1755041610 nanos:453138261}" Aug 12 23:33:30.453693 containerd[1511]: time="2025-08-12T23:33:30.453661297Z" level=info msg="TaskExit event in podsandbox handler container_id:\"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\" id:\"4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46\" pid:2200 exited_at:{seconds:1755041610 nanos:453138261}" Aug 12 23:33:30.457487 kubelet[1793]: I0812 23:33:30.457405 1793 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Aug 12 23:33:30.554291 kubelet[1793]: E0812 23:33:30.554235 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:30.720226 containerd[1511]: time="2025-08-12T23:33:30.720121023Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 12 23:33:30.729733 containerd[1511]: time="2025-08-12T23:33:30.729527097Z" level=info msg="Container 1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:30.735870 containerd[1511]: time="2025-08-12T23:33:30.735817596Z" level=info msg="CreateContainer within sandbox \"552e4b7850b331011ac48a5b69dba7a646231d0d5bcf956529e7cf6c30d92954\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64\"" Aug 12 23:33:30.736504 containerd[1511]: time="2025-08-12T23:33:30.736478107Z" level=info msg="StartContainer for \"1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64\"" Aug 12 23:33:30.737684 containerd[1511]: time="2025-08-12T23:33:30.737658107Z" level=info msg="connecting to shim 1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64" address="unix:///run/containerd/s/243e79266dadc053ebc7888c3c129cb6b422298da00e9a02fbd4d8dd8da70981" protocol=ttrpc version=3 Aug 12 23:33:30.756548 systemd[1]: Started cri-containerd-1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64.scope - libcontainer container 1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64. Aug 12 23:33:30.784741 containerd[1511]: time="2025-08-12T23:33:30.784699237Z" level=info msg="StartContainer for \"1b4b0223c92fb65772d1b77c16bf4e6275c56d88f9812c6c3c0dbc01f403ae64\" returns successfully" Aug 12 23:33:30.850281 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-4fbf70b59c69cbaeb6ef564e1d80f8e92864ef26b3570f325113d81589a2ea46-rootfs.mount: Deactivated successfully. Aug 12 23:33:31.555098 kubelet[1793]: E0812 23:33:31.555037 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:31.732914 kubelet[1793]: I0812 23:33:31.732842 1793 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-lfhxk" podStartSLOduration=3.830653189 podStartE2EDuration="8.732823023s" podCreationTimestamp="2025-08-12 23:33:23 +0000 UTC" firstStartedPulling="2025-08-12 23:33:25.478222494 +0000 UTC m=+2.709472739" lastFinishedPulling="2025-08-12 23:33:30.380392328 +0000 UTC m=+7.611642573" observedRunningTime="2025-08-12 23:33:31.732617936 +0000 UTC m=+8.963868181" watchObservedRunningTime="2025-08-12 23:33:31.732823023 +0000 UTC m=+8.964073268" Aug 12 23:33:31.857900 systemd-networkd[1441]: flannel.1: Link UP Aug 12 23:33:31.857906 systemd-networkd[1441]: flannel.1: Gained carrier Aug 12 23:33:32.555649 kubelet[1793]: E0812 23:33:32.555597 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:33.556459 kubelet[1793]: E0812 23:33:33.556413 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:33.607482 systemd-networkd[1441]: flannel.1: Gained IPv6LL Aug 12 23:33:34.557441 kubelet[1793]: E0812 23:33:34.557388 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:35.156786 systemd[1]: Created slice kubepods-besteffort-podedc51823_9ed2_443d_970f_cc8b2dd89e45.slice - libcontainer container kubepods-besteffort-podedc51823_9ed2_443d_970f_cc8b2dd89e45.slice. Aug 12 23:33:35.226210 kubelet[1793]: I0812 23:33:35.226141 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2lxwr\" (UniqueName: \"kubernetes.io/projected/edc51823-9ed2-443d-970f-cc8b2dd89e45-kube-api-access-2lxwr\") pod \"nginx-deployment-8587fbcb89-gh764\" (UID: \"edc51823-9ed2-443d-970f-cc8b2dd89e45\") " pod="default/nginx-deployment-8587fbcb89-gh764" Aug 12 23:33:35.460051 containerd[1511]: time="2025-08-12T23:33:35.459922261Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-gh764,Uid:edc51823-9ed2-443d-970f-cc8b2dd89e45,Namespace:default,Attempt:0,}" Aug 12 23:33:35.517282 systemd-networkd[1441]: cni0: Link UP Aug 12 23:33:35.517287 systemd-networkd[1441]: cni0: Gained carrier Aug 12 23:33:35.518557 systemd-networkd[1441]: cni0: Lost carrier Aug 12 23:33:35.525197 systemd-networkd[1441]: veth745fe70f: Link UP Aug 12 23:33:35.525594 kernel: cni0: port 1(veth745fe70f) entered blocking state Aug 12 23:33:35.525648 kernel: cni0: port 1(veth745fe70f) entered disabled state Aug 12 23:33:35.525664 kernel: veth745fe70f: entered allmulticast mode Aug 12 23:33:35.526446 kernel: veth745fe70f: entered promiscuous mode Aug 12 23:33:35.537569 kernel: cni0: port 1(veth745fe70f) entered blocking state Aug 12 23:33:35.537653 kernel: cni0: port 1(veth745fe70f) entered forwarding state Aug 12 23:33:35.538101 systemd-networkd[1441]: veth745fe70f: Gained carrier Aug 12 23:33:35.538790 systemd-networkd[1441]: cni0: Gained carrier Aug 12 23:33:35.539995 containerd[1511]: 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"} Aug 12 23:33:35.539995 containerd[1511]: delegateAdd: netconf sent to delegate plugin: Aug 12 23:33:35.558173 kubelet[1793]: E0812 23:33:35.558124 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:35.568372 containerd[1511]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-08-12T23:33:35.568312568Z" level=info msg="connecting to shim 79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01" address="unix:///run/containerd/s/1e59ca0353305d8c8b5319a57c088517ced95028ec777905dbd374ab0b38138f" namespace=k8s.io protocol=ttrpc version=3 Aug 12 23:33:35.590542 systemd[1]: Started cri-containerd-79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01.scope - libcontainer container 79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01. Aug 12 23:33:35.600457 systemd-resolved[1354]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 12 23:33:35.618624 containerd[1511]: time="2025-08-12T23:33:35.618584205Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-gh764,Uid:edc51823-9ed2-443d-970f-cc8b2dd89e45,Namespace:default,Attempt:0,} returns sandbox id \"79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01\"" Aug 12 23:33:35.620204 containerd[1511]: time="2025-08-12T23:33:35.620145865Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 12 23:33:36.558907 kubelet[1793]: E0812 23:33:36.558861 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:36.746306 systemd-networkd[1441]: veth745fe70f: Gained IPv6LL Aug 12 23:33:37.319891 systemd-networkd[1441]: cni0: Gained IPv6LL Aug 12 23:33:37.560017 kubelet[1793]: E0812 23:33:37.559973 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:37.647576 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4289332916.mount: Deactivated successfully. Aug 12 23:33:38.326664 containerd[1511]: time="2025-08-12T23:33:38.326607814Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:38.327870 containerd[1511]: time="2025-08-12T23:33:38.327802250Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69963857" Aug 12 23:33:38.329390 containerd[1511]: time="2025-08-12T23:33:38.328729130Z" level=info msg="ImageCreate event name:\"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:38.331343 containerd[1511]: time="2025-08-12T23:33:38.331312247Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:38.332468 containerd[1511]: time="2025-08-12T23:33:38.332442721Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"69963735\" in 2.712262068s" Aug 12 23:33:38.332575 containerd[1511]: time="2025-08-12T23:33:38.332557342Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 12 23:33:38.334409 containerd[1511]: time="2025-08-12T23:33:38.334380099Z" level=info msg="CreateContainer within sandbox \"79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 12 23:33:38.341253 containerd[1511]: time="2025-08-12T23:33:38.341211881Z" level=info msg="Container 46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:38.343992 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4095973055.mount: Deactivated successfully. Aug 12 23:33:38.346513 containerd[1511]: time="2025-08-12T23:33:38.346476876Z" level=info msg="CreateContainer within sandbox \"79af2b4778ed01e18db9f2eb42b70f50e9bdb40d4dc1281ab5b6c0604c3ffb01\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb\"" Aug 12 23:33:38.347114 containerd[1511]: time="2025-08-12T23:33:38.347081905Z" level=info msg="StartContainer for \"46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb\"" Aug 12 23:33:38.347839 containerd[1511]: time="2025-08-12T23:33:38.347812022Z" level=info msg="connecting to shim 46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb" address="unix:///run/containerd/s/1e59ca0353305d8c8b5319a57c088517ced95028ec777905dbd374ab0b38138f" protocol=ttrpc version=3 Aug 12 23:33:38.366527 systemd[1]: Started cri-containerd-46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb.scope - libcontainer container 46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb. Aug 12 23:33:38.390655 containerd[1511]: time="2025-08-12T23:33:38.389423283Z" level=info msg="StartContainer for \"46c3f12c3389f5eb90ba7e03fb4f4c43e10290cb0e86a62f3a26d15ea459ebdb\" returns successfully" Aug 12 23:33:38.561141 kubelet[1793]: E0812 23:33:38.561090 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:38.758801 kubelet[1793]: I0812 23:33:38.758337 1793 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-gh764" podStartSLOduration=1.044951988 podStartE2EDuration="3.758319166s" podCreationTimestamp="2025-08-12 23:33:35 +0000 UTC" firstStartedPulling="2025-08-12 23:33:35.619905579 +0000 UTC m=+12.851155824" lastFinishedPulling="2025-08-12 23:33:38.333272757 +0000 UTC m=+15.564523002" observedRunningTime="2025-08-12 23:33:38.758294715 +0000 UTC m=+15.989544960" watchObservedRunningTime="2025-08-12 23:33:38.758319166 +0000 UTC m=+15.989569411" Aug 12 23:33:39.561267 kubelet[1793]: E0812 23:33:39.561203 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:40.562354 kubelet[1793]: E0812 23:33:40.562311 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:41.562929 kubelet[1793]: E0812 23:33:41.562884 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:42.012399 systemd[1]: Created slice kubepods-besteffort-pod8f495a4f_d0a4_4a00_a73a_0aa8a4e2eeaa.slice - libcontainer container kubepods-besteffort-pod8f495a4f_d0a4_4a00_a73a_0aa8a4e2eeaa.slice. Aug 12 23:33:42.058104 kubelet[1793]: I0812 23:33:42.058007 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa-data\") pod \"nfs-server-provisioner-0\" (UID: \"8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa\") " pod="default/nfs-server-provisioner-0" Aug 12 23:33:42.058104 kubelet[1793]: I0812 23:33:42.058049 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-4ntkr\" (UniqueName: \"kubernetes.io/projected/8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa-kube-api-access-4ntkr\") pod \"nfs-server-provisioner-0\" (UID: \"8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa\") " pod="default/nfs-server-provisioner-0" Aug 12 23:33:42.315187 containerd[1511]: time="2025-08-12T23:33:42.315083249Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa,Namespace:default,Attempt:0,}" Aug 12 23:33:42.330563 systemd-networkd[1441]: veth29c6550c: Link UP Aug 12 23:33:42.332476 kernel: cni0: port 2(veth29c6550c) entered blocking state Aug 12 23:33:42.332577 kernel: cni0: port 2(veth29c6550c) entered disabled state Aug 12 23:33:42.332593 kernel: veth29c6550c: entered allmulticast mode Aug 12 23:33:42.332609 kernel: veth29c6550c: entered promiscuous mode Aug 12 23:33:42.337850 kernel: cni0: port 2(veth29c6550c) entered blocking state Aug 12 23:33:42.337902 kernel: cni0: port 2(veth29c6550c) entered forwarding state Aug 12 23:33:42.338031 systemd-networkd[1441]: veth29c6550c: Gained carrier Aug 12 23:33:42.340839 containerd[1511]: 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)(0x4000016938), "name":"cbr0", "type":"bridge"} Aug 12 23:33:42.340839 containerd[1511]: delegateAdd: netconf sent to delegate plugin: Aug 12 23:33:42.361669 containerd[1511]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-08-12T23:33:42.361632802Z" level=info msg="connecting to shim 60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54" address="unix:///run/containerd/s/92ceae52edf37f279e6f60a4e7144c28a2deacce309285e0a1075400bad0cdc4" namespace=k8s.io protocol=ttrpc version=3 Aug 12 23:33:42.384492 systemd[1]: Started cri-containerd-60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54.scope - libcontainer container 60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54. Aug 12 23:33:42.393864 systemd-resolved[1354]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 12 23:33:42.411278 containerd[1511]: time="2025-08-12T23:33:42.411243027Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:8f495a4f-d0a4-4a00-a73a-0aa8a4e2eeaa,Namespace:default,Attempt:0,} returns sandbox id \"60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54\"" Aug 12 23:33:42.412993 containerd[1511]: time="2025-08-12T23:33:42.412961810Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 12 23:33:42.563774 kubelet[1793]: E0812 23:33:42.563717 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:43.465447 systemd-networkd[1441]: veth29c6550c: Gained IPv6LL Aug 12 23:33:43.550954 kubelet[1793]: E0812 23:33:43.550920 1793 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:43.564507 kubelet[1793]: E0812 23:33:43.564467 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:44.565058 kubelet[1793]: E0812 23:33:44.565010 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:44.816807 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount725062039.mount: Deactivated successfully. Aug 12 23:33:45.565999 kubelet[1793]: E0812 23:33:45.565947 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:46.095883 containerd[1511]: time="2025-08-12T23:33:46.095827272Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:46.096409 containerd[1511]: time="2025-08-12T23:33:46.096379621Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625" Aug 12 23:33:46.097346 containerd[1511]: time="2025-08-12T23:33:46.097306231Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:46.102472 containerd[1511]: time="2025-08-12T23:33:46.102423947Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:46.103278 containerd[1511]: time="2025-08-12T23:33:46.103249712Z" 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.690246285s" Aug 12 23:33:46.103329 containerd[1511]: time="2025-08-12T23:33:46.103282353Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Aug 12 23:33:46.105693 containerd[1511]: time="2025-08-12T23:33:46.105658042Z" level=info msg="CreateContainer within sandbox \"60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 12 23:33:46.112239 containerd[1511]: time="2025-08-12T23:33:46.112202514Z" level=info msg="Container 545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:46.119871 containerd[1511]: time="2025-08-12T23:33:46.119826965Z" level=info msg="CreateContainer within sandbox \"60b91f29b18f9356476cdb9437d230c005c02c2b478704488c96b3f91ba16d54\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52\"" Aug 12 23:33:46.120585 containerd[1511]: time="2025-08-12T23:33:46.120245268Z" level=info msg="StartContainer for \"545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52\"" Aug 12 23:33:46.121150 containerd[1511]: time="2025-08-12T23:33:46.121126675Z" level=info msg="connecting to shim 545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52" address="unix:///run/containerd/s/92ceae52edf37f279e6f60a4e7144c28a2deacce309285e0a1075400bad0cdc4" protocol=ttrpc version=3 Aug 12 23:33:46.138509 systemd[1]: Started cri-containerd-545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52.scope - libcontainer container 545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52. Aug 12 23:33:46.162296 containerd[1511]: time="2025-08-12T23:33:46.162255253Z" level=info msg="StartContainer for \"545f0647e00131e6dd99badc0f7029e7006f86e5cb3755b34b14dfd006eb7b52\" returns successfully" Aug 12 23:33:46.566369 kubelet[1793]: E0812 23:33:46.566320 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:46.771430 kubelet[1793]: I0812 23:33:46.771344 1793 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.079323961 podStartE2EDuration="5.771325447s" podCreationTimestamp="2025-08-12 23:33:41 +0000 UTC" firstStartedPulling="2025-08-12 23:33:42.412347605 +0000 UTC m=+19.643597850" lastFinishedPulling="2025-08-12 23:33:46.104349091 +0000 UTC m=+23.335599336" observedRunningTime="2025-08-12 23:33:46.771289805 +0000 UTC m=+24.002540050" watchObservedRunningTime="2025-08-12 23:33:46.771325447 +0000 UTC m=+24.002575692" Aug 12 23:33:47.566948 kubelet[1793]: E0812 23:33:47.566901 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:48.567494 kubelet[1793]: E0812 23:33:48.567444 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:49.568146 kubelet[1793]: E0812 23:33:49.568096 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:50.568233 kubelet[1793]: E0812 23:33:50.568190 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:51.568955 kubelet[1793]: E0812 23:33:51.568877 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:52.569634 kubelet[1793]: E0812 23:33:52.569599 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:53.570677 kubelet[1793]: E0812 23:33:53.570638 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:54.571783 kubelet[1793]: E0812 23:33:54.571731 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:55.572567 kubelet[1793]: E0812 23:33:55.572526 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:56.389900 systemd[1]: Created slice kubepods-besteffort-pod3c6895b4_39d0_4316_81cc_dcafdc168a2c.slice - libcontainer container kubepods-besteffort-pod3c6895b4_39d0_4316_81cc_dcafdc168a2c.slice. Aug 12 23:33:56.437555 kubelet[1793]: I0812 23:33:56.437493 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-dca43095-c6a0-4b7a-b043-eecf558f21e1\" (UniqueName: \"kubernetes.io/nfs/3c6895b4-39d0-4316-81cc-dcafdc168a2c-pvc-dca43095-c6a0-4b7a-b043-eecf558f21e1\") pod \"test-pod-1\" (UID: \"3c6895b4-39d0-4316-81cc-dcafdc168a2c\") " pod="default/test-pod-1" Aug 12 23:33:56.437555 kubelet[1793]: I0812 23:33:56.437537 1793 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-pzd9r\" (UniqueName: \"kubernetes.io/projected/3c6895b4-39d0-4316-81cc-dcafdc168a2c-kube-api-access-pzd9r\") pod \"test-pod-1\" (UID: \"3c6895b4-39d0-4316-81cc-dcafdc168a2c\") " pod="default/test-pod-1" Aug 12 23:33:56.566404 kernel: netfs: FS-Cache loaded Aug 12 23:33:56.572775 kubelet[1793]: E0812 23:33:56.572739 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:56.597420 kernel: RPC: Registered named UNIX socket transport module. Aug 12 23:33:56.597521 kernel: RPC: Registered udp transport module. Aug 12 23:33:56.597539 kernel: RPC: Registered tcp transport module. Aug 12 23:33:56.598808 kernel: RPC: Registered tcp-with-tls transport module. Aug 12 23:33:56.598859 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 12 23:33:56.779577 kernel: NFS: Registering the id_resolver key type Aug 12 23:33:56.779725 kernel: Key type id_resolver registered Aug 12 23:33:56.779745 kernel: Key type id_legacy registered Aug 12 23:33:56.816062 nfsidmap[2807]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Aug 12 23:33:56.819226 nfsidmap[2807]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 12 23:33:56.820466 nfsidmap[2808]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Aug 12 23:33:56.820595 nfsidmap[2808]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 12 23:33:56.827598 nfsrahead[2810]: setting /var/lib/kubelet/pods/3c6895b4-39d0-4316-81cc-dcafdc168a2c/volumes/kubernetes.io~nfs/pvc-dca43095-c6a0-4b7a-b043-eecf558f21e1 readahead to 128 Aug 12 23:33:56.993066 containerd[1511]: time="2025-08-12T23:33:56.993023438Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:3c6895b4-39d0-4316-81cc-dcafdc168a2c,Namespace:default,Attempt:0,}" Aug 12 23:33:57.004621 systemd-networkd[1441]: veth14506c26: Link UP Aug 12 23:33:57.005757 kernel: cni0: port 3(veth14506c26) entered blocking state Aug 12 23:33:57.005799 kernel: cni0: port 3(veth14506c26) entered disabled state Aug 12 23:33:57.006373 kernel: veth14506c26: entered allmulticast mode Aug 12 23:33:57.006457 kernel: veth14506c26: entered promiscuous mode Aug 12 23:33:57.011428 kernel: cni0: port 3(veth14506c26) entered blocking state Aug 12 23:33:57.011645 kernel: cni0: port 3(veth14506c26) entered forwarding state Aug 12 23:33:57.011517 systemd-networkd[1441]: veth14506c26: Gained carrier Aug 12 23:33:57.015707 containerd[1511]: 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)(0x4000012938), "name":"cbr0", "type":"bridge"} Aug 12 23:33:57.015707 containerd[1511]: delegateAdd: netconf sent to delegate plugin: Aug 12 23:33:57.034941 containerd[1511]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-08-12T23:33:57.034598080Z" level=info msg="connecting to shim 1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623" address="unix:///run/containerd/s/de4432c8bc648649684fcd9623378613f42bfe2afae6abe25a8b86fdec957e96" namespace=k8s.io protocol=ttrpc version=3 Aug 12 23:33:57.057521 systemd[1]: Started cri-containerd-1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623.scope - libcontainer container 1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623. Aug 12 23:33:57.068276 systemd-resolved[1354]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 12 23:33:57.089566 containerd[1511]: time="2025-08-12T23:33:57.089528143Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:3c6895b4-39d0-4316-81cc-dcafdc168a2c,Namespace:default,Attempt:0,} returns sandbox id \"1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623\"" Aug 12 23:33:57.091228 containerd[1511]: time="2025-08-12T23:33:57.091201033Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 12 23:33:57.353016 containerd[1511]: time="2025-08-12T23:33:57.352904687Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 12 23:33:57.353411 containerd[1511]: time="2025-08-12T23:33:57.353280298Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Aug 12 23:33:57.356269 containerd[1511]: time="2025-08-12T23:33:57.356235425Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"69963735\" in 264.909469ms" Aug 12 23:33:57.356269 containerd[1511]: time="2025-08-12T23:33:57.356272946Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 12 23:33:57.358446 containerd[1511]: time="2025-08-12T23:33:57.358091840Z" level=info msg="CreateContainer within sandbox \"1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 12 23:33:57.364655 containerd[1511]: time="2025-08-12T23:33:57.364632193Z" level=info msg="Container 35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0: CDI devices from CRI Config.CDIDevices: []" Aug 12 23:33:57.370637 containerd[1511]: time="2025-08-12T23:33:57.370600530Z" level=info msg="CreateContainer within sandbox \"1daf90243488b23784e2b854c0e3cb38d1fc1b1247a464bf5c742e679fd5b623\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0\"" Aug 12 23:33:57.371072 containerd[1511]: time="2025-08-12T23:33:57.371037502Z" level=info msg="StartContainer for \"35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0\"" Aug 12 23:33:57.373120 containerd[1511]: time="2025-08-12T23:33:57.373056482Z" level=info msg="connecting to shim 35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0" address="unix:///run/containerd/s/de4432c8bc648649684fcd9623378613f42bfe2afae6abe25a8b86fdec957e96" protocol=ttrpc version=3 Aug 12 23:33:57.390516 systemd[1]: Started cri-containerd-35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0.scope - libcontainer container 35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0. Aug 12 23:33:57.413127 containerd[1511]: time="2025-08-12T23:33:57.413081705Z" level=info msg="StartContainer for \"35a475e7958dcd6f09d5820abb5fd6c365121551612b555ab5ee9d8529d7dbe0\" returns successfully" Aug 12 23:33:57.573832 kubelet[1793]: E0812 23:33:57.573787 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:57.777558 kubelet[1793]: I0812 23:33:57.777494 1793 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=15.511332689 podStartE2EDuration="15.777479394s" podCreationTimestamp="2025-08-12 23:33:42 +0000 UTC" firstStartedPulling="2025-08-12 23:33:57.090800221 +0000 UTC m=+34.322050426" lastFinishedPulling="2025-08-12 23:33:57.356946886 +0000 UTC m=+34.588197131" observedRunningTime="2025-08-12 23:33:57.777147864 +0000 UTC m=+35.008398109" watchObservedRunningTime="2025-08-12 23:33:57.777479394 +0000 UTC m=+35.008729639" Aug 12 23:33:58.247743 systemd-networkd[1441]: veth14506c26: Gained IPv6LL Aug 12 23:33:58.574847 kubelet[1793]: E0812 23:33:58.574726 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 12 23:33:59.483042 update_engine[1499]: I20250812 23:33:59.482479 1499 update_attempter.cc:509] Updating boot flags... Aug 12 23:33:59.575086 kubelet[1793]: E0812 23:33:59.575027 1793 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"