Aug 13 07:13:43.946058 kernel: Linux version 6.6.100-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Aug 12 22:14:58 -00 2025 Aug 13 07:13:43.946085 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 verity.usrhash=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:13:43.946096 kernel: BIOS-provided physical RAM map: Aug 13 07:13:43.946103 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Aug 13 07:13:43.946109 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Aug 13 07:13:43.946115 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Aug 13 07:13:43.946123 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Aug 13 07:13:43.946129 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Aug 13 07:13:43.946136 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Aug 13 07:13:43.946142 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Aug 13 07:13:43.946151 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Aug 13 07:13:43.946158 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Aug 13 07:13:43.946167 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Aug 13 07:13:43.946174 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Aug 13 07:13:43.946184 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Aug 13 07:13:43.946191 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Aug 13 07:13:43.946201 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Aug 13 07:13:43.946208 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Aug 13 07:13:43.946215 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Aug 13 07:13:43.946222 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Aug 13 07:13:43.946228 kernel: NX (Execute Disable) protection: active Aug 13 07:13:43.946235 kernel: APIC: Static calls initialized Aug 13 07:13:43.946242 kernel: efi: EFI v2.7 by EDK II Aug 13 07:13:43.946249 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b674118 Aug 13 07:13:43.946256 kernel: SMBIOS 2.8 present. Aug 13 07:13:43.946263 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Aug 13 07:13:43.946269 kernel: Hypervisor detected: KVM Aug 13 07:13:43.946279 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Aug 13 07:13:43.946286 kernel: kvm-clock: using sched offset of 4577321002 cycles Aug 13 07:13:43.946293 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Aug 13 07:13:43.946300 kernel: tsc: Detected 2794.750 MHz processor Aug 13 07:13:43.946308 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Aug 13 07:13:43.946315 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Aug 13 07:13:43.946322 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x400000000 Aug 13 07:13:43.946329 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Aug 13 07:13:43.946336 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Aug 13 07:13:43.946346 kernel: Using GB pages for direct mapping Aug 13 07:13:43.946353 kernel: Secure boot disabled Aug 13 07:13:43.946361 kernel: ACPI: Early table checksum verification disabled Aug 13 07:13:43.946368 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Aug 13 07:13:43.946379 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Aug 13 07:13:43.946386 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946394 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946404 kernel: ACPI: FACS 0x000000009CBDD000 000040 Aug 13 07:13:43.946411 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946423 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946430 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946440 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 07:13:43.946448 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Aug 13 07:13:43.946455 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Aug 13 07:13:43.946465 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Aug 13 07:13:43.946473 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Aug 13 07:13:43.946480 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Aug 13 07:13:43.946487 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Aug 13 07:13:43.946494 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Aug 13 07:13:43.946501 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Aug 13 07:13:43.946509 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Aug 13 07:13:43.946516 kernel: No NUMA configuration found Aug 13 07:13:43.946525 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Aug 13 07:13:43.946535 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Aug 13 07:13:43.946542 kernel: Zone ranges: Aug 13 07:13:43.946550 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Aug 13 07:13:43.946557 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Aug 13 07:13:43.946564 kernel: Normal empty Aug 13 07:13:43.946571 kernel: Movable zone start for each node Aug 13 07:13:43.946578 kernel: Early memory node ranges Aug 13 07:13:43.946586 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Aug 13 07:13:43.946593 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Aug 13 07:13:43.946600 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Aug 13 07:13:43.946610 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Aug 13 07:13:43.946617 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Aug 13 07:13:43.946624 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Aug 13 07:13:43.946652 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Aug 13 07:13:43.946681 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Aug 13 07:13:43.946691 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Aug 13 07:13:43.946701 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Aug 13 07:13:43.946711 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Aug 13 07:13:43.946721 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Aug 13 07:13:43.946735 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Aug 13 07:13:43.946742 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Aug 13 07:13:43.946750 kernel: ACPI: PM-Timer IO Port: 0x608 Aug 13 07:13:43.946757 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Aug 13 07:13:43.946764 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Aug 13 07:13:43.946771 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Aug 13 07:13:43.946779 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Aug 13 07:13:43.946786 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Aug 13 07:13:43.946793 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Aug 13 07:13:43.946803 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Aug 13 07:13:43.946810 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Aug 13 07:13:43.946818 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Aug 13 07:13:43.946825 kernel: TSC deadline timer available Aug 13 07:13:43.946832 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Aug 13 07:13:43.946839 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Aug 13 07:13:43.946847 kernel: kvm-guest: KVM setup pv remote TLB flush Aug 13 07:13:43.946854 kernel: kvm-guest: setup PV sched yield Aug 13 07:13:43.946862 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Aug 13 07:13:43.946872 kernel: Booting paravirtualized kernel on KVM Aug 13 07:13:43.946879 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Aug 13 07:13:43.946887 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Aug 13 07:13:43.946902 kernel: percpu: Embedded 58 pages/cpu s197096 r8192 d32280 u524288 Aug 13 07:13:43.946910 kernel: pcpu-alloc: s197096 r8192 d32280 u524288 alloc=1*2097152 Aug 13 07:13:43.946918 kernel: pcpu-alloc: [0] 0 1 2 3 Aug 13 07:13:43.946925 kernel: kvm-guest: PV spinlocks enabled Aug 13 07:13:43.946932 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Aug 13 07:13:43.946941 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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 verity.usrhash=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:13:43.946955 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 13 07:13:43.946962 kernel: random: crng init done Aug 13 07:13:43.946970 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 13 07:13:43.946977 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 13 07:13:43.946984 kernel: Fallback order for Node 0: 0 Aug 13 07:13:43.946992 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Aug 13 07:13:43.946999 kernel: Policy zone: DMA32 Aug 13 07:13:43.947006 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 13 07:13:43.947017 kernel: Memory: 2395616K/2567000K available (12288K kernel code, 2295K rwdata, 22748K rodata, 42876K init, 2316K bss, 171124K reserved, 0K cma-reserved) Aug 13 07:13:43.947025 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 13 07:13:43.947032 kernel: ftrace: allocating 37968 entries in 149 pages Aug 13 07:13:43.947039 kernel: ftrace: allocated 149 pages with 4 groups Aug 13 07:13:43.947047 kernel: Dynamic Preempt: voluntary Aug 13 07:13:43.947062 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 13 07:13:43.947073 kernel: rcu: RCU event tracing is enabled. Aug 13 07:13:43.947081 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 13 07:13:43.947089 kernel: Trampoline variant of Tasks RCU enabled. Aug 13 07:13:43.947097 kernel: Rude variant of Tasks RCU enabled. Aug 13 07:13:43.947105 kernel: Tracing variant of Tasks RCU enabled. Aug 13 07:13:43.947113 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 13 07:13:43.947123 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 13 07:13:43.947131 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Aug 13 07:13:43.947141 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 13 07:13:43.947149 kernel: Console: colour dummy device 80x25 Aug 13 07:13:43.947156 kernel: printk: console [ttyS0] enabled Aug 13 07:13:43.947167 kernel: ACPI: Core revision 20230628 Aug 13 07:13:43.947174 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Aug 13 07:13:43.947182 kernel: APIC: Switch to symmetric I/O mode setup Aug 13 07:13:43.947190 kernel: x2apic enabled Aug 13 07:13:43.947197 kernel: APIC: Switched APIC routing to: physical x2apic Aug 13 07:13:43.947205 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Aug 13 07:13:43.947213 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Aug 13 07:13:43.947221 kernel: kvm-guest: setup PV IPIs Aug 13 07:13:43.947228 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Aug 13 07:13:43.947239 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Aug 13 07:13:43.947246 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Aug 13 07:13:43.947254 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Aug 13 07:13:43.947262 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Aug 13 07:13:43.947269 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Aug 13 07:13:43.947277 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Aug 13 07:13:43.947285 kernel: Spectre V2 : Mitigation: Retpolines Aug 13 07:13:43.947293 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Aug 13 07:13:43.947300 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Aug 13 07:13:43.947311 kernel: RETBleed: Mitigation: untrained return thunk Aug 13 07:13:43.947318 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Aug 13 07:13:43.947326 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Aug 13 07:13:43.947334 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Aug 13 07:13:43.947344 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Aug 13 07:13:43.947352 kernel: x86/bugs: return thunk changed Aug 13 07:13:43.947360 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Aug 13 07:13:43.947368 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Aug 13 07:13:43.947378 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Aug 13 07:13:43.947386 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Aug 13 07:13:43.947393 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Aug 13 07:13:43.947401 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Aug 13 07:13:43.947409 kernel: Freeing SMP alternatives memory: 32K Aug 13 07:13:43.947416 kernel: pid_max: default: 32768 minimum: 301 Aug 13 07:13:43.947424 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Aug 13 07:13:43.947431 kernel: landlock: Up and running. Aug 13 07:13:43.947439 kernel: SELinux: Initializing. Aug 13 07:13:43.947449 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:13:43.947457 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 07:13:43.947465 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Aug 13 07:13:43.947473 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:13:43.947480 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:13:43.947488 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Aug 13 07:13:43.947496 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Aug 13 07:13:43.947503 kernel: ... version: 0 Aug 13 07:13:43.947511 kernel: ... bit width: 48 Aug 13 07:13:43.947521 kernel: ... generic registers: 6 Aug 13 07:13:43.947529 kernel: ... value mask: 0000ffffffffffff Aug 13 07:13:43.947536 kernel: ... max period: 00007fffffffffff Aug 13 07:13:43.947544 kernel: ... fixed-purpose events: 0 Aug 13 07:13:43.947552 kernel: ... event mask: 000000000000003f Aug 13 07:13:43.947559 kernel: signal: max sigframe size: 1776 Aug 13 07:13:43.947567 kernel: rcu: Hierarchical SRCU implementation. Aug 13 07:13:43.947575 kernel: rcu: Max phase no-delay instances is 400. Aug 13 07:13:43.947582 kernel: smp: Bringing up secondary CPUs ... Aug 13 07:13:43.947592 kernel: smpboot: x86: Booting SMP configuration: Aug 13 07:13:43.947600 kernel: .... node #0, CPUs: #1 #2 #3 Aug 13 07:13:43.947608 kernel: smp: Brought up 1 node, 4 CPUs Aug 13 07:13:43.947615 kernel: smpboot: Max logical packages: 1 Aug 13 07:13:43.947623 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Aug 13 07:13:43.947630 kernel: devtmpfs: initialized Aug 13 07:13:43.947656 kernel: x86/mm: Memory block size: 128MB Aug 13 07:13:43.947667 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Aug 13 07:13:43.947678 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Aug 13 07:13:43.947693 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Aug 13 07:13:43.947704 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Aug 13 07:13:43.947714 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Aug 13 07:13:43.947724 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 13 07:13:43.947732 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 13 07:13:43.947739 kernel: pinctrl core: initialized pinctrl subsystem Aug 13 07:13:43.947747 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 13 07:13:43.947755 kernel: audit: initializing netlink subsys (disabled) Aug 13 07:13:43.947762 kernel: audit: type=2000 audit(1755069222.906:1): state=initialized audit_enabled=0 res=1 Aug 13 07:13:43.947773 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 13 07:13:43.947781 kernel: thermal_sys: Registered thermal governor 'user_space' Aug 13 07:13:43.947788 kernel: cpuidle: using governor menu Aug 13 07:13:43.947796 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 13 07:13:43.947804 kernel: dca service started, version 1.12.1 Aug 13 07:13:43.947812 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Aug 13 07:13:43.947820 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Aug 13 07:13:43.947827 kernel: PCI: Using configuration type 1 for base access Aug 13 07:13:43.947835 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Aug 13 07:13:43.947845 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 13 07:13:43.947853 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Aug 13 07:13:43.947860 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 13 07:13:43.947868 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Aug 13 07:13:43.947875 kernel: ACPI: Added _OSI(Module Device) Aug 13 07:13:43.947883 kernel: ACPI: Added _OSI(Processor Device) Aug 13 07:13:43.947890 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 13 07:13:43.947906 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 13 07:13:43.947913 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Aug 13 07:13:43.947924 kernel: ACPI: Interpreter enabled Aug 13 07:13:43.947932 kernel: ACPI: PM: (supports S0 S3 S5) Aug 13 07:13:43.947939 kernel: ACPI: Using IOAPIC for interrupt routing Aug 13 07:13:43.947947 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Aug 13 07:13:43.947955 kernel: PCI: Using E820 reservations for host bridge windows Aug 13 07:13:43.947962 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Aug 13 07:13:43.947970 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 13 07:13:43.948227 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 13 07:13:43.948375 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Aug 13 07:13:43.948509 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Aug 13 07:13:43.948519 kernel: PCI host bridge to bus 0000:00 Aug 13 07:13:43.948711 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Aug 13 07:13:43.948838 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Aug 13 07:13:43.948967 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Aug 13 07:13:43.949084 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Aug 13 07:13:43.949210 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Aug 13 07:13:43.949326 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Aug 13 07:13:43.949441 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 13 07:13:43.949596 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Aug 13 07:13:43.949772 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Aug 13 07:13:43.949913 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] Aug 13 07:13:43.950059 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xc1044000-0xc1044fff] Aug 13 07:13:43.950189 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] Aug 13 07:13:43.950315 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Aug 13 07:13:43.950442 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Aug 13 07:13:43.950612 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Aug 13 07:13:43.950775 kernel: pci 0000:00:02.0: reg 0x10: [io 0x6100-0x611f] Aug 13 07:13:43.950916 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xc1043000-0xc1043fff] Aug 13 07:13:43.951050 kernel: pci 0000:00:02.0: reg 0x20: [mem 0x800000000-0x800003fff 64bit pref] Aug 13 07:13:43.951195 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Aug 13 07:13:43.951326 kernel: pci 0000:00:03.0: reg 0x10: [io 0x6000-0x607f] Aug 13 07:13:43.951453 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xc1042000-0xc1042fff] Aug 13 07:13:43.951580 kernel: pci 0000:00:03.0: reg 0x20: [mem 0x800004000-0x800007fff 64bit pref] Aug 13 07:13:43.951788 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Aug 13 07:13:43.951978 kernel: pci 0000:00:04.0: reg 0x10: [io 0x60e0-0x60ff] Aug 13 07:13:43.952154 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xc1041000-0xc1041fff] Aug 13 07:13:43.952443 kernel: pci 0000:00:04.0: reg 0x20: [mem 0x800008000-0x80000bfff 64bit pref] Aug 13 07:13:43.952612 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] Aug 13 07:13:43.952807 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Aug 13 07:13:43.952988 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Aug 13 07:13:43.953189 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Aug 13 07:13:43.953365 kernel: pci 0000:00:1f.2: reg 0x20: [io 0x60c0-0x60df] Aug 13 07:13:43.953545 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xc1040000-0xc1040fff] Aug 13 07:13:43.953876 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Aug 13 07:13:43.955749 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x6080-0x60bf] Aug 13 07:13:43.956986 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Aug 13 07:13:43.957007 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Aug 13 07:13:43.957019 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Aug 13 07:13:43.957030 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Aug 13 07:13:43.957050 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Aug 13 07:13:43.957060 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Aug 13 07:13:43.957071 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Aug 13 07:13:43.957081 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Aug 13 07:13:43.957091 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Aug 13 07:13:43.957102 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Aug 13 07:13:43.957111 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Aug 13 07:13:43.957122 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Aug 13 07:13:43.957132 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Aug 13 07:13:43.957146 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Aug 13 07:13:43.957156 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Aug 13 07:13:43.957166 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Aug 13 07:13:43.957176 kernel: iommu: Default domain type: Translated Aug 13 07:13:43.957187 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Aug 13 07:13:43.957197 kernel: efivars: Registered efivars operations Aug 13 07:13:43.957208 kernel: PCI: Using ACPI for IRQ routing Aug 13 07:13:43.957218 kernel: PCI: pci_cache_line_size set to 64 bytes Aug 13 07:13:43.957229 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Aug 13 07:13:43.957243 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Aug 13 07:13:43.957254 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Aug 13 07:13:43.957265 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Aug 13 07:13:43.957480 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Aug 13 07:13:43.957670 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Aug 13 07:13:43.957837 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Aug 13 07:13:43.957854 kernel: vgaarb: loaded Aug 13 07:13:43.957866 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Aug 13 07:13:43.957878 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Aug 13 07:13:43.957907 kernel: clocksource: Switched to clocksource kvm-clock Aug 13 07:13:43.957919 kernel: VFS: Disk quotas dquot_6.6.0 Aug 13 07:13:43.957930 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 13 07:13:43.957941 kernel: pnp: PnP ACPI init Aug 13 07:13:43.958115 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Aug 13 07:13:43.958129 kernel: pnp: PnP ACPI: found 6 devices Aug 13 07:13:43.958137 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Aug 13 07:13:43.958146 kernel: NET: Registered PF_INET protocol family Aug 13 07:13:43.958158 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 13 07:13:43.958167 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 13 07:13:43.958178 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 13 07:13:43.958189 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 13 07:13:43.958200 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 13 07:13:43.958211 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 13 07:13:43.958223 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:13:43.958233 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 07:13:43.958244 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 13 07:13:43.958258 kernel: NET: Registered PF_XDP protocol family Aug 13 07:13:43.958433 kernel: pci 0000:00:04.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window Aug 13 07:13:43.958597 kernel: pci 0000:00:04.0: BAR 6: assigned [mem 0x9d000000-0x9d03ffff pref] Aug 13 07:13:43.958848 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Aug 13 07:13:43.959063 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Aug 13 07:13:43.959211 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Aug 13 07:13:43.959360 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Aug 13 07:13:43.959490 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Aug 13 07:13:43.959614 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Aug 13 07:13:43.959624 kernel: PCI: CLS 0 bytes, default 64 Aug 13 07:13:43.959650 kernel: Initialise system trusted keyrings Aug 13 07:13:43.959659 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 13 07:13:43.959667 kernel: Key type asymmetric registered Aug 13 07:13:43.959674 kernel: Asymmetric key parser 'x509' registered Aug 13 07:13:43.959682 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Aug 13 07:13:43.959691 kernel: io scheduler mq-deadline registered Aug 13 07:13:43.959699 kernel: io scheduler kyber registered Aug 13 07:13:43.959710 kernel: io scheduler bfq registered Aug 13 07:13:43.959718 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Aug 13 07:13:43.959727 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Aug 13 07:13:43.959734 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Aug 13 07:13:43.959742 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Aug 13 07:13:43.959750 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 13 07:13:43.959758 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Aug 13 07:13:43.959766 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Aug 13 07:13:43.959774 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Aug 13 07:13:43.959785 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Aug 13 07:13:43.959793 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Aug 13 07:13:43.959974 kernel: rtc_cmos 00:04: RTC can wake from S4 Aug 13 07:13:43.960135 kernel: rtc_cmos 00:04: registered as rtc0 Aug 13 07:13:43.960293 kernel: rtc_cmos 00:04: setting system clock to 2025-08-13T07:13:43 UTC (1755069223) Aug 13 07:13:43.960439 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Aug 13 07:13:43.960451 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Aug 13 07:13:43.960459 kernel: efifb: probing for efifb Aug 13 07:13:43.960474 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Aug 13 07:13:43.960484 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Aug 13 07:13:43.960495 kernel: efifb: scrolling: redraw Aug 13 07:13:43.960506 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Aug 13 07:13:43.960517 kernel: Console: switching to colour frame buffer device 100x37 Aug 13 07:13:43.960528 kernel: fb0: EFI VGA frame buffer device Aug 13 07:13:43.960563 kernel: pstore: Using crash dump compression: deflate Aug 13 07:13:43.960578 kernel: pstore: Registered efi_pstore as persistent store backend Aug 13 07:13:43.960589 kernel: NET: Registered PF_INET6 protocol family Aug 13 07:13:43.960602 kernel: Segment Routing with IPv6 Aug 13 07:13:43.960612 kernel: In-situ OAM (IOAM) with IPv6 Aug 13 07:13:43.960620 kernel: NET: Registered PF_PACKET protocol family Aug 13 07:13:43.960628 kernel: Key type dns_resolver registered Aug 13 07:13:43.960651 kernel: IPI shorthand broadcast: enabled Aug 13 07:13:43.960660 kernel: sched_clock: Marking stable (979004473, 122656686)->(1135728926, -34067767) Aug 13 07:13:43.960668 kernel: registered taskstats version 1 Aug 13 07:13:43.960676 kernel: Loading compiled-in X.509 certificates Aug 13 07:13:43.960685 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.100-flatcar: 264e720147fa8df9744bb9dc1c08171c0cb20041' Aug 13 07:13:43.960696 kernel: Key type .fscrypt registered Aug 13 07:13:43.960704 kernel: Key type fscrypt-provisioning registered Aug 13 07:13:43.960712 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 13 07:13:43.960720 kernel: ima: Allocated hash algorithm: sha1 Aug 13 07:13:43.960729 kernel: ima: No architecture policies found Aug 13 07:13:43.960737 kernel: clk: Disabling unused clocks Aug 13 07:13:43.960745 kernel: Freeing unused kernel image (initmem) memory: 42876K Aug 13 07:13:43.960753 kernel: Write protecting the kernel read-only data: 36864k Aug 13 07:13:43.960764 kernel: Freeing unused kernel image (rodata/data gap) memory: 1828K Aug 13 07:13:43.960772 kernel: Run /init as init process Aug 13 07:13:43.960780 kernel: with arguments: Aug 13 07:13:43.960788 kernel: /init Aug 13 07:13:43.960796 kernel: with environment: Aug 13 07:13:43.960804 kernel: HOME=/ Aug 13 07:13:43.960812 kernel: TERM=linux Aug 13 07:13:43.960820 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 13 07:13:43.960834 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 13 07:13:43.960853 systemd[1]: Detected virtualization kvm. Aug 13 07:13:43.960865 systemd[1]: Detected architecture x86-64. Aug 13 07:13:43.960877 systemd[1]: Running in initrd. Aug 13 07:13:43.960888 systemd[1]: No hostname configured, using default hostname. Aug 13 07:13:43.960909 systemd[1]: Hostname set to . Aug 13 07:13:43.960925 systemd[1]: Initializing machine ID from VM UUID. Aug 13 07:13:43.960936 systemd[1]: Queued start job for default target initrd.target. Aug 13 07:13:43.960947 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:13:43.960958 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:13:43.960970 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 13 07:13:43.960981 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:13:43.960993 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 13 07:13:43.961009 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 13 07:13:43.961023 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 13 07:13:43.961035 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 13 07:13:43.961047 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:13:43.961058 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:13:43.961069 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:13:43.961081 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:13:43.961096 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:13:43.961109 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:13:43.961120 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:13:43.961132 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:13:43.961145 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 07:13:43.961157 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 13 07:13:43.961169 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:13:43.961180 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:13:43.961189 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:13:43.961201 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:13:43.961210 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 13 07:13:43.961228 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:13:43.961253 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 13 07:13:43.961267 systemd[1]: Starting systemd-fsck-usr.service... Aug 13 07:13:43.962687 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:13:43.962705 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:13:43.962717 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:43.962737 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 13 07:13:43.962749 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:13:43.962761 systemd[1]: Finished systemd-fsck-usr.service. Aug 13 07:13:43.962773 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 07:13:43.962818 systemd-journald[191]: Collecting audit messages is disabled. Aug 13 07:13:43.962852 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:43.962865 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:13:43.962878 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:13:43.962903 systemd-journald[191]: Journal started Aug 13 07:13:43.962929 systemd-journald[191]: Runtime Journal (/run/log/journal/5da0b44481f940709afd99bdae8763ee) is 6.0M, max 48.3M, 42.2M free. Aug 13 07:13:43.957176 systemd-modules-load[194]: Inserted module 'overlay' Aug 13 07:13:43.965664 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:13:43.967998 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:13:44.076103 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:13:44.077020 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:13:44.083221 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 13 07:13:44.092012 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 13 07:13:44.091265 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:13:44.095420 systemd-modules-load[194]: Inserted module 'br_netfilter' Aug 13 07:13:44.096451 kernel: Bridge firewalling registered Aug 13 07:13:44.096931 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:13:44.099102 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:13:44.106968 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:13:44.115131 dracut-cmdline[219]: dracut-dracut-053 Aug 13 07:13:44.118656 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:13:44.120871 dracut-cmdline[219]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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 verity.usrhash=8b1c4c6202e70eaa8c6477427259ab5e403c8f1de8515605304942a21d23450a Aug 13 07:13:44.133833 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:13:44.168528 systemd-resolved[245]: Positive Trust Anchors: Aug 13 07:13:44.168552 systemd-resolved[245]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:13:44.168594 systemd-resolved[245]: 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 13 07:13:44.180384 systemd-resolved[245]: Defaulting to hostname 'linux'. Aug 13 07:13:44.182864 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:13:44.184166 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:13:44.216685 kernel: SCSI subsystem initialized Aug 13 07:13:44.226677 kernel: Loading iSCSI transport class v2.0-870. Aug 13 07:13:44.238679 kernel: iscsi: registered transport (tcp) Aug 13 07:13:44.262676 kernel: iscsi: registered transport (qla4xxx) Aug 13 07:13:44.262750 kernel: QLogic iSCSI HBA Driver Aug 13 07:13:44.318141 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 13 07:13:44.327990 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 13 07:13:44.356159 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 13 07:13:44.356226 kernel: device-mapper: uevent: version 1.0.3 Aug 13 07:13:44.357182 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 13 07:13:44.400670 kernel: raid6: avx2x4 gen() 30123 MB/s Aug 13 07:13:44.417655 kernel: raid6: avx2x2 gen() 29015 MB/s Aug 13 07:13:44.434742 kernel: raid6: avx2x1 gen() 22792 MB/s Aug 13 07:13:44.434770 kernel: raid6: using algorithm avx2x4 gen() 30123 MB/s Aug 13 07:13:44.452740 kernel: raid6: .... xor() 6737 MB/s, rmw enabled Aug 13 07:13:44.454193 kernel: raid6: using avx2x2 recovery algorithm Aug 13 07:13:44.477667 kernel: xor: automatically using best checksumming function avx Aug 13 07:13:44.647684 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 13 07:13:44.662383 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:13:44.674805 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:13:44.692327 systemd-udevd[413]: Using default interface naming scheme 'v255'. Aug 13 07:13:44.697303 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:13:44.705793 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 13 07:13:44.721177 dracut-pre-trigger[421]: rd.md=0: removing MD RAID activation Aug 13 07:13:44.753084 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:13:44.763790 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:13:44.833522 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:13:44.844119 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 13 07:13:44.854110 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 13 07:13:44.857328 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:13:44.858552 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:13:44.859296 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:13:44.870808 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 13 07:13:44.876670 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Aug 13 07:13:44.878796 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 13 07:13:44.887560 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 13 07:13:44.887597 kernel: GPT:9289727 != 19775487 Aug 13 07:13:44.887613 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 13 07:13:44.887628 kernel: GPT:9289727 != 19775487 Aug 13 07:13:44.887679 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 13 07:13:44.887704 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:13:44.887171 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:13:44.894171 kernel: cryptd: max_cpu_qlen set to 1000 Aug 13 07:13:44.903710 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:13:44.904405 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:13:44.908662 kernel: AVX2 version of gcm_enc/dec engaged. Aug 13 07:13:44.909774 kernel: AES CTR mode by8 optimization enabled Aug 13 07:13:44.909802 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:13:44.914999 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:13:44.916535 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:44.921334 kernel: libata version 3.00 loaded. Aug 13 07:13:44.920257 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:44.929701 kernel: BTRFS: device fsid 6f4baebc-7e60-4ee7-93a9-8bedb08a33ad devid 1 transid 37 /dev/vda3 scanned by (udev-worker) (459) Aug 13 07:13:44.929730 kernel: ahci 0000:00:1f.2: version 3.0 Aug 13 07:13:44.929971 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:44.935335 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Aug 13 07:13:44.938000 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Aug 13 07:13:44.938184 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Aug 13 07:13:44.939671 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (469) Aug 13 07:13:44.947742 kernel: scsi host0: ahci Aug 13 07:13:44.951660 kernel: scsi host1: ahci Aug 13 07:13:44.953651 kernel: scsi host2: ahci Aug 13 07:13:44.954370 kernel: scsi host3: ahci Aug 13 07:13:44.954327 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 13 07:13:44.956282 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:44.962857 kernel: scsi host4: ahci Aug 13 07:13:44.963044 kernel: scsi host5: ahci Aug 13 07:13:44.963195 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Aug 13 07:13:44.963207 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Aug 13 07:13:44.963217 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Aug 13 07:13:44.963232 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Aug 13 07:13:44.964398 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Aug 13 07:13:44.964438 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Aug 13 07:13:44.966809 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 13 07:13:44.969430 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 13 07:13:44.985630 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 13 07:13:44.992914 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 13 07:13:45.018770 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 13 07:13:45.021038 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:13:45.021098 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:45.024411 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:45.027416 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:45.029562 disk-uuid[565]: Primary Header is updated. Aug 13 07:13:45.029562 disk-uuid[565]: Secondary Entries is updated. Aug 13 07:13:45.029562 disk-uuid[565]: Secondary Header is updated. Aug 13 07:13:45.032734 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:13:45.035670 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:13:45.045544 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:45.055066 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 07:13:45.077351 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:13:45.277808 kernel: ata4: SATA link down (SStatus 0 SControl 300) Aug 13 07:13:45.277896 kernel: ata2: SATA link down (SStatus 0 SControl 300) Aug 13 07:13:45.277908 kernel: ata6: SATA link down (SStatus 0 SControl 300) Aug 13 07:13:45.278678 kernel: ata5: SATA link down (SStatus 0 SControl 300) Aug 13 07:13:45.279675 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Aug 13 07:13:45.280661 kernel: ata1: SATA link down (SStatus 0 SControl 300) Aug 13 07:13:45.281672 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Aug 13 07:13:45.281708 kernel: ata3.00: applying bridge limits Aug 13 07:13:45.282663 kernel: ata3.00: configured for UDMA/100 Aug 13 07:13:45.283661 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Aug 13 07:13:45.325242 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Aug 13 07:13:45.325482 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Aug 13 07:13:45.337674 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Aug 13 07:13:46.037331 disk-uuid[567]: The operation has completed successfully. Aug 13 07:13:46.038681 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 07:13:46.067138 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 13 07:13:46.067266 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 13 07:13:46.089988 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 13 07:13:46.095556 sh[595]: Success Aug 13 07:13:46.109678 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Aug 13 07:13:46.144487 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 13 07:13:46.159871 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 13 07:13:46.162614 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 13 07:13:46.181202 kernel: BTRFS info (device dm-0): first mount of filesystem 6f4baebc-7e60-4ee7-93a9-8bedb08a33ad Aug 13 07:13:46.181255 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:13:46.181267 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 13 07:13:46.182198 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 13 07:13:46.183662 kernel: BTRFS info (device dm-0): using free space tree Aug 13 07:13:46.188278 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 13 07:13:46.189454 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 13 07:13:46.201868 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 13 07:13:46.203124 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 13 07:13:46.218928 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:13:46.218991 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:13:46.219006 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:13:46.223013 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:13:46.233492 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 13 07:13:46.235043 kernel: BTRFS info (device vda6): last unmount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:13:46.244677 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 13 07:13:46.252819 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 13 07:13:46.317455 ignition[697]: Ignition 2.19.0 Aug 13 07:13:46.317469 ignition[697]: Stage: fetch-offline Aug 13 07:13:46.317508 ignition[697]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:46.317518 ignition[697]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:46.317625 ignition[697]: parsed url from cmdline: "" Aug 13 07:13:46.317629 ignition[697]: no config URL provided Aug 13 07:13:46.317653 ignition[697]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 07:13:46.317668 ignition[697]: no config at "/usr/lib/ignition/user.ign" Aug 13 07:13:46.317705 ignition[697]: op(1): [started] loading QEMU firmware config module Aug 13 07:13:46.317712 ignition[697]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 13 07:13:46.328476 ignition[697]: op(1): [finished] loading QEMU firmware config module Aug 13 07:13:46.330098 ignition[697]: parsing config with SHA512: 852d3200e25f868cc71f8d2895f39dc4df79aeca96591bb1d89261ac7f36d99a985e25ccf2f5d0bbd405b2201e5a13398a4dc623a726f71cee9583f480037122 Aug 13 07:13:46.333474 unknown[697]: fetched base config from "system" Aug 13 07:13:46.333491 unknown[697]: fetched user config from "qemu" Aug 13 07:13:46.333916 ignition[697]: fetch-offline: fetch-offline passed Aug 13 07:13:46.335801 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:13:46.334005 ignition[697]: Ignition finished successfully Aug 13 07:13:46.349918 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:13:46.351245 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:13:46.373154 systemd-networkd[785]: lo: Link UP Aug 13 07:13:46.373165 systemd-networkd[785]: lo: Gained carrier Aug 13 07:13:46.374887 systemd-networkd[785]: Enumeration completed Aug 13 07:13:46.375027 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:13:46.375429 systemd-networkd[785]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:13:46.375434 systemd-networkd[785]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:13:46.376390 systemd-networkd[785]: eth0: Link UP Aug 13 07:13:46.376395 systemd-networkd[785]: eth0: Gained carrier Aug 13 07:13:46.376403 systemd-networkd[785]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:13:46.377392 systemd[1]: Reached target network.target - Network. Aug 13 07:13:46.379089 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 13 07:13:46.393836 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 13 07:13:46.399741 systemd-networkd[785]: eth0: DHCPv4 address 10.0.0.116/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 07:13:46.407609 ignition[788]: Ignition 2.19.0 Aug 13 07:13:46.407620 ignition[788]: Stage: kargs Aug 13 07:13:46.407793 ignition[788]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:46.407806 ignition[788]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:46.408518 ignition[788]: kargs: kargs passed Aug 13 07:13:46.408565 ignition[788]: Ignition finished successfully Aug 13 07:13:46.412399 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 13 07:13:46.423775 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 13 07:13:46.438615 ignition[797]: Ignition 2.19.0 Aug 13 07:13:46.438627 ignition[797]: Stage: disks Aug 13 07:13:46.438850 ignition[797]: no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:46.438866 ignition[797]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:46.439568 ignition[797]: disks: disks passed Aug 13 07:13:46.441763 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 13 07:13:46.439616 ignition[797]: Ignition finished successfully Aug 13 07:13:46.443102 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 13 07:13:46.444620 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 07:13:46.446774 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:13:46.447779 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:13:46.449472 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:13:46.463872 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 13 07:13:46.479151 systemd-fsck[808]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 13 07:13:46.486622 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 13 07:13:46.500887 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 13 07:13:46.614674 kernel: EXT4-fs (vda9): mounted filesystem 98cc0201-e9ec-4d2c-8a62-5b521bf9317d r/w with ordered data mode. Quota mode: none. Aug 13 07:13:46.615826 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 13 07:13:46.617024 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 13 07:13:46.630724 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:13:46.632574 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 13 07:13:46.633676 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 13 07:13:46.633718 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 13 07:13:46.640835 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (816) Aug 13 07:13:46.633739 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:13:46.645760 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:13:46.645776 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:13:46.645788 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:13:46.643194 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 13 07:13:46.648463 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:13:46.647075 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 13 07:13:46.650850 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:13:46.686743 initrd-setup-root[840]: cut: /sysroot/etc/passwd: No such file or directory Aug 13 07:13:46.688473 systemd-resolved[245]: Detected conflict on linux IN A 10.0.0.116 Aug 13 07:13:46.688494 systemd-resolved[245]: Hostname conflict, changing published hostname from 'linux' to 'linux7'. Aug 13 07:13:46.692607 initrd-setup-root[847]: cut: /sysroot/etc/group: No such file or directory Aug 13 07:13:46.697800 initrd-setup-root[854]: cut: /sysroot/etc/shadow: No such file or directory Aug 13 07:13:46.701888 initrd-setup-root[861]: cut: /sysroot/etc/gshadow: No such file or directory Aug 13 07:13:46.799236 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 13 07:13:46.810819 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 13 07:13:46.812834 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 13 07:13:46.820666 kernel: BTRFS info (device vda6): last unmount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:13:46.840485 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 13 07:13:46.846843 ignition[928]: INFO : Ignition 2.19.0 Aug 13 07:13:46.846843 ignition[928]: INFO : Stage: mount Aug 13 07:13:46.848489 ignition[928]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:46.848489 ignition[928]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:46.848489 ignition[928]: INFO : mount: mount passed Aug 13 07:13:46.848489 ignition[928]: INFO : Ignition finished successfully Aug 13 07:13:46.854333 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 13 07:13:46.866898 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 13 07:13:47.180900 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 13 07:13:47.190080 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 07:13:47.198321 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (942) Aug 13 07:13:47.198361 kernel: BTRFS info (device vda6): first mount of filesystem 7cc37ed4-8461-447f-bee4-dfe5b4695079 Aug 13 07:13:47.198373 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 13 07:13:47.199779 kernel: BTRFS info (device vda6): using free space tree Aug 13 07:13:47.202699 kernel: BTRFS info (device vda6): auto enabling async discard Aug 13 07:13:47.203723 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 07:13:47.236996 ignition[959]: INFO : Ignition 2.19.0 Aug 13 07:13:47.236996 ignition[959]: INFO : Stage: files Aug 13 07:13:47.239051 ignition[959]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:47.239051 ignition[959]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:47.239051 ignition[959]: DEBUG : files: compiled without relabeling support, skipping Aug 13 07:13:47.239051 ignition[959]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 13 07:13:47.239051 ignition[959]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 13 07:13:47.245496 ignition[959]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 13 07:13:47.245496 ignition[959]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 13 07:13:47.245496 ignition[959]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Aug 13 07:13:47.245496 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-x86-64.raw: attempt #1 Aug 13 07:13:47.242685 unknown[959]: wrote ssh authorized keys file for user: core Aug 13 07:13:47.552194 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Aug 13 07:13:48.182817 systemd-networkd[785]: eth0: Gained IPv6LL Aug 13 07:13:48.233263 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Aug 13 07:13:48.233263 ignition[959]: INFO : files: op(8): [started] processing unit "containerd.service" Aug 13 07:13:48.238984 ignition[959]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(8): [finished] processing unit "containerd.service" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Aug 13 07:13:48.241655 ignition[959]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Aug 13 07:13:48.276286 ignition[959]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 07:13:48.285476 ignition[959]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 07:13:48.287160 ignition[959]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Aug 13 07:13:48.288722 ignition[959]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:13:48.290459 ignition[959]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 13 07:13:48.292097 ignition[959]: INFO : files: files passed Aug 13 07:13:48.292885 ignition[959]: INFO : Ignition finished successfully Aug 13 07:13:48.296984 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 13 07:13:48.315787 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 13 07:13:48.318328 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 13 07:13:48.322223 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 13 07:13:48.322356 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 13 07:13:48.338419 initrd-setup-root-after-ignition[987]: grep: /sysroot/oem/oem-release: No such file or directory Aug 13 07:13:48.343359 initrd-setup-root-after-ignition[989]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:13:48.343359 initrd-setup-root-after-ignition[989]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:13:48.347863 initrd-setup-root-after-ignition[993]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 07:13:48.352162 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:13:48.355153 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 13 07:13:48.367954 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 13 07:13:48.399400 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 13 07:13:48.399579 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 13 07:13:48.400399 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 13 07:13:48.404594 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 13 07:13:48.405116 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 13 07:13:48.406283 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 13 07:13:48.428138 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:13:48.434915 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 13 07:13:48.446629 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:13:48.450194 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:13:48.453119 systemd[1]: Stopped target timers.target - Timer Units. Aug 13 07:13:48.454989 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 13 07:13:48.456068 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 07:13:48.458698 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 13 07:13:48.460861 systemd[1]: Stopped target basic.target - Basic System. Aug 13 07:13:48.462787 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 13 07:13:48.465016 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 07:13:48.467544 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 13 07:13:48.469880 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 13 07:13:48.472000 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 07:13:48.474519 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 13 07:13:48.476592 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 13 07:13:48.478613 systemd[1]: Stopped target swap.target - Swaps. Aug 13 07:13:48.480235 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 13 07:13:48.481445 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 13 07:13:48.484079 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:13:48.486871 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:13:48.489525 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 13 07:13:48.490523 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:13:48.493047 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 13 07:13:48.494082 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 13 07:13:48.496300 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 13 07:13:48.497374 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 07:13:48.499674 systemd[1]: Stopped target paths.target - Path Units. Aug 13 07:13:48.501393 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 13 07:13:48.502132 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:13:48.505214 systemd[1]: Stopped target slices.target - Slice Units. Aug 13 07:13:48.505561 systemd[1]: Stopped target sockets.target - Socket Units. Aug 13 07:13:48.506077 systemd[1]: iscsid.socket: Deactivated successfully. Aug 13 07:13:48.506198 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 07:13:48.508791 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 13 07:13:48.508887 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 07:13:48.510425 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 13 07:13:48.510555 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 07:13:48.512331 systemd[1]: ignition-files.service: Deactivated successfully. Aug 13 07:13:48.512449 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 13 07:13:48.523858 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 13 07:13:48.524163 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 13 07:13:48.524291 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:13:48.527052 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 13 07:13:48.528076 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 13 07:13:48.528266 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:13:48.530049 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 13 07:13:48.530172 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 07:13:48.537132 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 13 07:13:48.537275 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 13 07:13:48.552510 ignition[1013]: INFO : Ignition 2.19.0 Aug 13 07:13:48.552510 ignition[1013]: INFO : Stage: umount Aug 13 07:13:48.554306 ignition[1013]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 07:13:48.554306 ignition[1013]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 07:13:48.554306 ignition[1013]: INFO : umount: umount passed Aug 13 07:13:48.554306 ignition[1013]: INFO : Ignition finished successfully Aug 13 07:13:48.555940 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 13 07:13:48.556088 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 13 07:13:48.557597 systemd[1]: Stopped target network.target - Network. Aug 13 07:13:48.558904 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 13 07:13:48.558964 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 13 07:13:48.560831 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 13 07:13:48.560884 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 13 07:13:48.562719 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 13 07:13:48.562779 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 13 07:13:48.564553 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 13 07:13:48.564602 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 13 07:13:48.566460 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 13 07:13:48.568439 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 13 07:13:48.571344 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 13 07:13:48.572739 systemd-networkd[785]: eth0: DHCPv6 lease lost Aug 13 07:13:48.576475 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 13 07:13:48.576683 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 13 07:13:48.578813 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 13 07:13:48.578865 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:13:48.589848 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 13 07:13:48.590728 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 13 07:13:48.590809 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 07:13:48.593001 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:13:48.596472 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 13 07:13:48.596608 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 13 07:13:48.611245 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 13 07:13:48.611502 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:13:48.614075 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 13 07:13:48.614153 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 13 07:13:48.614948 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 13 07:13:48.615004 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:13:48.616970 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 13 07:13:48.617023 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 13 07:13:48.617691 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 13 07:13:48.617748 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 13 07:13:48.618391 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 07:13:48.618451 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 07:13:48.620215 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 13 07:13:48.626391 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 13 07:13:48.626454 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:13:48.627067 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 13 07:13:48.627117 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 13 07:13:48.627366 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 13 07:13:48.627414 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:13:48.627851 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 13 07:13:48.627900 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:13:48.628165 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 07:13:48.628211 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:48.628910 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 13 07:13:48.629042 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 13 07:13:48.702431 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 13 07:13:48.702563 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 13 07:13:48.785505 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 13 07:13:48.785684 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 13 07:13:48.787024 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 13 07:13:48.788424 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 13 07:13:48.788491 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 13 07:13:48.798780 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 13 07:13:48.806867 systemd[1]: Switching root. Aug 13 07:13:48.837139 systemd-journald[191]: Journal stopped Aug 13 07:13:50.228191 systemd-journald[191]: Received SIGTERM from PID 1 (systemd). Aug 13 07:13:50.228261 kernel: SELinux: policy capability network_peer_controls=1 Aug 13 07:13:50.228276 kernel: SELinux: policy capability open_perms=1 Aug 13 07:13:50.228287 kernel: SELinux: policy capability extended_socket_class=1 Aug 13 07:13:50.228298 kernel: SELinux: policy capability always_check_network=0 Aug 13 07:13:50.228318 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 13 07:13:50.228330 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 13 07:13:50.228341 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 13 07:13:50.228358 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 13 07:13:50.228370 kernel: audit: type=1403 audit(1755069229.439:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 13 07:13:50.228394 systemd[1]: Successfully loaded SELinux policy in 40.177ms. Aug 13 07:13:50.228409 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.585ms. Aug 13 07:13:50.228423 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 13 07:13:50.228435 systemd[1]: Detected virtualization kvm. Aug 13 07:13:50.228452 systemd[1]: Detected architecture x86-64. Aug 13 07:13:50.228468 systemd[1]: Detected first boot. Aug 13 07:13:50.228480 systemd[1]: Initializing machine ID from VM UUID. Aug 13 07:13:50.228492 zram_generator::config[1076]: No configuration found. Aug 13 07:13:50.228505 systemd[1]: Populated /etc with preset unit settings. Aug 13 07:13:50.228517 systemd[1]: Queued start job for default target multi-user.target. Aug 13 07:13:50.228529 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 13 07:13:50.228541 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 13 07:13:50.228559 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 13 07:13:50.228571 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 13 07:13:50.228584 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 13 07:13:50.228596 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 13 07:13:50.228608 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 13 07:13:50.228620 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 13 07:13:50.228646 systemd[1]: Created slice user.slice - User and Session Slice. Aug 13 07:13:50.228658 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 07:13:50.228671 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 07:13:50.228694 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 13 07:13:50.228706 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 13 07:13:50.228732 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 13 07:13:50.228744 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 07:13:50.228761 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 13 07:13:50.228778 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 07:13:50.228793 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 13 07:13:50.228808 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 07:13:50.228822 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 07:13:50.228845 systemd[1]: Reached target slices.target - Slice Units. Aug 13 07:13:50.228860 systemd[1]: Reached target swap.target - Swaps. Aug 13 07:13:50.228876 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 13 07:13:50.228888 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 13 07:13:50.228901 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 07:13:50.228914 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 13 07:13:50.228931 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 07:13:50.228947 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 07:13:50.228971 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 07:13:50.228988 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 13 07:13:50.229002 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 13 07:13:50.229014 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 13 07:13:50.229026 systemd[1]: Mounting media.mount - External Media Directory... Aug 13 07:13:50.229038 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:50.229050 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 13 07:13:50.229062 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 13 07:13:50.229075 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 13 07:13:50.229097 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 13 07:13:50.229110 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:13:50.229122 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 07:13:50.229134 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 13 07:13:50.229145 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:13:50.229158 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:13:50.229170 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:13:50.229181 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 13 07:13:50.229198 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:13:50.229211 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 13 07:13:50.229224 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Aug 13 07:13:50.229237 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.) Aug 13 07:13:50.229249 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 07:13:50.229261 kernel: loop: module loaded Aug 13 07:13:50.229272 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 07:13:50.229285 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 13 07:13:50.229302 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 13 07:13:50.229314 kernel: ACPI: bus type drm_connector registered Aug 13 07:13:50.229325 kernel: fuse: init (API version 7.39) Aug 13 07:13:50.229337 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 07:13:50.229349 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:50.229364 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 13 07:13:50.229397 systemd-journald[1168]: Collecting audit messages is disabled. Aug 13 07:13:50.229420 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 13 07:13:50.229438 systemd[1]: Mounted media.mount - External Media Directory. Aug 13 07:13:50.229450 systemd-journald[1168]: Journal started Aug 13 07:13:50.229472 systemd-journald[1168]: Runtime Journal (/run/log/journal/5da0b44481f940709afd99bdae8763ee) is 6.0M, max 48.3M, 42.2M free. Aug 13 07:13:50.231814 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 07:13:50.233426 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 13 07:13:50.234823 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 13 07:13:50.236088 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 13 07:13:50.237595 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 13 07:13:50.239206 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 07:13:50.240964 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 13 07:13:50.241248 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 13 07:13:50.242935 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:13:50.243186 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:13:50.244893 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:13:50.245176 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:13:50.246842 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:13:50.247061 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:13:50.248780 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 13 07:13:50.249058 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 13 07:13:50.250672 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:13:50.250998 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:13:50.252801 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 07:13:50.254386 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 13 07:13:50.256431 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 13 07:13:50.269821 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 13 07:13:50.280828 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 13 07:13:50.283599 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 13 07:13:50.284765 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 13 07:13:50.289804 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 13 07:13:50.292512 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 13 07:13:50.294998 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:13:50.297158 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 13 07:13:50.298460 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:13:50.303199 systemd-journald[1168]: Time spent on flushing to /var/log/journal/5da0b44481f940709afd99bdae8763ee is 21.288ms for 967 entries. Aug 13 07:13:50.303199 systemd-journald[1168]: System Journal (/var/log/journal/5da0b44481f940709afd99bdae8763ee) is 8.0M, max 195.6M, 187.6M free. Aug 13 07:13:50.335732 systemd-journald[1168]: Received client request to flush runtime journal. Aug 13 07:13:50.302842 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 07:13:50.308858 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 07:13:50.313578 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 13 07:13:50.315238 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 13 07:13:50.320727 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 07:13:50.329467 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 13 07:13:50.332200 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 13 07:13:50.338458 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 13 07:13:50.340507 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 13 07:13:50.342318 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 07:13:50.357083 systemd-tmpfiles[1213]: ACLs are not supported, ignoring. Aug 13 07:13:50.357101 systemd-tmpfiles[1213]: ACLs are not supported, ignoring. Aug 13 07:13:50.359514 udevadm[1222]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 13 07:13:50.364855 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 07:13:50.373915 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 13 07:13:50.400992 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 13 07:13:50.409826 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 07:13:50.427908 systemd-tmpfiles[1235]: ACLs are not supported, ignoring. Aug 13 07:13:50.427933 systemd-tmpfiles[1235]: ACLs are not supported, ignoring. Aug 13 07:13:50.434054 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 07:13:50.890997 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 13 07:13:50.903801 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 07:13:50.928505 systemd-udevd[1241]: Using default interface naming scheme 'v255'. Aug 13 07:13:50.947406 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 07:13:50.962328 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 07:13:50.972842 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 13 07:13:51.012664 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1261) Aug 13 07:13:51.042540 systemd[1]: Found device dev-ttyS0.device - /dev/ttyS0. Aug 13 07:13:51.053275 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 13 07:13:51.101810 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Aug 13 07:13:51.105669 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Aug 13 07:13:51.105992 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Aug 13 07:13:51.106408 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Aug 13 07:13:51.106598 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Aug 13 07:13:51.113935 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Aug 13 07:13:51.115753 kernel: ACPI: button: Power Button [PWRF] Aug 13 07:13:51.124126 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 13 07:13:51.145712 kernel: mousedev: PS/2 mouse device common for all mice Aug 13 07:13:51.161931 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 07:13:51.173153 systemd-networkd[1247]: lo: Link UP Aug 13 07:13:51.173162 systemd-networkd[1247]: lo: Gained carrier Aug 13 07:13:51.175135 systemd-networkd[1247]: Enumeration completed Aug 13 07:13:51.175599 systemd-networkd[1247]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:13:51.175604 systemd-networkd[1247]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 07:13:51.175793 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 07:13:51.178046 systemd-networkd[1247]: eth0: Link UP Aug 13 07:13:51.178103 systemd-networkd[1247]: eth0: Gained carrier Aug 13 07:13:51.178152 systemd-networkd[1247]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 07:13:51.182817 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 13 07:13:51.241729 systemd-networkd[1247]: eth0: DHCPv4 address 10.0.0.116/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 07:13:51.253212 kernel: kvm_amd: TSC scaling supported Aug 13 07:13:51.253250 kernel: kvm_amd: Nested Virtualization enabled Aug 13 07:13:51.253263 kernel: kvm_amd: Nested Paging enabled Aug 13 07:13:51.253750 kernel: kvm_amd: LBR virtualization supported Aug 13 07:13:51.254995 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Aug 13 07:13:51.255010 kernel: kvm_amd: Virtual GIF supported Aug 13 07:13:51.278704 kernel: EDAC MC: Ver: 3.0.0 Aug 13 07:13:51.283328 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 07:13:51.323940 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 13 07:13:51.335771 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 13 07:13:51.345867 lvm[1289]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:13:51.379054 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 13 07:13:51.380599 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 07:13:51.400921 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 13 07:13:51.408283 lvm[1292]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 07:13:51.451145 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 13 07:13:51.452690 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 07:13:51.453921 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 13 07:13:51.453948 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 07:13:51.454950 systemd[1]: Reached target machines.target - Containers. Aug 13 07:13:51.457225 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 13 07:13:51.470782 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 13 07:13:51.473417 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 13 07:13:51.474738 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:13:51.475788 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 13 07:13:51.478264 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 13 07:13:51.481908 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 13 07:13:51.484004 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 13 07:13:51.499665 kernel: loop0: detected capacity change from 0 to 140768 Aug 13 07:13:51.501488 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 13 07:13:51.511135 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 13 07:13:51.512183 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 13 07:13:51.522653 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 13 07:13:51.541657 kernel: loop1: detected capacity change from 0 to 142488 Aug 13 07:13:51.572662 kernel: loop2: detected capacity change from 0 to 221472 Aug 13 07:13:51.624681 kernel: loop3: detected capacity change from 0 to 140768 Aug 13 07:13:51.639662 kernel: loop4: detected capacity change from 0 to 142488 Aug 13 07:13:51.648657 kernel: loop5: detected capacity change from 0 to 221472 Aug 13 07:13:51.654284 (sd-merge)[1312]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Aug 13 07:13:51.654966 (sd-merge)[1312]: Merged extensions into '/usr'. Aug 13 07:13:51.659345 systemd[1]: Reloading requested from client PID 1300 ('systemd-sysext') (unit systemd-sysext.service)... Aug 13 07:13:51.659364 systemd[1]: Reloading... Aug 13 07:13:51.705807 zram_generator::config[1337]: No configuration found. Aug 13 07:13:51.822418 ldconfig[1296]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 13 07:13:51.879966 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 13 07:13:51.946166 systemd[1]: Reloading finished in 286 ms. Aug 13 07:13:51.963468 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 13 07:13:51.965160 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 13 07:13:51.988029 systemd[1]: Starting ensure-sysext.service... Aug 13 07:13:51.990847 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 07:13:51.996351 systemd[1]: Reloading requested from client PID 1384 ('systemctl') (unit ensure-sysext.service)... Aug 13 07:13:51.996369 systemd[1]: Reloading... Aug 13 07:13:52.021974 systemd-tmpfiles[1385]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 13 07:13:52.022352 systemd-tmpfiles[1385]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 13 07:13:52.023439 systemd-tmpfiles[1385]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 13 07:13:52.023773 systemd-tmpfiles[1385]: ACLs are not supported, ignoring. Aug 13 07:13:52.023862 systemd-tmpfiles[1385]: ACLs are not supported, ignoring. Aug 13 07:13:52.031128 systemd-tmpfiles[1385]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:13:52.031141 systemd-tmpfiles[1385]: Skipping /boot Aug 13 07:13:52.045478 systemd-tmpfiles[1385]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 07:13:52.045495 systemd-tmpfiles[1385]: Skipping /boot Aug 13 07:13:52.053701 zram_generator::config[1413]: No configuration found. Aug 13 07:13:52.171901 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 13 07:13:52.241068 systemd[1]: Reloading finished in 244 ms. Aug 13 07:13:52.260136 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 07:13:52.284978 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 13 07:13:52.289104 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 13 07:13:52.292394 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 13 07:13:52.298076 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 07:13:52.303155 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 13 07:13:52.307334 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:52.307696 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:13:52.309815 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:13:52.314868 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:13:52.319007 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:13:52.320358 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:13:52.320693 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:52.321930 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:13:52.322233 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:13:52.326121 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:13:52.326383 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:13:52.330258 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:13:52.330568 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:13:52.333308 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 13 07:13:52.346736 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 13 07:13:52.351706 augenrules[1491]: No rules Aug 13 07:13:52.352693 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 13 07:13:52.357106 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:52.357262 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 07:13:52.365842 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 07:13:52.368908 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 07:13:52.372960 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 07:13:52.377988 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 07:13:52.379266 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 07:13:52.382805 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 13 07:13:52.385768 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 13 07:13:52.386617 systemd[1]: Finished ensure-sysext.service. Aug 13 07:13:52.388013 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 13 07:13:52.388843 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 07:13:52.389074 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 07:13:52.391116 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 07:13:52.391347 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 07:13:52.392864 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 07:13:52.393093 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 07:13:52.394864 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 07:13:52.395103 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 07:13:52.401945 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 13 07:13:52.404163 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 07:13:52.404273 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 07:13:52.410799 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 13 07:13:52.412091 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 13 07:13:52.440257 systemd-resolved[1465]: Positive Trust Anchors: Aug 13 07:13:52.440299 systemd-resolved[1465]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 07:13:52.440354 systemd-resolved[1465]: 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 13 07:13:52.447321 systemd-resolved[1465]: Defaulting to hostname 'linux'. Aug 13 07:13:52.450945 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 07:13:52.452491 systemd[1]: Reached target network.target - Network. Aug 13 07:13:52.453619 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 07:13:52.500777 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 13 07:13:52.502396 systemd-timesyncd[1520]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 13 07:13:52.502445 systemd-timesyncd[1520]: Initial clock synchronization to Wed 2025-08-13 07:13:52.822372 UTC. Aug 13 07:13:52.502549 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 07:13:52.503712 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 13 07:13:52.504962 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 13 07:13:52.506198 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 13 07:13:52.507413 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 13 07:13:52.507440 systemd[1]: Reached target paths.target - Path Units. Aug 13 07:13:52.508385 systemd[1]: Reached target time-set.target - System Time Set. Aug 13 07:13:52.509580 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 13 07:13:52.510813 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 13 07:13:52.512180 systemd[1]: Reached target timers.target - Timer Units. Aug 13 07:13:52.514354 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 13 07:13:52.517818 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 13 07:13:52.520932 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 13 07:13:52.533449 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 13 07:13:52.534692 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 07:13:52.535684 systemd[1]: Reached target basic.target - Basic System. Aug 13 07:13:52.536851 systemd[1]: System is tainted: cgroupsv1 Aug 13 07:13:52.536938 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:13:52.536991 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 13 07:13:52.539077 systemd[1]: Starting containerd.service - containerd container runtime... Aug 13 07:13:52.541992 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 13 07:13:52.544395 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 13 07:13:52.548785 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 13 07:13:52.549855 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 13 07:13:52.553790 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 13 07:13:52.555820 jq[1526]: false Aug 13 07:13:52.558826 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 13 07:13:52.563842 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 13 07:13:52.571834 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 13 07:13:52.574940 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 13 07:13:52.583962 systemd[1]: Starting update-engine.service - Update Engine... Aug 13 07:13:52.596480 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 13 07:13:52.604683 extend-filesystems[1527]: Found loop3 Aug 13 07:13:52.604209 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 13 07:13:52.608324 update_engine[1539]: I20250813 07:13:52.607523 1539 main.cc:92] Flatcar Update Engine starting Aug 13 07:13:52.605439 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 13 07:13:52.608695 systemd[1]: motdgen.service: Deactivated successfully. Aug 13 07:13:52.609832 extend-filesystems[1527]: Found loop4 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found loop5 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found sr0 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda1 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda2 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda3 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found usr Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda4 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda6 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda7 Aug 13 07:13:52.609832 extend-filesystems[1527]: Found vda9 Aug 13 07:13:52.609832 extend-filesystems[1527]: Checking size of /dev/vda9 Aug 13 07:13:52.609301 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 13 07:13:52.625764 update_engine[1539]: I20250813 07:13:52.619700 1539 update_check_scheduler.cc:74] Next update check in 3m40s Aug 13 07:13:52.614561 dbus-daemon[1525]: [system] SELinux support is enabled Aug 13 07:13:52.610783 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 13 07:13:52.626238 jq[1545]: true Aug 13 07:13:52.611123 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 13 07:13:52.615403 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 13 07:13:52.642728 jq[1551]: true Aug 13 07:13:52.643807 extend-filesystems[1527]: Resized partition /dev/vda9 Aug 13 07:13:52.649263 extend-filesystems[1561]: resize2fs 1.47.1 (20-May-2024) Aug 13 07:13:52.656166 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 13 07:13:52.658680 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (1248) Aug 13 07:13:52.660171 (ntainerd)[1563]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 13 07:13:52.664900 systemd[1]: Started update-engine.service - Update Engine. Aug 13 07:13:52.668854 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 13 07:13:52.668898 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 13 07:13:52.669351 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 13 07:13:52.669383 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 13 07:13:52.672297 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 13 07:13:52.678703 systemd-logind[1536]: Watching system buttons on /dev/input/event1 (Power Button) Aug 13 07:13:52.678732 systemd-logind[1536]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Aug 13 07:13:52.682384 systemd-logind[1536]: New seat seat0. Aug 13 07:13:52.683898 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 13 07:13:52.695344 systemd[1]: Started systemd-logind.service - User Login Management. Aug 13 07:13:52.699132 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 13 07:13:52.734173 extend-filesystems[1561]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 13 07:13:52.734173 extend-filesystems[1561]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 13 07:13:52.734173 extend-filesystems[1561]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 13 07:13:52.742847 extend-filesystems[1527]: Resized filesystem in /dev/vda9 Aug 13 07:13:52.735401 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 13 07:13:52.736312 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 13 07:13:52.758611 locksmithd[1567]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 13 07:13:52.773078 bash[1588]: Updated "/home/core/.ssh/authorized_keys" Aug 13 07:13:52.775193 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 13 07:13:52.778538 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 13 07:13:52.940989 sshd_keygen[1547]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 13 07:13:52.984016 systemd-networkd[1247]: eth0: Gained IPv6LL Aug 13 07:13:53.200152 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 13 07:13:53.202475 systemd[1]: Reached target network-online.target - Network is Online. Aug 13 07:13:53.211907 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 13 07:13:53.215964 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 07:13:53.220819 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 13 07:13:53.223167 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 13 07:13:53.246706 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 13 07:13:53.248749 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 13 07:13:53.249220 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 13 07:13:53.252770 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 13 07:13:53.256116 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 13 07:13:53.262825 systemd[1]: issuegen.service: Deactivated successfully. Aug 13 07:13:53.263202 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 13 07:13:53.273173 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 13 07:13:53.310131 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 13 07:13:53.322114 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 13 07:13:53.325322 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 13 07:13:53.326636 systemd[1]: Reached target getty.target - Login Prompts. Aug 13 07:13:53.415153 containerd[1563]: time="2025-08-13T07:13:53.415030649Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Aug 13 07:13:53.447661 containerd[1563]: time="2025-08-13T07:13:53.447568184Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.450219 containerd[1563]: time="2025-08-13T07:13:53.450147631Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.100-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:13:53.450219 containerd[1563]: time="2025-08-13T07:13:53.450210060Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 13 07:13:53.450350 containerd[1563]: time="2025-08-13T07:13:53.450238487Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 13 07:13:53.450594 containerd[1563]: time="2025-08-13T07:13:53.450559834Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 13 07:13:53.450618 containerd[1563]: time="2025-08-13T07:13:53.450592804Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.450763 containerd[1563]: time="2025-08-13T07:13:53.450723227Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:13:53.450763 containerd[1563]: time="2025-08-13T07:13:53.450744120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451201 containerd[1563]: time="2025-08-13T07:13:53.451164097Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451201 containerd[1563]: time="2025-08-13T07:13:53.451194202Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451258 containerd[1563]: time="2025-08-13T07:13:53.451230403Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451258 containerd[1563]: time="2025-08-13T07:13:53.451248472Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451458 containerd[1563]: time="2025-08-13T07:13:53.451425298Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.451837 containerd[1563]: time="2025-08-13T07:13:53.451806865Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 13 07:13:53.452088 containerd[1563]: time="2025-08-13T07:13:53.452054236Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 07:13:53.452088 containerd[1563]: time="2025-08-13T07:13:53.452080986Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 13 07:13:53.452297 containerd[1563]: time="2025-08-13T07:13:53.452265325Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 13 07:13:53.452385 containerd[1563]: time="2025-08-13T07:13:53.452364371Z" level=info msg="metadata content store policy set" policy=shared Aug 13 07:13:53.458937 containerd[1563]: time="2025-08-13T07:13:53.458896915Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 13 07:13:53.458981 containerd[1563]: time="2025-08-13T07:13:53.458947037Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 13 07:13:53.458981 containerd[1563]: time="2025-08-13T07:13:53.458964648Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 13 07:13:53.459034 containerd[1563]: time="2025-08-13T07:13:53.458980862Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 13 07:13:53.459034 containerd[1563]: time="2025-08-13T07:13:53.458997400Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 13 07:13:53.459187 containerd[1563]: time="2025-08-13T07:13:53.459147903Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 13 07:13:53.459504 containerd[1563]: time="2025-08-13T07:13:53.459471355Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 13 07:13:53.459629 containerd[1563]: time="2025-08-13T07:13:53.459599933Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 13 07:13:53.459629 containerd[1563]: time="2025-08-13T07:13:53.459621556Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 13 07:13:53.459629 containerd[1563]: time="2025-08-13T07:13:53.459635279Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 13 07:13:53.459712 containerd[1563]: time="2025-08-13T07:13:53.459650232Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459712 containerd[1563]: time="2025-08-13T07:13:53.459666082Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459750 containerd[1563]: time="2025-08-13T07:13:53.459709473Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459750 containerd[1563]: time="2025-08-13T07:13:53.459727302Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459792 containerd[1563]: time="2025-08-13T07:13:53.459750801Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459792 containerd[1563]: time="2025-08-13T07:13:53.459764889Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459792 containerd[1563]: time="2025-08-13T07:13:53.459789054Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459847 containerd[1563]: time="2025-08-13T07:13:53.459802882Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 13 07:13:53.459847 containerd[1563]: time="2025-08-13T07:13:53.459824099Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.459847 containerd[1563]: time="2025-08-13T07:13:53.459836874Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.459914 containerd[1563]: time="2025-08-13T07:13:53.459863780Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.459914 containerd[1563]: time="2025-08-13T07:13:53.459879025Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.459914 containerd[1563]: time="2025-08-13T07:13:53.459891228Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.459914 containerd[1563]: time="2025-08-13T07:13:53.459905222Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459918706Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459933743Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459948415Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459962900Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459975206Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.459987127Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460010927Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460028882Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460048410Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460060351Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460071148Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460119029Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460135629Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 13 07:13:53.460190 containerd[1563]: time="2025-08-13T07:13:53.460147123Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 13 07:13:53.460448 containerd[1563]: time="2025-08-13T07:13:53.460163640Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 13 07:13:53.460448 containerd[1563]: time="2025-08-13T07:13:53.460173789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.460448 containerd[1563]: time="2025-08-13T07:13:53.460187076Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 13 07:13:53.460448 containerd[1563]: time="2025-08-13T07:13:53.460231446Z" level=info msg="NRI interface is disabled by configuration." Aug 13 07:13:53.460448 containerd[1563]: time="2025-08-13T07:13:53.460246691Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 13 07:13:53.464950 containerd[1563]: time="2025-08-13T07:13:53.464840116Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:false] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Aug 13 07:13:53.464950 containerd[1563]: time="2025-08-13T07:13:53.464957743Z" level=info msg="Connect containerd service" Aug 13 07:13:53.465205 containerd[1563]: time="2025-08-13T07:13:53.465021235Z" level=info msg="using legacy CRI server" Aug 13 07:13:53.465205 containerd[1563]: time="2025-08-13T07:13:53.465030863Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 13 07:13:53.465205 containerd[1563]: time="2025-08-13T07:13:53.465149355Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 13 07:13:53.465977 containerd[1563]: time="2025-08-13T07:13:53.465941823Z" 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 13 07:13:53.466142 containerd[1563]: time="2025-08-13T07:13:53.466102923Z" level=info msg="Start subscribing containerd event" Aug 13 07:13:53.466216 containerd[1563]: time="2025-08-13T07:13:53.466164915Z" level=info msg="Start recovering state" Aug 13 07:13:53.466271 containerd[1563]: time="2025-08-13T07:13:53.466239464Z" level=info msg="Start event monitor" Aug 13 07:13:53.466300 containerd[1563]: time="2025-08-13T07:13:53.466285918Z" level=info msg="Start snapshots syncer" Aug 13 07:13:53.466322 containerd[1563]: time="2025-08-13T07:13:53.466298714Z" level=info msg="Start cni network conf syncer for default" Aug 13 07:13:53.466322 containerd[1563]: time="2025-08-13T07:13:53.466307801Z" level=info msg="Start streaming server" Aug 13 07:13:53.466322 containerd[1563]: time="2025-08-13T07:13:53.466417175Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 13 07:13:53.466537 containerd[1563]: time="2025-08-13T07:13:53.466492557Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 13 07:13:53.466584 containerd[1563]: time="2025-08-13T07:13:53.466561478Z" level=info msg="containerd successfully booted in 0.053019s" Aug 13 07:13:53.466786 systemd[1]: Started containerd.service - containerd container runtime. Aug 13 07:13:54.388459 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 07:13:54.390140 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 13 07:13:54.392738 systemd[1]: Startup finished in 6.844s (kernel) + 4.991s (userspace) = 11.836s. Aug 13 07:13:54.394064 (kubelet)[1651]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Aug 13 07:13:55.158223 kubelet[1651]: E0813 07:13:55.158141 1651 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 13 07:13:55.162766 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 13 07:13:55.163065 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 13 07:13:57.124591 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 13 07:13:57.135106 systemd[1]: Started sshd@0-10.0.0.116:22-10.0.0.1:48690.service - OpenSSH per-connection server daemon (10.0.0.1:48690). Aug 13 07:13:57.181212 sshd[1664]: Accepted publickey for core from 10.0.0.1 port 48690 ssh2: RSA SHA256:CMfoLhPNmBOOiskIU7y9xMX9q9TU1tPTT3rYgwbB2Y8 Aug 13 07:13:57.183789 sshd[1664]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:13:57.194113 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 13 07:13:57.204094 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 13 07:13:57.206859 systemd-logind[1536]: New session 1 of user core. Aug 13 07:13:57.220560 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 13 07:13:57.227984 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 13 07:13:57.235321 (systemd)[1670]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 13 07:13:57.373700 systemd[1670]: Queued start job for default target default.target. Aug 13 07:13:57.374130 systemd[1670]: Created slice app.slice - User Application Slice. Aug 13 07:13:57.374153 systemd[1670]: Reached target paths.target - Paths. Aug 13 07:13:57.374166 systemd[1670]: Reached target timers.target - Timers. Aug 13 07:13:57.385784 systemd[1670]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 13 07:13:57.394485 systemd[1670]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 13 07:13:57.394595 systemd[1670]: Reached target sockets.target - Sockets. Aug 13 07:13:57.394615 systemd[1670]: Reached target basic.target - Basic System. Aug 13 07:13:57.394706 systemd[1670]: Reached target default.target - Main User Target. Aug 13 07:13:57.394753 systemd[1670]: Startup finished in 150ms. Aug 13 07:13:57.395008 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 13 07:13:57.396917 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 13 07:13:57.459000 systemd[1]: Started sshd@1-10.0.0.116:22-10.0.0.1:48706.service - OpenSSH per-connection server daemon (10.0.0.1:48706). Aug 13 07:13:57.494474 sshd[1682]: Accepted publickey for core from 10.0.0.1 port 48706 ssh2: RSA SHA256:CMfoLhPNmBOOiskIU7y9xMX9q9TU1tPTT3rYgwbB2Y8 Aug 13 07:13:57.496460 sshd[1682]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:13:57.500815 systemd-logind[1536]: New session 2 of user core. Aug 13 07:13:57.509992 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 13 07:13:57.569231 sshd[1682]: pam_unix(sshd:session): session closed for user core Aug 13 07:13:57.588904 systemd[1]: Started sshd@2-10.0.0.116:22-10.0.0.1:48718.service - OpenSSH per-connection server daemon (10.0.0.1:48718). Aug 13 07:13:57.589410 systemd[1]: sshd@1-10.0.0.116:22-10.0.0.1:48706.service: Deactivated successfully. Aug 13 07:13:57.591712 systemd-logind[1536]: Session 2 logged out. Waiting for processes to exit. Aug 13 07:13:57.592410 systemd[1]: session-2.scope: Deactivated successfully. Aug 13 07:13:57.593922 systemd-logind[1536]: Removed session 2. Aug 13 07:13:57.625556 sshd[1687]: Accepted publickey for core from 10.0.0.1 port 48718 ssh2: RSA SHA256:CMfoLhPNmBOOiskIU7y9xMX9q9TU1tPTT3rYgwbB2Y8 Aug 13 07:13:57.627788 sshd[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:13:57.632357 systemd-logind[1536]: New session 3 of user core. Aug 13 07:13:57.646087 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 13 07:13:57.699688 sshd[1687]: pam_unix(sshd:session): session closed for user core Aug 13 07:13:57.717259 systemd[1]: Started sshd@3-10.0.0.116:22-10.0.0.1:48730.service - OpenSSH per-connection server daemon (10.0.0.1:48730). Aug 13 07:13:57.718297 systemd[1]: sshd@2-10.0.0.116:22-10.0.0.1:48718.service: Deactivated successfully. Aug 13 07:13:57.721224 systemd[1]: session-3.scope: Deactivated successfully. Aug 13 07:13:57.722089 systemd-logind[1536]: Session 3 logged out. Waiting for processes to exit. Aug 13 07:13:57.724434 systemd-logind[1536]: Removed session 3. Aug 13 07:13:57.749128 sshd[1696]: Accepted publickey for core from 10.0.0.1 port 48730 ssh2: RSA SHA256:CMfoLhPNmBOOiskIU7y9xMX9q9TU1tPTT3rYgwbB2Y8 Aug 13 07:13:57.750999 sshd[1696]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:13:57.757428 systemd-logind[1536]: New session 4 of user core. Aug 13 07:13:57.767160 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 13 07:13:57.827163 sshd[1696]: pam_unix(sshd:session): session closed for user core Aug 13 07:13:57.835964 systemd[1]: Started sshd@4-10.0.0.116:22-10.0.0.1:57226.service - OpenSSH per-connection server daemon (10.0.0.1:57226). Aug 13 07:13:57.836694 systemd[1]: sshd@3-10.0.0.116:22-10.0.0.1:48730.service: Deactivated successfully. Aug 13 07:13:57.839462 systemd[1]: session-4.scope: Deactivated successfully. Aug 13 07:13:57.840217 systemd-logind[1536]: Session 4 logged out. Waiting for processes to exit. Aug 13 07:13:57.842081 systemd-logind[1536]: Removed session 4. Aug 13 07:13:57.872462 sshd[1703]: Accepted publickey for core from 10.0.0.1 port 57226 ssh2: RSA SHA256:CMfoLhPNmBOOiskIU7y9xMX9q9TU1tPTT3rYgwbB2Y8 Aug 13 07:13:57.874490 sshd[1703]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 07:13:57.879928 systemd-logind[1536]: New session 5 of user core. Aug 13 07:13:57.897182 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 13 07:13:57.960065 sudo[1710]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 13 07:13:57.960471 sudo[1710]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 13 07:13:57.989063 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 13 07:13:58.015340 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 13 07:13:58.015836 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 13 07:13:58.774951 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 07:13:58.785977 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 07:13:58.819373 systemd[1]: Reloading requested from client PID 1755 ('systemctl') (unit session-5.scope)... Aug 13 07:13:58.819392 systemd[1]: Reloading... Aug 13 07:13:58.899736 zram_generator::config[1799]: No configuration found. Aug 13 07:13:59.286553 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 13 07:13:59.365378 systemd[1]: Reloading finished in 545 ms. Aug 13 07:13:59.408923 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Aug 13 07:13:59.409039 systemd[1]: kubelet.service: Failed with result 'signal'. Aug 13 07:13:59.409486 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 07:13:59.423045 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 07:13:59.592424 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 07:13:59.597300 (kubelet)[1853]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Aug 13 07:13:59.641807 kubelet[1853]: 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 13 07:13:59.641807 kubelet[1853]: 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 13 07:13:59.641807 kubelet[1853]: 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 13 07:13:59.642239 kubelet[1853]: I0813 07:13:59.641885 1853 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 13 07:13:59.846060 kubelet[1853]: I0813 07:13:59.845929 1853 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Aug 13 07:13:59.846060 kubelet[1853]: I0813 07:13:59.845963 1853 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 13 07:13:59.846228 kubelet[1853]: I0813 07:13:59.846205 1853 server.go:934] "Client rotation is on, will bootstrap in background" Aug 13 07:13:59.878337 kubelet[1853]: I0813 07:13:59.878220 1853 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 13 07:13:59.884848 kubelet[1853]: E0813 07:13:59.884799 1853 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Aug 13 07:13:59.884848 kubelet[1853]: I0813 07:13:59.884844 1853 server.go:1408] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Aug 13 07:13:59.892206 kubelet[1853]: I0813 07:13:59.892166 1853 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 13 07:13:59.892707 kubelet[1853]: I0813 07:13:59.892678 1853 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Aug 13 07:13:59.892914 kubelet[1853]: I0813 07:13:59.892876 1853 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 13 07:13:59.893208 kubelet[1853]: I0813 07:13:59.892906 1853 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.116","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":1} Aug 13 07:13:59.893351 kubelet[1853]: I0813 07:13:59.893236 1853 topology_manager.go:138] "Creating topology manager with none policy" Aug 13 07:13:59.893351 kubelet[1853]: I0813 07:13:59.893247 1853 container_manager_linux.go:300] "Creating device plugin manager" Aug 13 07:13:59.893456 kubelet[1853]: I0813 07:13:59.893422 1853 state_mem.go:36] "Initialized new in-memory state store" Aug 13 07:13:59.898475 kubelet[1853]: I0813 07:13:59.897795 1853 kubelet.go:408] "Attempting to sync node with API server" Aug 13 07:13:59.898475 kubelet[1853]: I0813 07:13:59.897905 1853 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 13 07:13:59.898475 kubelet[1853]: I0813 07:13:59.897953 1853 kubelet.go:314] "Adding apiserver pod source" Aug 13 07:13:59.898475 kubelet[1853]: I0813 07:13:59.897986 1853 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 13 07:13:59.898475 kubelet[1853]: E0813 07:13:59.898171 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:13:59.898475 kubelet[1853]: E0813 07:13:59.898205 1853 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:13:59.902775 kubelet[1853]: I0813 07:13:59.902730 1853 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Aug 13 07:13:59.903283 kubelet[1853]: I0813 07:13:59.903262 1853 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Aug 13 07:13:59.904955 kubelet[1853]: W0813 07:13:59.904912 1853 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 13 07:13:59.906921 kubelet[1853]: I0813 07:13:59.906731 1853 server.go:1274] "Started kubelet" Aug 13 07:13:59.906921 kubelet[1853]: I0813 07:13:59.906834 1853 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Aug 13 07:13:59.908292 kubelet[1853]: I0813 07:13:59.907911 1853 server.go:449] "Adding debug handlers to kubelet server" Aug 13 07:13:59.908974 kubelet[1853]: I0813 07:13:59.908631 1853 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.909122 1853 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Aug 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.909384 1853 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.909858 1853 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 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.910082 1853 volume_manager.go:289] "Starting Kubelet Volume Manager" Aug 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.910182 1853 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Aug 13 07:13:59.910685 kubelet[1853]: I0813 07:13:59.910267 1853 reconciler.go:26] "Reconciler: start to sync state" Aug 13 07:13:59.910685 kubelet[1853]: E0813 07:13:59.910669 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:13:59.921239 kubelet[1853]: I0813 07:13:59.921194 1853 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 13 07:13:59.923201 kubelet[1853]: I0813 07:13:59.923183 1853 factory.go:221] Registration of the containerd container factory successfully Aug 13 07:13:59.923295 kubelet[1853]: I0813 07:13:59.923283 1853 factory.go:221] Registration of the systemd container factory successfully Aug 13 07:13:59.923449 kubelet[1853]: E0813 07:13:59.923406 1853 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 13 07:13:59.925378 kubelet[1853]: E0813 07:13:59.925327 1853 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.116\" not found" node="10.0.0.116" Aug 13 07:13:59.949621 kubelet[1853]: I0813 07:13:59.949588 1853 cpu_manager.go:214] "Starting CPU manager" policy="none" Aug 13 07:13:59.949621 kubelet[1853]: I0813 07:13:59.949607 1853 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Aug 13 07:13:59.949778 kubelet[1853]: I0813 07:13:59.949630 1853 state_mem.go:36] "Initialized new in-memory state store" Aug 13 07:14:00.011320 kubelet[1853]: E0813 07:14:00.011253 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:14:00.112460 kubelet[1853]: E0813 07:14:00.112326 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:14:00.212898 kubelet[1853]: E0813 07:14:00.212851 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:14:00.313991 kubelet[1853]: E0813 07:14:00.313924 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:14:00.414602 kubelet[1853]: E0813 07:14:00.414431 1853 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.116\" not found" Aug 13 07:14:00.430586 kubelet[1853]: E0813 07:14:00.430512 1853 csi_plugin.go:305] Failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "10.0.0.116" not found Aug 13 07:14:00.431876 kubelet[1853]: I0813 07:14:00.431849 1853 policy_none.go:49] "None policy: Start" Aug 13 07:14:00.432760 kubelet[1853]: I0813 07:14:00.432742 1853 memory_manager.go:170] "Starting memorymanager" policy="None" Aug 13 07:14:00.432810 kubelet[1853]: I0813 07:14:00.432769 1853 state_mem.go:35] "Initializing new in-memory state store" Aug 13 07:14:00.440428 kubelet[1853]: I0813 07:14:00.439835 1853 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 13 07:14:00.440428 kubelet[1853]: I0813 07:14:00.440076 1853 eviction_manager.go:189] "Eviction manager: starting control loop" Aug 13 07:14:00.440428 kubelet[1853]: I0813 07:14:00.440088 1853 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Aug 13 07:14:00.440595 kubelet[1853]: I0813 07:14:00.440470 1853 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 13 07:14:00.442365 kubelet[1853]: E0813 07:14:00.442327 1853 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.116\" not found" Aug 13 07:14:00.464161 kubelet[1853]: I0813 07:14:00.464102 1853 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 13 07:14:00.465942 kubelet[1853]: I0813 07:14:00.465914 1853 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 13 07:14:00.465983 kubelet[1853]: I0813 07:14:00.465962 1853 status_manager.go:217] "Starting to sync pod status with apiserver" Aug 13 07:14:00.466055 kubelet[1853]: I0813 07:14:00.466002 1853 kubelet.go:2321] "Starting kubelet main sync loop" Aug 13 07:14:00.466078 kubelet[1853]: E0813 07:14:00.466058 1853 kubelet.go:2345] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Aug 13 07:14:00.541184 kubelet[1853]: I0813 07:14:00.541129 1853 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.116" Aug 13 07:14:00.547701 kubelet[1853]: I0813 07:14:00.547677 1853 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.116" Aug 13 07:14:00.619729 sudo[1710]: pam_unix(sudo:session): session closed for user root Aug 13 07:14:00.621938 sshd[1703]: pam_unix(sshd:session): session closed for user core Aug 13 07:14:00.626082 systemd[1]: sshd@4-10.0.0.116:22-10.0.0.1:57226.service: Deactivated successfully. Aug 13 07:14:00.628571 systemd-logind[1536]: Session 5 logged out. Waiting for processes to exit. Aug 13 07:14:00.628668 systemd[1]: session-5.scope: Deactivated successfully. Aug 13 07:14:00.630132 systemd-logind[1536]: Removed session 5. Aug 13 07:14:00.659198 kubelet[1853]: I0813 07:14:00.659155 1853 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 13 07:14:00.659724 containerd[1563]: time="2025-08-13T07:14:00.659566572Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 13 07:14:00.660027 kubelet[1853]: I0813 07:14:00.659882 1853 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 13 07:14:00.849247 kubelet[1853]: I0813 07:14:00.849181 1853 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 13 07:14:00.849768 kubelet[1853]: W0813 07:14:00.849499 1853 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 13 07:14:00.849768 kubelet[1853]: W0813 07:14:00.849563 1853 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 13 07:14:00.849768 kubelet[1853]: W0813 07:14:00.849585 1853 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 13 07:14:00.849768 kubelet[1853]: E0813 07:14:00.849610 1853 csi_plugin.go:305] Failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: Post "https://10.0.0.104:6443/apis/storage.k8s.io/v1/csinodes": read tcp 10.0.0.116:52686->10.0.0.104:6443: use of closed network connection Aug 13 07:14:00.898974 kubelet[1853]: I0813 07:14:00.898909 1853 apiserver.go:52] "Watching apiserver" Aug 13 07:14:00.899082 kubelet[1853]: E0813 07:14:00.898920 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:00.929503 kubelet[1853]: I0813 07:14:00.929437 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-run\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:00.929707 kubelet[1853]: I0813 07:14:00.929603 1853 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Aug 13 07:14:01.030029 kubelet[1853]: I0813 07:14:01.029935 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/74bb769d-68cb-4d64-b649-802d2018ac96-xtables-lock\") pod \"kube-proxy-wcx22\" (UID: \"74bb769d-68cb-4d64-b649-802d2018ac96\") " pod="kube-system/kube-proxy-wcx22" Aug 13 07:14:01.030029 kubelet[1853]: I0813 07:14:01.030011 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/74bb769d-68cb-4d64-b649-802d2018ac96-lib-modules\") pod \"kube-proxy-wcx22\" (UID: \"74bb769d-68cb-4d64-b649-802d2018ac96\") " pod="kube-system/kube-proxy-wcx22" Aug 13 07:14:01.030029 kubelet[1853]: I0813 07:14:01.030032 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-4nkk2\" (UniqueName: \"kubernetes.io/projected/74bb769d-68cb-4d64-b649-802d2018ac96-kube-api-access-4nkk2\") pod \"kube-proxy-wcx22\" (UID: \"74bb769d-68cb-4d64-b649-802d2018ac96\") " pod="kube-system/kube-proxy-wcx22" Aug 13 07:14:01.030029 kubelet[1853]: I0813 07:14:01.030051 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-cni-plugin\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:01.030359 kubelet[1853]: I0813 07:14:01.030068 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-cni\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:01.030359 kubelet[1853]: I0813 07:14:01.030094 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-flannel-cfg\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:01.030359 kubelet[1853]: I0813 07:14:01.030111 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-r8j5x\" (UniqueName: \"kubernetes.io/projected/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-kube-api-access-r8j5x\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:01.030359 kubelet[1853]: I0813 07:14:01.030160 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/74bb769d-68cb-4d64-b649-802d2018ac96-kube-proxy\") pod \"kube-proxy-wcx22\" (UID: \"74bb769d-68cb-4d64-b649-802d2018ac96\") " pod="kube-system/kube-proxy-wcx22" Aug 13 07:14:01.030359 kubelet[1853]: I0813 07:14:01.030228 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/e01a322b-1a99-4126-8f1d-9c5c466c1dd3-xtables-lock\") pod \"kube-flannel-ds-czd22\" (UID: \"e01a322b-1a99-4126-8f1d-9c5c466c1dd3\") " pod="kube-flannel/kube-flannel-ds-czd22" Aug 13 07:14:01.507259 kubelet[1853]: E0813 07:14:01.507207 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:01.507992 containerd[1563]: time="2025-08-13T07:14:01.507947949Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-wcx22,Uid:74bb769d-68cb-4d64-b649-802d2018ac96,Namespace:kube-system,Attempt:0,}" Aug 13 07:14:01.531424 kubelet[1853]: E0813 07:14:01.531368 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:01.534567 containerd[1563]: time="2025-08-13T07:14:01.534530694Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-czd22,Uid:e01a322b-1a99-4126-8f1d-9c5c466c1dd3,Namespace:kube-flannel,Attempt:0,}" Aug 13 07:14:01.900244 kubelet[1853]: E0813 07:14:01.900084 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:02.901241 kubelet[1853]: E0813 07:14:02.901204 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:03.422371 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount563194562.mount: Deactivated successfully. Aug 13 07:14:03.431527 containerd[1563]: time="2025-08-13T07:14:03.431484247Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 13 07:14:03.432425 containerd[1563]: time="2025-08-13T07:14:03.432388099Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 13 07:14:03.433174 containerd[1563]: time="2025-08-13T07:14:03.433132955Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312056" Aug 13 07:14:03.433958 containerd[1563]: time="2025-08-13T07:14:03.433925589Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Aug 13 07:14:03.434918 containerd[1563]: time="2025-08-13T07:14:03.434885034Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 13 07:14:03.439211 containerd[1563]: time="2025-08-13T07:14:03.437898660Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 13 07:14:03.440195 containerd[1563]: time="2025-08-13T07:14:03.440134789Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.905536724s" Aug 13 07:14:03.442241 containerd[1563]: time="2025-08-13T07:14:03.442202994Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.934149012s" Aug 13 07:14:03.595625 containerd[1563]: time="2025-08-13T07:14:03.594950563Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:14:03.595625 containerd[1563]: time="2025-08-13T07:14:03.595017122Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:14:03.595625 containerd[1563]: time="2025-08-13T07:14:03.595031468Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:03.595625 containerd[1563]: time="2025-08-13T07:14:03.595133077Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:03.624510 containerd[1563]: time="2025-08-13T07:14:03.624363603Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:14:03.624730 containerd[1563]: time="2025-08-13T07:14:03.624524045Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:14:03.624730 containerd[1563]: time="2025-08-13T07:14:03.624539647Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:03.624874 containerd[1563]: time="2025-08-13T07:14:03.624814334Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:03.769867 containerd[1563]: time="2025-08-13T07:14:03.769817267Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-wcx22,Uid:74bb769d-68cb-4d64-b649-802d2018ac96,Namespace:kube-system,Attempt:0,} returns sandbox id \"692aacdfccb9c35249c2069d421fa4151409f518288d3f4d7f1d0d5442dffee2\"" Aug 13 07:14:03.770532 containerd[1563]: time="2025-08-13T07:14:03.770473555Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-czd22,Uid:e01a322b-1a99-4126-8f1d-9c5c466c1dd3,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\"" Aug 13 07:14:03.771292 kubelet[1853]: E0813 07:14:03.771263 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:03.771395 kubelet[1853]: E0813 07:14:03.771310 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:03.772412 containerd[1563]: time="2025-08-13T07:14:03.772379221Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\"" Aug 13 07:14:03.901991 kubelet[1853]: E0813 07:14:03.901929 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:04.902121 kubelet[1853]: E0813 07:14:04.902055 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:05.127893 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount947285286.mount: Deactivated successfully. Aug 13 07:14:05.679471 containerd[1563]: time="2025-08-13T07:14:05.679402502Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:05.680658 containerd[1563]: time="2025-08-13T07:14:05.680577166Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.11: active requests=0, bytes read=30383612" Aug 13 07:14:05.682070 containerd[1563]: time="2025-08-13T07:14:05.682016534Z" level=info msg="ImageCreate event name:\"sha256:0cec28fd5c3c446ec52e2886ddea38bf7f7e17755aa5d0095d50d3df5914a8fd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:05.684407 containerd[1563]: time="2025-08-13T07:14:05.684360925Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:05.684947 containerd[1563]: time="2025-08-13T07:14:05.684919711Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.11\" with image id \"sha256:0cec28fd5c3c446ec52e2886ddea38bf7f7e17755aa5d0095d50d3df5914a8fd\", repo tag \"registry.k8s.io/kube-proxy:v1.31.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\", size \"30382631\" in 1.912510243s" Aug 13 07:14:05.685014 containerd[1563]: time="2025-08-13T07:14:05.684951747Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\" returns image reference \"sha256:0cec28fd5c3c446ec52e2886ddea38bf7f7e17755aa5d0095d50d3df5914a8fd\"" Aug 13 07:14:05.686011 containerd[1563]: time="2025-08-13T07:14:05.685972180Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 13 07:14:05.687342 containerd[1563]: time="2025-08-13T07:14:05.687308854Z" level=info msg="CreateContainer within sandbox \"692aacdfccb9c35249c2069d421fa4151409f518288d3f4d7f1d0d5442dffee2\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 13 07:14:05.734901 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount67259508.mount: Deactivated successfully. Aug 13 07:14:05.784618 containerd[1563]: time="2025-08-13T07:14:05.784552323Z" level=info msg="CreateContainer within sandbox \"692aacdfccb9c35249c2069d421fa4151409f518288d3f4d7f1d0d5442dffee2\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"f7ec169e7618a724819bd0a60901686cd0ce45a239dc4c576ff7c2cc9c90680c\"" Aug 13 07:14:05.785264 containerd[1563]: time="2025-08-13T07:14:05.785222719Z" level=info msg="StartContainer for \"f7ec169e7618a724819bd0a60901686cd0ce45a239dc4c576ff7c2cc9c90680c\"" Aug 13 07:14:05.876259 containerd[1563]: time="2025-08-13T07:14:05.876205207Z" level=info msg="StartContainer for \"f7ec169e7618a724819bd0a60901686cd0ce45a239dc4c576ff7c2cc9c90680c\" returns successfully" Aug 13 07:14:05.903045 kubelet[1853]: E0813 07:14:05.902996 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:06.478168 kubelet[1853]: E0813 07:14:06.478129 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:06.903665 kubelet[1853]: E0813 07:14:06.903500 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:07.483566 kubelet[1853]: E0813 07:14:07.483524 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:07.762653 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2007470235.mount: Deactivated successfully. Aug 13 07:14:07.801105 containerd[1563]: time="2025-08-13T07:14:07.801045769Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:07.801751 containerd[1563]: time="2025-08-13T07:14:07.801691429Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852937" Aug 13 07:14:07.802806 containerd[1563]: time="2025-08-13T07:14:07.802761348Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:07.804932 containerd[1563]: time="2025-08-13T07:14:07.804902212Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:07.805557 containerd[1563]: time="2025-08-13T07:14:07.805533336Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3842055\" in 2.119525119s" Aug 13 07:14:07.805589 containerd[1563]: time="2025-08-13T07:14:07.805565161Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Aug 13 07:14:07.807616 containerd[1563]: time="2025-08-13T07:14:07.807588515Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 13 07:14:07.819104 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2018919154.mount: Deactivated successfully. Aug 13 07:14:07.822088 containerd[1563]: time="2025-08-13T07:14:07.822044765Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236\"" Aug 13 07:14:07.822551 containerd[1563]: time="2025-08-13T07:14:07.822499446Z" level=info msg="StartContainer for \"73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236\"" Aug 13 07:14:07.900281 containerd[1563]: time="2025-08-13T07:14:07.900232029Z" level=info msg="StartContainer for \"73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236\" returns successfully" Aug 13 07:14:07.904570 kubelet[1853]: E0813 07:14:07.904522 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:08.434215 containerd[1563]: time="2025-08-13T07:14:08.434136916Z" level=info msg="shim disconnected" id=73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236 namespace=k8s.io Aug 13 07:14:08.434215 containerd[1563]: time="2025-08-13T07:14:08.434207900Z" level=warning msg="cleaning up after shim disconnected" id=73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236 namespace=k8s.io Aug 13 07:14:08.434215 containerd[1563]: time="2025-08-13T07:14:08.434216563Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 13 07:14:08.482578 kubelet[1853]: E0813 07:14:08.482537 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:08.483228 containerd[1563]: time="2025-08-13T07:14:08.483194039Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 13 07:14:08.492306 kubelet[1853]: I0813 07:14:08.492241 1853 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-wcx22" podStartSLOduration=6.578399953 podStartE2EDuration="8.492212816s" podCreationTimestamp="2025-08-13 07:14:00 +0000 UTC" firstStartedPulling="2025-08-13 07:14:03.771993844 +0000 UTC m=+4.169260967" lastFinishedPulling="2025-08-13 07:14:05.685806696 +0000 UTC m=+6.083073830" observedRunningTime="2025-08-13 07:14:06.667185305 +0000 UTC m=+7.064452429" watchObservedRunningTime="2025-08-13 07:14:08.492212816 +0000 UTC m=+8.889479959" Aug 13 07:14:08.685212 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-73ffebe9f1063b1a924c9d5437f7749cd22b751d5c7ced53c98c0fa693cff236-rootfs.mount: Deactivated successfully. Aug 13 07:14:08.905618 kubelet[1853]: E0813 07:14:08.905561 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:09.906462 kubelet[1853]: E0813 07:14:09.906416 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:10.130285 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1816997952.mount: Deactivated successfully. Aug 13 07:14:10.868810 containerd[1563]: time="2025-08-13T07:14:10.868746084Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:10.869479 containerd[1563]: time="2025-08-13T07:14:10.869411461Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866358" Aug 13 07:14:10.870603 containerd[1563]: time="2025-08-13T07:14:10.870565436Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:10.873405 containerd[1563]: time="2025-08-13T07:14:10.873372797Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:10.874404 containerd[1563]: time="2025-08-13T07:14:10.874357497Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26855532\" in 2.391120712s" Aug 13 07:14:10.874404 containerd[1563]: time="2025-08-13T07:14:10.874388896Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Aug 13 07:14:10.876612 containerd[1563]: time="2025-08-13T07:14:10.876585206Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 13 07:14:10.889116 containerd[1563]: time="2025-08-13T07:14:10.889076374Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc\"" Aug 13 07:14:10.889647 containerd[1563]: time="2025-08-13T07:14:10.889604901Z" level=info msg="StartContainer for \"b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc\"" Aug 13 07:14:10.906813 kubelet[1853]: E0813 07:14:10.906769 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:10.949587 containerd[1563]: time="2025-08-13T07:14:10.949529120Z" level=info msg="StartContainer for \"b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc\" returns successfully" Aug 13 07:14:11.004225 kubelet[1853]: I0813 07:14:11.004167 1853 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Aug 13 07:14:11.046020 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc-rootfs.mount: Deactivated successfully. Aug 13 07:14:11.317014 containerd[1563]: time="2025-08-13T07:14:11.316927344Z" level=info msg="shim disconnected" id=b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc namespace=k8s.io Aug 13 07:14:11.317014 containerd[1563]: time="2025-08-13T07:14:11.316988680Z" level=warning msg="cleaning up after shim disconnected" id=b397006665ee4ca1dbde11bc2ab875919ceb623962fb86607fa4c4616b33f8bc namespace=k8s.io Aug 13 07:14:11.317014 containerd[1563]: time="2025-08-13T07:14:11.316997648Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 13 07:14:11.488222 kubelet[1853]: E0813 07:14:11.488174 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:11.489649 containerd[1563]: time="2025-08-13T07:14:11.489598859Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 13 07:14:11.505525 containerd[1563]: time="2025-08-13T07:14:11.505471741Z" level=info msg="CreateContainer within sandbox \"a0a4b9b2632b76456d1cb5e4a2cc67daa6a78f8acdb9936dcfc2d0526913691e\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"361a0355767b74d24b88643fc392b47bc35f578b44205c7ef278636530e41853\"" Aug 13 07:14:11.506011 containerd[1563]: time="2025-08-13T07:14:11.505982127Z" level=info msg="StartContainer for \"361a0355767b74d24b88643fc392b47bc35f578b44205c7ef278636530e41853\"" Aug 13 07:14:11.570712 containerd[1563]: time="2025-08-13T07:14:11.570141773Z" level=info msg="StartContainer for \"361a0355767b74d24b88643fc392b47bc35f578b44205c7ef278636530e41853\" returns successfully" Aug 13 07:14:11.724286 kubelet[1853]: I0813 07:14:11.724232 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-872kh\" (UniqueName: \"kubernetes.io/projected/539351da-31f7-45fe-a1bd-a0738bcce4a9-kube-api-access-872kh\") pod \"nginx-deployment-8587fbcb89-c2rfw\" (UID: \"539351da-31f7-45fe-a1bd-a0738bcce4a9\") " pod="default/nginx-deployment-8587fbcb89-c2rfw" Aug 13 07:14:11.852504 containerd[1563]: time="2025-08-13T07:14:11.852396162Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-c2rfw,Uid:539351da-31f7-45fe-a1bd-a0738bcce4a9,Namespace:default,Attempt:0,}" Aug 13 07:14:11.907134 kubelet[1853]: E0813 07:14:11.907086 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:11.937806 containerd[1563]: time="2025-08-13T07:14:11.937733745Z" level=error msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-c2rfw,Uid:539351da-31f7-45fe-a1bd-a0738bcce4a9,Namespace:default,Attempt:0,} failed, error" error="failed to setup network for sandbox \"3119ca9a400f6fbb15fd775c1955acfc5de651a346216e451a6ba77312a30494\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Aug 13 07:14:11.938306 kubelet[1853]: E0813 07:14:11.938008 1853 log.go:32] "RunPodSandbox from runtime service failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"3119ca9a400f6fbb15fd775c1955acfc5de651a346216e451a6ba77312a30494\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Aug 13 07:14:11.938306 kubelet[1853]: E0813 07:14:11.938105 1853 kuberuntime_sandbox.go:72] "Failed to create sandbox for pod" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"3119ca9a400f6fbb15fd775c1955acfc5de651a346216e451a6ba77312a30494\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-c2rfw" Aug 13 07:14:11.938306 kubelet[1853]: E0813 07:14:11.938130 1853 kuberuntime_manager.go:1170] "CreatePodSandbox for pod failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"3119ca9a400f6fbb15fd775c1955acfc5de651a346216e451a6ba77312a30494\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-c2rfw" Aug 13 07:14:11.938306 kubelet[1853]: E0813 07:14:11.938198 1853 pod_workers.go:1301] "Error syncing pod, skipping" err="failed to \"CreatePodSandbox\" for \"nginx-deployment-8587fbcb89-c2rfw_default(539351da-31f7-45fe-a1bd-a0738bcce4a9)\" with CreatePodSandboxError: \"Failed to create sandbox for pod \\\"nginx-deployment-8587fbcb89-c2rfw_default(539351da-31f7-45fe-a1bd-a0738bcce4a9)\\\": rpc error: code = Unknown desc = failed to setup network for sandbox \\\"3119ca9a400f6fbb15fd775c1955acfc5de651a346216e451a6ba77312a30494\\\": plugin type=\\\"flannel\\\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory\"" pod="default/nginx-deployment-8587fbcb89-c2rfw" podUID="539351da-31f7-45fe-a1bd-a0738bcce4a9" Aug 13 07:14:12.492933 kubelet[1853]: E0813 07:14:12.492890 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:12.617411 systemd-networkd[1247]: flannel.1: Link UP Aug 13 07:14:12.617423 systemd-networkd[1247]: flannel.1: Gained carrier Aug 13 07:14:12.908442 kubelet[1853]: E0813 07:14:12.908257 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:13.497671 kubelet[1853]: E0813 07:14:13.495674 1853 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 13 07:14:13.909009 kubelet[1853]: E0813 07:14:13.908831 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:14.038856 systemd-networkd[1247]: flannel.1: Gained IPv6LL Aug 13 07:14:14.909445 kubelet[1853]: E0813 07:14:14.909325 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:15.910476 kubelet[1853]: E0813 07:14:15.910426 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:16.911446 kubelet[1853]: E0813 07:14:16.911358 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:17.911555 kubelet[1853]: E0813 07:14:17.911487 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:18.912413 kubelet[1853]: E0813 07:14:18.912341 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:19.899163 kubelet[1853]: E0813 07:14:19.899059 1853 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:19.912869 kubelet[1853]: E0813 07:14:19.912815 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:20.914358 kubelet[1853]: E0813 07:14:20.914213 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:21.914665 kubelet[1853]: E0813 07:14:21.914554 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:22.915836 kubelet[1853]: E0813 07:14:22.915733 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:23.468784 containerd[1563]: time="2025-08-13T07:14:23.468715740Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-c2rfw,Uid:539351da-31f7-45fe-a1bd-a0738bcce4a9,Namespace:default,Attempt:0,}" Aug 13 07:14:23.490026 systemd-networkd[1247]: cni0: Link UP Aug 13 07:14:23.490040 systemd-networkd[1247]: cni0: Gained carrier Aug 13 07:14:23.496628 systemd-networkd[1247]: cni0: Lost carrier Aug 13 07:14:23.500192 systemd-networkd[1247]: veth58abc0b7: Link UP Aug 13 07:14:23.501949 kernel: cni0: port 1(veth58abc0b7) entered blocking state Aug 13 07:14:23.502029 kernel: cni0: port 1(veth58abc0b7) entered disabled state Aug 13 07:14:23.502056 kernel: veth58abc0b7: entered allmulticast mode Aug 13 07:14:23.503229 kernel: veth58abc0b7: entered promiscuous mode Aug 13 07:14:23.504158 kernel: cni0: port 1(veth58abc0b7) entered blocking state Aug 13 07:14:23.504185 kernel: cni0: port 1(veth58abc0b7) entered forwarding state Aug 13 07:14:23.505663 kernel: cni0: port 1(veth58abc0b7) entered disabled state Aug 13 07:14:23.515744 kernel: cni0: port 1(veth58abc0b7) entered blocking state Aug 13 07:14:23.515785 kernel: cni0: port 1(veth58abc0b7) entered forwarding state Aug 13 07:14:23.515905 systemd-networkd[1247]: veth58abc0b7: Gained carrier Aug 13 07:14:23.516420 systemd-networkd[1247]: cni0: Gained carrier Aug 13 07:14:23.519057 containerd[1563]: 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)(0xc00011c8e8), "name":"cbr0", "type":"bridge"} Aug 13 07:14:23.519057 containerd[1563]: delegateAdd: netconf sent to delegate plugin: Aug 13 07:14:23.588427 containerd[1563]: {"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-13T07:14:23.588300662Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:14:23.588427 containerd[1563]: time="2025-08-13T07:14:23.588390295Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:14:23.588591 containerd[1563]: time="2025-08-13T07:14:23.588401836Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:23.588631 containerd[1563]: time="2025-08-13T07:14:23.588528796Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:23.625097 systemd-resolved[1465]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 07:14:23.656860 containerd[1563]: time="2025-08-13T07:14:23.656805455Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-c2rfw,Uid:539351da-31f7-45fe-a1bd-a0738bcce4a9,Namespace:default,Attempt:0,} returns sandbox id \"bc0b304b9146ad7e85ece35d12180b262ff908293b99c6dbcfd85c5d3000a34a\"" Aug 13 07:14:23.659023 containerd[1563]: time="2025-08-13T07:14:23.658981849Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 07:14:23.916412 kubelet[1853]: E0813 07:14:23.916250 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:24.917219 kubelet[1853]: E0813 07:14:24.917155 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:25.238920 systemd-networkd[1247]: veth58abc0b7: Gained IPv6LL Aug 13 07:14:25.366823 systemd-networkd[1247]: cni0: Gained IPv6LL Aug 13 07:14:25.917424 kubelet[1853]: E0813 07:14:25.917349 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:26.918149 kubelet[1853]: E0813 07:14:26.918066 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:27.163978 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount463406674.mount: Deactivated successfully. Aug 13 07:14:27.919009 kubelet[1853]: E0813 07:14:27.918940 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:28.682388 containerd[1563]: time="2025-08-13T07:14:28.682318397Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:28.683149 containerd[1563]: time="2025-08-13T07:14:28.683123110Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73303204" Aug 13 07:14:28.684365 containerd[1563]: time="2025-08-13T07:14:28.684318002Z" level=info msg="ImageCreate event name:\"sha256:f36b8965af58ac17c6fcb27d986b37161ceb26b3d41d3cd53f232b0e16761305\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:28.686835 containerd[1563]: time="2025-08-13T07:14:28.686783301Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:28.688113 containerd[1563]: time="2025-08-13T07:14:28.688068728Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f36b8965af58ac17c6fcb27d986b37161ceb26b3d41d3cd53f232b0e16761305\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"73303082\" in 5.029046143s" Aug 13 07:14:28.688174 containerd[1563]: time="2025-08-13T07:14:28.688115960Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f36b8965af58ac17c6fcb27d986b37161ceb26b3d41d3cd53f232b0e16761305\"" Aug 13 07:14:28.690382 containerd[1563]: time="2025-08-13T07:14:28.690356688Z" level=info msg="CreateContainer within sandbox \"bc0b304b9146ad7e85ece35d12180b262ff908293b99c6dbcfd85c5d3000a34a\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 13 07:14:28.919671 kubelet[1853]: E0813 07:14:28.919599 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:28.964758 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1021182271.mount: Deactivated successfully. Aug 13 07:14:29.292891 containerd[1563]: time="2025-08-13T07:14:29.292723792Z" level=info msg="CreateContainer within sandbox \"bc0b304b9146ad7e85ece35d12180b262ff908293b99c6dbcfd85c5d3000a34a\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"4f8163fad0d0e984dc5371cfebb773cd1199d30c49f237cfe7a99703d181ae9f\"" Aug 13 07:14:29.293489 containerd[1563]: time="2025-08-13T07:14:29.293447096Z" level=info msg="StartContainer for \"4f8163fad0d0e984dc5371cfebb773cd1199d30c49f237cfe7a99703d181ae9f\"" Aug 13 07:14:29.417028 containerd[1563]: time="2025-08-13T07:14:29.416969816Z" level=info msg="StartContainer for \"4f8163fad0d0e984dc5371cfebb773cd1199d30c49f237cfe7a99703d181ae9f\" returns successfully" Aug 13 07:14:29.561924 kubelet[1853]: I0813 07:14:29.561740 1853 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-czd22" podStartSLOduration=22.458470456 podStartE2EDuration="29.561706598s" podCreationTimestamp="2025-08-13 07:14:00 +0000 UTC" firstStartedPulling="2025-08-13 07:14:03.772025412 +0000 UTC m=+4.169292536" lastFinishedPulling="2025-08-13 07:14:10.875261555 +0000 UTC m=+11.272528678" observedRunningTime="2025-08-13 07:14:12.50204706 +0000 UTC m=+12.899314194" watchObservedRunningTime="2025-08-13 07:14:29.561706598 +0000 UTC m=+29.958973721" Aug 13 07:14:29.562121 kubelet[1853]: I0813 07:14:29.562043 1853 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-c2rfw" podStartSLOduration=13.531483667 podStartE2EDuration="18.56203676s" podCreationTimestamp="2025-08-13 07:14:11 +0000 UTC" firstStartedPulling="2025-08-13 07:14:23.658389597 +0000 UTC m=+24.055656710" lastFinishedPulling="2025-08-13 07:14:28.68894269 +0000 UTC m=+29.086209803" observedRunningTime="2025-08-13 07:14:29.561573749 +0000 UTC m=+29.958840872" watchObservedRunningTime="2025-08-13 07:14:29.56203676 +0000 UTC m=+29.959303883" Aug 13 07:14:29.920806 kubelet[1853]: E0813 07:14:29.920616 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:30.921391 kubelet[1853]: E0813 07:14:30.921328 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:31.922599 kubelet[1853]: E0813 07:14:31.922510 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:32.923726 kubelet[1853]: E0813 07:14:32.923613 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:33.840413 kubelet[1853]: I0813 07:14:33.840337 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/7454e964-ea15-4c91-b4b2-1238d1462683-data\") pod \"nfs-server-provisioner-0\" (UID: \"7454e964-ea15-4c91-b4b2-1238d1462683\") " pod="default/nfs-server-provisioner-0" Aug 13 07:14:33.840413 kubelet[1853]: I0813 07:14:33.840408 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zrdqz\" (UniqueName: \"kubernetes.io/projected/7454e964-ea15-4c91-b4b2-1238d1462683-kube-api-access-zrdqz\") pod \"nfs-server-provisioner-0\" (UID: \"7454e964-ea15-4c91-b4b2-1238d1462683\") " pod="default/nfs-server-provisioner-0" Aug 13 07:14:33.923942 kubelet[1853]: E0813 07:14:33.923868 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:34.002508 containerd[1563]: time="2025-08-13T07:14:34.002459847Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7454e964-ea15-4c91-b4b2-1238d1462683,Namespace:default,Attempt:0,}" Aug 13 07:14:34.744097 systemd-networkd[1247]: veth5e6ad2cb: Link UP Aug 13 07:14:34.745925 kernel: cni0: port 2(veth5e6ad2cb) entered blocking state Aug 13 07:14:34.746040 kernel: cni0: port 2(veth5e6ad2cb) entered disabled state Aug 13 07:14:34.746860 kernel: veth5e6ad2cb: entered allmulticast mode Aug 13 07:14:34.747010 kernel: veth5e6ad2cb: entered promiscuous mode Aug 13 07:14:34.754162 kernel: cni0: port 2(veth5e6ad2cb) entered blocking state Aug 13 07:14:34.754214 kernel: cni0: port 2(veth5e6ad2cb) entered forwarding state Aug 13 07:14:34.754258 systemd-networkd[1247]: veth5e6ad2cb: Gained carrier Aug 13 07:14:34.758604 containerd[1563]: 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)(0xc00001c938), "name":"cbr0", "type":"bridge"} Aug 13 07:14:34.758604 containerd[1563]: delegateAdd: netconf sent to delegate plugin: Aug 13 07:14:34.800421 containerd[1563]: {"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-13T07:14:34.800295558Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:14:34.800421 containerd[1563]: time="2025-08-13T07:14:34.800380831Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:14:34.800622 containerd[1563]: time="2025-08-13T07:14:34.800396729Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:34.801568 containerd[1563]: time="2025-08-13T07:14:34.801511603Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:34.829654 systemd-resolved[1465]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 07:14:34.861042 containerd[1563]: time="2025-08-13T07:14:34.861001831Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7454e964-ea15-4c91-b4b2-1238d1462683,Namespace:default,Attempt:0,} returns sandbox id \"218200c2607f40d71e18650aab50fa0c02516d50b6d52d8b2468cdd5b6cf0410\"" Aug 13 07:14:34.862580 containerd[1563]: time="2025-08-13T07:14:34.862559662Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 13 07:14:34.924353 kubelet[1853]: E0813 07:14:34.924286 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:35.924847 kubelet[1853]: E0813 07:14:35.924790 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:36.758928 systemd-networkd[1247]: veth5e6ad2cb: Gained IPv6LL Aug 13 07:14:36.925565 kubelet[1853]: E0813 07:14:36.925519 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:37.275946 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2513811640.mount: Deactivated successfully. Aug 13 07:14:37.579143 update_engine[1539]: I20250813 07:14:37.578943 1539 update_attempter.cc:509] Updating boot flags... Aug 13 07:14:37.619737 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (2760) Aug 13 07:14:37.697744 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 37 scanned by (udev-worker) (2760) Aug 13 07:14:37.927068 kubelet[1853]: E0813 07:14:37.926944 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:38.927728 kubelet[1853]: E0813 07:14:38.927675 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:39.898852 kubelet[1853]: E0813 07:14:39.898787 1853 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:39.928589 kubelet[1853]: E0813 07:14:39.928563 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:40.541830 containerd[1563]: time="2025-08-13T07:14:40.541761357Z" 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 13 07:14:40.542530 containerd[1563]: time="2025-08-13T07:14:40.542477000Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Aug 13 07:14:40.543967 containerd[1563]: time="2025-08-13T07:14:40.543918359Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:40.547360 containerd[1563]: time="2025-08-13T07:14:40.547330732Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:40.548395 containerd[1563]: time="2025-08-13T07:14:40.548362858Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 5.685772656s" Aug 13 07:14:40.548464 containerd[1563]: time="2025-08-13T07:14:40.548396654Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Aug 13 07:14:40.550441 containerd[1563]: time="2025-08-13T07:14:40.550410634Z" level=info msg="CreateContainer within sandbox \"218200c2607f40d71e18650aab50fa0c02516d50b6d52d8b2468cdd5b6cf0410\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 13 07:14:40.566202 containerd[1563]: time="2025-08-13T07:14:40.566152128Z" level=info msg="CreateContainer within sandbox \"218200c2607f40d71e18650aab50fa0c02516d50b6d52d8b2468cdd5b6cf0410\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"388473551797f1925c7b2d8473b7df9245e754891bb94999014466918e72c58a\"" Aug 13 07:14:40.566710 containerd[1563]: time="2025-08-13T07:14:40.566687986Z" level=info msg="StartContainer for \"388473551797f1925c7b2d8473b7df9245e754891bb94999014466918e72c58a\"" Aug 13 07:14:40.649527 containerd[1563]: time="2025-08-13T07:14:40.649475710Z" level=info msg="StartContainer for \"388473551797f1925c7b2d8473b7df9245e754891bb94999014466918e72c58a\" returns successfully" Aug 13 07:14:40.929112 kubelet[1853]: E0813 07:14:40.928961 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:41.559362 kubelet[1853]: I0813 07:14:41.559288 1853 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.872217889 podStartE2EDuration="8.559266494s" podCreationTimestamp="2025-08-13 07:14:33 +0000 UTC" firstStartedPulling="2025-08-13 07:14:34.862178371 +0000 UTC m=+35.259445494" lastFinishedPulling="2025-08-13 07:14:40.549226976 +0000 UTC m=+40.946494099" observedRunningTime="2025-08-13 07:14:41.55915258 +0000 UTC m=+41.956419693" watchObservedRunningTime="2025-08-13 07:14:41.559266494 +0000 UTC m=+41.956533617" Aug 13 07:14:41.930102 kubelet[1853]: E0813 07:14:41.929919 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:42.930811 kubelet[1853]: E0813 07:14:42.930758 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:43.931766 kubelet[1853]: E0813 07:14:43.931680 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:44.932104 kubelet[1853]: E0813 07:14:44.932034 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:45.932392 kubelet[1853]: E0813 07:14:45.932342 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:46.933174 kubelet[1853]: E0813 07:14:46.933112 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:47.934175 kubelet[1853]: E0813 07:14:47.934108 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:48.934711 kubelet[1853]: E0813 07:14:48.934621 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:49.935626 kubelet[1853]: E0813 07:14:49.935528 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:50.936558 kubelet[1853]: E0813 07:14:50.936489 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:51.937665 kubelet[1853]: E0813 07:14:51.937598 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:52.170505 kubelet[1853]: I0813 07:14:52.170452 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-114d969f-a914-46d8-8295-cb1b919276b3\" (UniqueName: \"kubernetes.io/nfs/8ec9d187-a23a-4569-afa1-1e278c7db74f-pvc-114d969f-a914-46d8-8295-cb1b919276b3\") pod \"test-pod-1\" (UID: \"8ec9d187-a23a-4569-afa1-1e278c7db74f\") " pod="default/test-pod-1" Aug 13 07:14:52.170505 kubelet[1853]: I0813 07:14:52.170506 1853 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qx47x\" (UniqueName: \"kubernetes.io/projected/8ec9d187-a23a-4569-afa1-1e278c7db74f-kube-api-access-qx47x\") pod \"test-pod-1\" (UID: \"8ec9d187-a23a-4569-afa1-1e278c7db74f\") " pod="default/test-pod-1" Aug 13 07:14:52.299670 kernel: FS-Cache: Loaded Aug 13 07:14:52.369128 kernel: RPC: Registered named UNIX socket transport module. Aug 13 07:14:52.369302 kernel: RPC: Registered udp transport module. Aug 13 07:14:52.369332 kernel: RPC: Registered tcp transport module. Aug 13 07:14:52.369357 kernel: RPC: Registered tcp-with-tls transport module. Aug 13 07:14:52.369772 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 13 07:14:52.649691 kernel: NFS: Registering the id_resolver key type Aug 13 07:14:52.649823 kernel: Key type id_resolver registered Aug 13 07:14:52.649862 kernel: Key type id_legacy registered Aug 13 07:14:52.778007 nfsidmap[3001]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 13 07:14:52.783164 nfsidmap[3004]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 13 07:14:52.927190 containerd[1563]: time="2025-08-13T07:14:52.927121936Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:8ec9d187-a23a-4569-afa1-1e278c7db74f,Namespace:default,Attempt:0,}" Aug 13 07:14:52.938443 kubelet[1853]: E0813 07:14:52.938403 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:53.646214 systemd-networkd[1247]: veth3302a2f2: Link UP Aug 13 07:14:53.648872 kernel: cni0: port 3(veth3302a2f2) entered blocking state Aug 13 07:14:53.648983 kernel: cni0: port 3(veth3302a2f2) entered disabled state Aug 13 07:14:53.649011 kernel: veth3302a2f2: entered allmulticast mode Aug 13 07:14:53.650122 kernel: veth3302a2f2: entered promiscuous mode Aug 13 07:14:53.662856 kernel: cni0: port 3(veth3302a2f2) entered blocking state Aug 13 07:14:53.662967 kernel: cni0: port 3(veth3302a2f2) entered forwarding state Aug 13 07:14:53.662978 systemd-networkd[1247]: veth3302a2f2: Gained carrier Aug 13 07:14:53.664679 containerd[1563]: 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)(0xc000018938), "name":"cbr0", "type":"bridge"} Aug 13 07:14:53.664679 containerd[1563]: delegateAdd: netconf sent to delegate plugin: Aug 13 07:14:53.697702 containerd[1563]: {"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-13T07:14:53.697568119Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 07:14:53.697702 containerd[1563]: time="2025-08-13T07:14:53.697675383Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 07:14:53.697702 containerd[1563]: time="2025-08-13T07:14:53.697688691Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:53.697939 containerd[1563]: time="2025-08-13T07:14:53.697784802Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 07:14:53.735808 systemd-resolved[1465]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 07:14:53.767671 containerd[1563]: time="2025-08-13T07:14:53.767600489Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:8ec9d187-a23a-4569-afa1-1e278c7db74f,Namespace:default,Attempt:0,} returns sandbox id \"fb76bb850fa74c12948c7e9e187160947563c178abee26e7510d4a89f11db810\"" Aug 13 07:14:53.769365 containerd[1563]: time="2025-08-13T07:14:53.769344548Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 07:14:53.939221 kubelet[1853]: E0813 07:14:53.939185 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:54.155558 containerd[1563]: time="2025-08-13T07:14:54.155509954Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 07:14:54.156308 containerd[1563]: time="2025-08-13T07:14:54.156262953Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Aug 13 07:14:54.162126 containerd[1563]: time="2025-08-13T07:14:54.162069256Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f36b8965af58ac17c6fcb27d986b37161ceb26b3d41d3cd53f232b0e16761305\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"73303082\" in 392.619678ms" Aug 13 07:14:54.162126 containerd[1563]: time="2025-08-13T07:14:54.162118027Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f36b8965af58ac17c6fcb27d986b37161ceb26b3d41d3cd53f232b0e16761305\"" Aug 13 07:14:54.164413 containerd[1563]: time="2025-08-13T07:14:54.164374420Z" level=info msg="CreateContainer within sandbox \"fb76bb850fa74c12948c7e9e187160947563c178abee26e7510d4a89f11db810\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 13 07:14:54.177800 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3957777443.mount: Deactivated successfully. Aug 13 07:14:54.179331 containerd[1563]: time="2025-08-13T07:14:54.179280370Z" level=info msg="CreateContainer within sandbox \"fb76bb850fa74c12948c7e9e187160947563c178abee26e7510d4a89f11db810\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"4504f79c7d23334b555684e6eab5ae4fd5189d4faac6502924ca89f8b2001bb8\"" Aug 13 07:14:54.179915 containerd[1563]: time="2025-08-13T07:14:54.179881383Z" level=info msg="StartContainer for \"4504f79c7d23334b555684e6eab5ae4fd5189d4faac6502924ca89f8b2001bb8\"" Aug 13 07:14:54.245119 containerd[1563]: time="2025-08-13T07:14:54.244991195Z" level=info msg="StartContainer for \"4504f79c7d23334b555684e6eab5ae4fd5189d4faac6502924ca89f8b2001bb8\" returns successfully" Aug 13 07:14:54.584064 kubelet[1853]: I0813 07:14:54.583867 1853 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=21.190084017 podStartE2EDuration="21.583843454s" podCreationTimestamp="2025-08-13 07:14:33 +0000 UTC" firstStartedPulling="2025-08-13 07:14:53.769008475 +0000 UTC m=+54.166275598" lastFinishedPulling="2025-08-13 07:14:54.162767912 +0000 UTC m=+54.560035035" observedRunningTime="2025-08-13 07:14:54.583477572 +0000 UTC m=+54.980744695" watchObservedRunningTime="2025-08-13 07:14:54.583843454 +0000 UTC m=+54.981110578" Aug 13 07:14:54.934986 systemd-networkd[1247]: veth3302a2f2: Gained IPv6LL Aug 13 07:14:54.940424 kubelet[1853]: E0813 07:14:54.940346 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 07:14:55.940666 kubelet[1853]: E0813 07:14:55.940594 1853 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"