Nov 3 16:21:11.794713 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT_DYNAMIC Mon Nov 3 14:29:33 -00 2025 Nov 3 16:21:11.794745 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=e9d538d1fb909beabac60fa40d47676de06d795b9bab2159a3819b90e410c77a Nov 3 16:21:11.794758 kernel: BIOS-provided physical RAM map: Nov 3 16:21:11.794765 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Nov 3 16:21:11.794772 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Nov 3 16:21:11.794779 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Nov 3 16:21:11.794787 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Nov 3 16:21:11.794795 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Nov 3 16:21:11.794804 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Nov 3 16:21:11.794811 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Nov 3 16:21:11.794821 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 3 16:21:11.794828 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Nov 3 16:21:11.794835 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 3 16:21:11.794842 kernel: NX (Execute Disable) protection: active Nov 3 16:21:11.794851 kernel: APIC: Static calls initialized Nov 3 16:21:11.794861 kernel: SMBIOS 2.8 present. Nov 3 16:21:11.794872 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Nov 3 16:21:11.794888 kernel: DMI: Memory slots populated: 1/1 Nov 3 16:21:11.794895 kernel: Hypervisor detected: KVM Nov 3 16:21:11.794903 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Nov 3 16:21:11.794910 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 3 16:21:11.794918 kernel: kvm-clock: using sched offset of 4102724467 cycles Nov 3 16:21:11.794928 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 3 16:21:11.794936 kernel: tsc: Detected 2794.750 MHz processor Nov 3 16:21:11.794947 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 3 16:21:11.794955 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 3 16:21:11.794963 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Nov 3 16:21:11.794971 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Nov 3 16:21:11.794979 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 3 16:21:11.794987 kernel: Using GB pages for direct mapping Nov 3 16:21:11.794995 kernel: ACPI: Early table checksum verification disabled Nov 3 16:21:11.795005 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Nov 3 16:21:11.795013 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795021 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795029 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795037 kernel: ACPI: FACS 0x000000009CFE0000 000040 Nov 3 16:21:11.795050 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795057 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795084 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795093 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 3 16:21:11.795105 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Nov 3 16:21:11.795114 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Nov 3 16:21:11.795122 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Nov 3 16:21:11.795133 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Nov 3 16:21:11.795141 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Nov 3 16:21:11.795149 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Nov 3 16:21:11.795157 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Nov 3 16:21:11.795165 kernel: No NUMA configuration found Nov 3 16:21:11.795173 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Nov 3 16:21:11.795181 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Nov 3 16:21:11.795192 kernel: Zone ranges: Nov 3 16:21:11.795200 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 3 16:21:11.795208 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Nov 3 16:21:11.795216 kernel: Normal empty Nov 3 16:21:11.795224 kernel: Device empty Nov 3 16:21:11.795233 kernel: Movable zone start for each node Nov 3 16:21:11.795240 kernel: Early memory node ranges Nov 3 16:21:11.795248 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Nov 3 16:21:11.795259 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Nov 3 16:21:11.795267 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Nov 3 16:21:11.795275 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 3 16:21:11.795286 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Nov 3 16:21:11.795295 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Nov 3 16:21:11.795305 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 3 16:21:11.795313 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 3 16:21:11.795324 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 3 16:21:11.795332 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 3 16:21:11.795343 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 3 16:21:11.795351 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 3 16:21:11.795359 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 3 16:21:11.795367 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 3 16:21:11.795375 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 3 16:21:11.795386 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 3 16:21:11.795394 kernel: TSC deadline timer available Nov 3 16:21:11.795402 kernel: CPU topo: Max. logical packages: 1 Nov 3 16:21:11.795410 kernel: CPU topo: Max. logical dies: 1 Nov 3 16:21:11.795418 kernel: CPU topo: Max. dies per package: 1 Nov 3 16:21:11.795427 kernel: CPU topo: Max. threads per core: 1 Nov 3 16:21:11.795435 kernel: CPU topo: Num. cores per package: 4 Nov 3 16:21:11.795445 kernel: CPU topo: Num. threads per package: 4 Nov 3 16:21:11.795453 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Nov 3 16:21:11.795461 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 3 16:21:11.795470 kernel: kvm-guest: KVM setup pv remote TLB flush Nov 3 16:21:11.795478 kernel: kvm-guest: setup PV sched yield Nov 3 16:21:11.795486 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Nov 3 16:21:11.795494 kernel: Booting paravirtualized kernel on KVM Nov 3 16:21:11.795502 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 3 16:21:11.795513 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Nov 3 16:21:11.795521 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Nov 3 16:21:11.795530 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Nov 3 16:21:11.795537 kernel: pcpu-alloc: [0] 0 1 2 3 Nov 3 16:21:11.795546 kernel: kvm-guest: PV spinlocks enabled Nov 3 16:21:11.795554 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 3 16:21:11.795563 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=e9d538d1fb909beabac60fa40d47676de06d795b9bab2159a3819b90e410c77a Nov 3 16:21:11.795574 kernel: random: crng init done Nov 3 16:21:11.795582 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 3 16:21:11.795591 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 3 16:21:11.795599 kernel: Fallback order for Node 0: 0 Nov 3 16:21:11.795607 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Nov 3 16:21:11.795615 kernel: Policy zone: DMA32 Nov 3 16:21:11.795626 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 3 16:21:11.795634 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 3 16:21:11.795642 kernel: ftrace: allocating 40092 entries in 157 pages Nov 3 16:21:11.795650 kernel: ftrace: allocated 157 pages with 5 groups Nov 3 16:21:11.795658 kernel: Dynamic Preempt: voluntary Nov 3 16:21:11.795666 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 3 16:21:11.795680 kernel: rcu: RCU event tracing is enabled. Nov 3 16:21:11.795688 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 3 16:21:11.795699 kernel: Trampoline variant of Tasks RCU enabled. Nov 3 16:21:11.795709 kernel: Rude variant of Tasks RCU enabled. Nov 3 16:21:11.795718 kernel: Tracing variant of Tasks RCU enabled. Nov 3 16:21:11.795726 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 3 16:21:11.795734 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 3 16:21:11.795742 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 3 16:21:11.795750 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 3 16:21:11.795761 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 3 16:21:11.795770 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Nov 3 16:21:11.795778 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 3 16:21:11.795794 kernel: Console: colour VGA+ 80x25 Nov 3 16:21:11.795805 kernel: printk: legacy console [ttyS0] enabled Nov 3 16:21:11.795813 kernel: ACPI: Core revision 20240827 Nov 3 16:21:11.795822 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Nov 3 16:21:11.795830 kernel: APIC: Switch to symmetric I/O mode setup Nov 3 16:21:11.795838 kernel: x2apic enabled Nov 3 16:21:11.795849 kernel: APIC: Switched APIC routing to: physical x2apic Nov 3 16:21:11.795860 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Nov 3 16:21:11.795869 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Nov 3 16:21:11.795883 kernel: kvm-guest: setup PV IPIs Nov 3 16:21:11.795895 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Nov 3 16:21:11.795903 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 3 16:21:11.795912 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Nov 3 16:21:11.795921 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 3 16:21:11.795929 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Nov 3 16:21:11.795938 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Nov 3 16:21:11.795946 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 3 16:21:11.795957 kernel: Spectre V2 : Mitigation: Retpolines Nov 3 16:21:11.795966 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 3 16:21:11.795974 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Nov 3 16:21:11.795983 kernel: active return thunk: retbleed_return_thunk Nov 3 16:21:11.795991 kernel: RETBleed: Mitigation: untrained return thunk Nov 3 16:21:11.796000 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 3 16:21:11.796008 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 3 16:21:11.796019 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Nov 3 16:21:11.796028 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Nov 3 16:21:11.796037 kernel: active return thunk: srso_return_thunk Nov 3 16:21:11.796045 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Nov 3 16:21:11.796054 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 3 16:21:11.796063 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 3 16:21:11.796104 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 3 16:21:11.796113 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 3 16:21:11.796121 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Nov 3 16:21:11.796156 kernel: Freeing SMP alternatives memory: 32K Nov 3 16:21:11.796164 kernel: pid_max: default: 32768 minimum: 301 Nov 3 16:21:11.796186 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 3 16:21:11.796195 kernel: landlock: Up and running. Nov 3 16:21:11.796203 kernel: SELinux: Initializing. Nov 3 16:21:11.796218 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 3 16:21:11.796227 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 3 16:21:11.796236 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Nov 3 16:21:11.796244 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Nov 3 16:21:11.796253 kernel: ... version: 0 Nov 3 16:21:11.796261 kernel: ... bit width: 48 Nov 3 16:21:11.796269 kernel: ... generic registers: 6 Nov 3 16:21:11.796294 kernel: ... value mask: 0000ffffffffffff Nov 3 16:21:11.796316 kernel: ... max period: 00007fffffffffff Nov 3 16:21:11.796324 kernel: ... fixed-purpose events: 0 Nov 3 16:21:11.796333 kernel: ... event mask: 000000000000003f Nov 3 16:21:11.796341 kernel: signal: max sigframe size: 1776 Nov 3 16:21:11.796350 kernel: rcu: Hierarchical SRCU implementation. Nov 3 16:21:11.796383 kernel: rcu: Max phase no-delay instances is 400. Nov 3 16:21:11.796396 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 3 16:21:11.796404 kernel: smp: Bringing up secondary CPUs ... Nov 3 16:21:11.796412 kernel: smpboot: x86: Booting SMP configuration: Nov 3 16:21:11.796421 kernel: .... node #0, CPUs: #1 #2 #3 Nov 3 16:21:11.796444 kernel: smp: Brought up 1 node, 4 CPUs Nov 3 16:21:11.796452 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Nov 3 16:21:11.796461 kernel: Memory: 2447340K/2571752K available (14336K kernel code, 2443K rwdata, 29892K rodata, 15356K init, 2688K bss, 118472K reserved, 0K cma-reserved) Nov 3 16:21:11.796473 kernel: devtmpfs: initialized Nov 3 16:21:11.796481 kernel: x86/mm: Memory block size: 128MB Nov 3 16:21:11.796490 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 3 16:21:11.796498 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 3 16:21:11.796506 kernel: pinctrl core: initialized pinctrl subsystem Nov 3 16:21:11.796518 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 3 16:21:11.796527 kernel: audit: initializing netlink subsys (disabled) Nov 3 16:21:11.796538 kernel: audit: type=2000 audit(1762186866.893:1): state=initialized audit_enabled=0 res=1 Nov 3 16:21:11.796546 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 3 16:21:11.796555 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 3 16:21:11.796563 kernel: cpuidle: using governor menu Nov 3 16:21:11.796571 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 3 16:21:11.796580 kernel: dca service started, version 1.12.1 Nov 3 16:21:11.796588 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Nov 3 16:21:11.796600 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Nov 3 16:21:11.796608 kernel: PCI: Using configuration type 1 for base access Nov 3 16:21:11.796617 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 3 16:21:11.796625 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 3 16:21:11.796634 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 3 16:21:11.796642 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 3 16:21:11.796651 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 3 16:21:11.796661 kernel: ACPI: Added _OSI(Module Device) Nov 3 16:21:11.796673 kernel: ACPI: Added _OSI(Processor Device) Nov 3 16:21:11.796699 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 3 16:21:11.796708 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 3 16:21:11.796719 kernel: ACPI: Interpreter enabled Nov 3 16:21:11.797145 kernel: ACPI: PM: (supports S0 S3 S5) Nov 3 16:21:11.797155 kernel: ACPI: Using IOAPIC for interrupt routing Nov 3 16:21:11.797164 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 3 16:21:11.797176 kernel: PCI: Using E820 reservations for host bridge windows Nov 3 16:21:11.797185 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 3 16:21:11.797194 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 3 16:21:11.797445 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 3 16:21:11.797629 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Nov 3 16:21:11.797810 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Nov 3 16:21:11.797821 kernel: PCI host bridge to bus 0000:00 Nov 3 16:21:11.798009 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 3 16:21:11.798219 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 3 16:21:11.798380 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 3 16:21:11.798552 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Nov 3 16:21:11.798730 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Nov 3 16:21:11.798901 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Nov 3 16:21:11.799065 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 3 16:21:11.799301 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 3 16:21:11.799497 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Nov 3 16:21:11.799677 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Nov 3 16:21:11.799992 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Nov 3 16:21:11.800191 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Nov 3 16:21:11.800366 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 3 16:21:11.800551 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Nov 3 16:21:11.800738 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Nov 3 16:21:11.800945 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Nov 3 16:21:11.801154 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Nov 3 16:21:11.801345 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Nov 3 16:21:11.801520 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Nov 3 16:21:11.801697 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Nov 3 16:21:11.801872 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Nov 3 16:21:11.802087 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 3 16:21:11.802314 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Nov 3 16:21:11.802492 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Nov 3 16:21:11.802665 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Nov 3 16:21:11.802837 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Nov 3 16:21:11.803027 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 3 16:21:11.803231 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 3 16:21:11.803422 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 3 16:21:11.803616 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Nov 3 16:21:11.803793 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Nov 3 16:21:11.803986 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 3 16:21:11.804187 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Nov 3 16:21:11.804200 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 3 16:21:11.804210 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 3 16:21:11.804219 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 3 16:21:11.804232 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 3 16:21:11.804240 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 3 16:21:11.804249 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 3 16:21:11.804262 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 3 16:21:11.804271 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 3 16:21:11.804279 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 3 16:21:11.804288 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 3 16:21:11.804297 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 3 16:21:11.804306 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 3 16:21:11.804315 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 3 16:21:11.804326 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 3 16:21:11.804335 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 3 16:21:11.804343 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 3 16:21:11.804352 kernel: iommu: Default domain type: Translated Nov 3 16:21:11.804361 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 3 16:21:11.804370 kernel: PCI: Using ACPI for IRQ routing Nov 3 16:21:11.804379 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 3 16:21:11.804390 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Nov 3 16:21:11.804399 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Nov 3 16:21:11.804572 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 3 16:21:11.804748 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 3 16:21:11.804929 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 3 16:21:11.804941 kernel: vgaarb: loaded Nov 3 16:21:11.804950 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Nov 3 16:21:11.804962 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Nov 3 16:21:11.804971 kernel: clocksource: Switched to clocksource kvm-clock Nov 3 16:21:11.804980 kernel: VFS: Disk quotas dquot_6.6.0 Nov 3 16:21:11.804989 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 3 16:21:11.804997 kernel: pnp: PnP ACPI init Nov 3 16:21:11.805226 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Nov 3 16:21:11.805245 kernel: pnp: PnP ACPI: found 6 devices Nov 3 16:21:11.805254 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 3 16:21:11.805263 kernel: NET: Registered PF_INET protocol family Nov 3 16:21:11.805272 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 3 16:21:11.805281 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 3 16:21:11.805290 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 3 16:21:11.805298 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 3 16:21:11.805310 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 3 16:21:11.805319 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 3 16:21:11.805327 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 3 16:21:11.805336 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 3 16:21:11.805345 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 3 16:21:11.805354 kernel: NET: Registered PF_XDP protocol family Nov 3 16:21:11.805516 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 3 16:21:11.805680 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 3 16:21:11.805840 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 3 16:21:11.806015 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Nov 3 16:21:11.806254 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Nov 3 16:21:11.806571 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Nov 3 16:21:11.806595 kernel: PCI: CLS 0 bytes, default 64 Nov 3 16:21:11.806611 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 3 16:21:11.806639 kernel: Initialise system trusted keyrings Nov 3 16:21:11.806655 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 3 16:21:11.806674 kernel: Key type asymmetric registered Nov 3 16:21:11.806690 kernel: Asymmetric key parser 'x509' registered Nov 3 16:21:11.806710 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 3 16:21:11.806726 kernel: io scheduler mq-deadline registered Nov 3 16:21:11.806742 kernel: io scheduler kyber registered Nov 3 16:21:11.806760 kernel: io scheduler bfq registered Nov 3 16:21:11.806779 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 3 16:21:11.806796 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 3 16:21:11.806812 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 3 16:21:11.806832 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Nov 3 16:21:11.806848 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 3 16:21:11.806863 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 3 16:21:11.806893 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 3 16:21:11.806913 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 3 16:21:11.806929 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 3 16:21:11.807258 kernel: rtc_cmos 00:04: RTC can wake from S4 Nov 3 16:21:11.807430 kernel: rtc_cmos 00:04: registered as rtc0 Nov 3 16:21:11.807442 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Nov 3 16:21:11.807611 kernel: rtc_cmos 00:04: setting system clock to 2025-11-03T16:21:09 UTC (1762186869) Nov 3 16:21:11.807808 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Nov 3 16:21:11.807820 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Nov 3 16:21:11.807829 kernel: NET: Registered PF_INET6 protocol family Nov 3 16:21:11.807838 kernel: Segment Routing with IPv6 Nov 3 16:21:11.807846 kernel: In-situ OAM (IOAM) with IPv6 Nov 3 16:21:11.807855 kernel: NET: Registered PF_PACKET protocol family Nov 3 16:21:11.807867 kernel: Key type dns_resolver registered Nov 3 16:21:11.807886 kernel: IPI shorthand broadcast: enabled Nov 3 16:21:11.807895 kernel: sched_clock: Marking stable (1911003315, 210484213)->(2974371176, -852883648) Nov 3 16:21:11.807903 kernel: registered taskstats version 1 Nov 3 16:21:11.807913 kernel: Loading compiled-in X.509 certificates Nov 3 16:21:11.807921 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: 64feed854ff613845f0d7f947c8dcfa082277d4d' Nov 3 16:21:11.807930 kernel: Demotion targets for Node 0: null Nov 3 16:21:11.807938 kernel: Key type .fscrypt registered Nov 3 16:21:11.807950 kernel: Key type fscrypt-provisioning registered Nov 3 16:21:11.807958 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 3 16:21:11.807967 kernel: ima: Allocated hash algorithm: sha1 Nov 3 16:21:11.807976 kernel: ima: No architecture policies found Nov 3 16:21:11.807984 kernel: clk: Disabling unused clocks Nov 3 16:21:11.807993 kernel: Freeing unused kernel image (initmem) memory: 15356K Nov 3 16:21:11.808002 kernel: Write protecting the kernel read-only data: 45056k Nov 3 16:21:11.808017 kernel: Freeing unused kernel image (rodata/data gap) memory: 828K Nov 3 16:21:11.808025 kernel: Run /init as init process Nov 3 16:21:11.808034 kernel: with arguments: Nov 3 16:21:11.808043 kernel: /init Nov 3 16:21:11.808052 kernel: with environment: Nov 3 16:21:11.808060 kernel: HOME=/ Nov 3 16:21:11.808084 kernel: TERM=linux Nov 3 16:21:11.808096 kernel: SCSI subsystem initialized Nov 3 16:21:11.808105 kernel: libata version 3.00 loaded. Nov 3 16:21:11.808284 kernel: ahci 0000:00:1f.2: version 3.0 Nov 3 16:21:11.808315 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 3 16:21:11.808489 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 3 16:21:11.808663 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 3 16:21:11.809021 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 3 16:21:11.809271 kernel: scsi host0: ahci Nov 3 16:21:11.809460 kernel: scsi host1: ahci Nov 3 16:21:11.809653 kernel: scsi host2: ahci Nov 3 16:21:11.809846 kernel: scsi host3: ahci Nov 3 16:21:11.810054 kernel: scsi host4: ahci Nov 3 16:21:11.810306 kernel: scsi host5: ahci Nov 3 16:21:11.810321 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 26 lpm-pol 1 Nov 3 16:21:11.810330 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 26 lpm-pol 1 Nov 3 16:21:11.810339 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 26 lpm-pol 1 Nov 3 16:21:11.810349 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 26 lpm-pol 1 Nov 3 16:21:11.810359 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 26 lpm-pol 1 Nov 3 16:21:11.810373 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 26 lpm-pol 1 Nov 3 16:21:11.810382 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 3 16:21:11.810391 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 3 16:21:11.810400 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 3 16:21:11.810409 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 3 16:21:11.810418 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Nov 3 16:21:11.810427 kernel: ata3.00: LPM support broken, forcing max_power Nov 3 16:21:11.810438 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Nov 3 16:21:11.810447 kernel: ata3.00: applying bridge limits Nov 3 16:21:11.810456 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 3 16:21:11.810465 kernel: ata3.00: LPM support broken, forcing max_power Nov 3 16:21:11.810474 kernel: ata3.00: configured for UDMA/100 Nov 3 16:21:11.810690 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Nov 3 16:21:11.810890 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Nov 3 16:21:11.811086 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Nov 3 16:21:11.811100 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 3 16:21:11.811121 kernel: GPT:16515071 != 27000831 Nov 3 16:21:11.811130 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 3 16:21:11.811139 kernel: GPT:16515071 != 27000831 Nov 3 16:21:11.811148 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 3 16:21:11.811161 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 3 16:21:11.811361 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Nov 3 16:21:11.811374 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 3 16:21:11.811563 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Nov 3 16:21:11.811576 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 3 16:21:11.811585 kernel: device-mapper: uevent: version 1.0.3 Nov 3 16:21:11.811594 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 3 16:21:11.811607 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Nov 3 16:21:11.811619 kernel: raid6: avx2x4 gen() 27780 MB/s Nov 3 16:21:11.811628 kernel: raid6: avx2x2 gen() 31209 MB/s Nov 3 16:21:11.811637 kernel: raid6: avx2x1 gen() 25800 MB/s Nov 3 16:21:11.811648 kernel: raid6: using algorithm avx2x2 gen() 31209 MB/s Nov 3 16:21:11.811658 kernel: raid6: .... xor() 19155 MB/s, rmw enabled Nov 3 16:21:11.811667 kernel: raid6: using avx2x2 recovery algorithm Nov 3 16:21:11.811676 kernel: xor: automatically using best checksumming function avx Nov 3 16:21:11.811685 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 3 16:21:11.811694 kernel: BTRFS: device fsid d2035e3e-4715-43f6-863f-bec7c8f679e4 devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (182) Nov 3 16:21:11.811704 kernel: BTRFS info (device dm-0): first mount of filesystem d2035e3e-4715-43f6-863f-bec7c8f679e4 Nov 3 16:21:11.811716 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 3 16:21:11.811725 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 3 16:21:11.811734 kernel: BTRFS info (device dm-0): enabling free space tree Nov 3 16:21:11.811743 kernel: loop: module loaded Nov 3 16:21:11.811752 kernel: loop0: detected capacity change from 0 to 100136 Nov 3 16:21:11.811761 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 3 16:21:11.811771 systemd[1]: Successfully made /usr/ read-only. Nov 3 16:21:11.811786 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 3 16:21:11.811798 systemd[1]: Detected virtualization kvm. Nov 3 16:21:11.811808 systemd[1]: Detected architecture x86-64. Nov 3 16:21:11.811817 systemd[1]: Running in initrd. Nov 3 16:21:11.811826 systemd[1]: No hostname configured, using default hostname. Nov 3 16:21:11.811836 systemd[1]: Hostname set to . Nov 3 16:21:11.811848 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 3 16:21:11.811857 systemd[1]: Queued start job for default target initrd.target. Nov 3 16:21:11.811867 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 3 16:21:11.811885 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 3 16:21:11.811895 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 3 16:21:11.811905 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 3 16:21:11.811918 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 3 16:21:11.811928 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 3 16:21:11.811938 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 3 16:21:11.811948 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 3 16:21:11.811957 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 3 16:21:11.811967 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 3 16:21:11.811979 systemd[1]: Reached target paths.target - Path Units. Nov 3 16:21:11.811988 systemd[1]: Reached target slices.target - Slice Units. Nov 3 16:21:11.811998 systemd[1]: Reached target swap.target - Swaps. Nov 3 16:21:11.812007 systemd[1]: Reached target timers.target - Timer Units. Nov 3 16:21:11.812017 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 3 16:21:11.812026 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 3 16:21:11.812036 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 3 16:21:11.812048 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 3 16:21:11.812058 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 3 16:21:11.812087 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 3 16:21:11.812097 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 3 16:21:11.812107 systemd[1]: Reached target sockets.target - Socket Units. Nov 3 16:21:11.812116 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 3 16:21:11.812129 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 3 16:21:11.812139 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 3 16:21:11.812148 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 3 16:21:11.812158 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 3 16:21:11.812168 systemd[1]: Starting systemd-fsck-usr.service... Nov 3 16:21:11.812177 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 3 16:21:11.812187 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 3 16:21:11.812199 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 3 16:21:11.812209 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 3 16:21:11.812219 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 3 16:21:11.812229 systemd[1]: Finished systemd-fsck-usr.service. Nov 3 16:21:11.812241 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 3 16:21:11.812419 systemd-journald[317]: Collecting audit messages is disabled. Nov 3 16:21:11.812442 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 3 16:21:11.812455 systemd-journald[317]: Journal started Nov 3 16:21:11.812478 systemd-journald[317]: Runtime Journal (/run/log/journal/7b4e45c6458c4de488a79791ba7c5999) is 6M, max 48.2M, 42.2M free. Nov 3 16:21:11.815131 systemd[1]: Started systemd-journald.service - Journal Service. Nov 3 16:21:11.815163 kernel: Bridge firewalling registered Nov 3 16:21:11.817423 systemd-modules-load[319]: Inserted module 'br_netfilter' Nov 3 16:21:11.820874 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 3 16:21:11.896642 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 3 16:21:11.901518 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 3 16:21:11.906405 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 3 16:21:11.910951 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 3 16:21:11.922151 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 3 16:21:11.923687 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 3 16:21:11.940122 systemd-tmpfiles[343]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 3 16:21:11.944305 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 3 16:21:11.948931 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 3 16:21:11.952476 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 3 16:21:11.955333 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 3 16:21:11.957953 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 3 16:21:11.965855 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 3 16:21:12.000898 dracut-cmdline[359]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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=e9d538d1fb909beabac60fa40d47676de06d795b9bab2159a3819b90e410c77a Nov 3 16:21:12.038827 systemd-resolved[360]: Positive Trust Anchors: Nov 3 16:21:12.038843 systemd-resolved[360]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 3 16:21:12.038847 systemd-resolved[360]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 3 16:21:12.038887 systemd-resolved[360]: 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 Nov 3 16:21:12.057625 systemd-resolved[360]: Defaulting to hostname 'linux'. Nov 3 16:21:12.064011 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 3 16:21:12.068000 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 3 16:21:12.164142 kernel: Loading iSCSI transport class v2.0-870. Nov 3 16:21:12.181123 kernel: iscsi: registered transport (tcp) Nov 3 16:21:12.205368 kernel: iscsi: registered transport (qla4xxx) Nov 3 16:21:12.205457 kernel: QLogic iSCSI HBA Driver Nov 3 16:21:12.242853 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 3 16:21:12.284808 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 3 16:21:12.286631 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 3 16:21:12.365981 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 3 16:21:12.369109 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 3 16:21:12.371387 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 3 16:21:12.418979 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 3 16:21:12.424176 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 3 16:21:12.462092 systemd-udevd[602]: Using default interface naming scheme 'v257'. Nov 3 16:21:12.476025 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 3 16:21:12.482955 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 3 16:21:12.527084 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 3 16:21:12.534106 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 3 16:21:12.581672 dracut-pre-trigger[670]: rd.md=0: removing MD RAID activation Nov 3 16:21:12.605175 systemd-networkd[703]: lo: Link UP Nov 3 16:21:12.605193 systemd-networkd[703]: lo: Gained carrier Nov 3 16:21:12.608214 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 3 16:21:12.610250 systemd[1]: Reached target network.target - Network. Nov 3 16:21:12.618764 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 3 16:21:12.623977 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 3 16:21:12.728915 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 3 16:21:12.735593 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 3 16:21:12.794319 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 3 16:21:12.809393 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 3 16:21:12.821105 kernel: cryptd: max_cpu_qlen set to 1000 Nov 3 16:21:12.839375 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 3 16:21:12.852099 kernel: AES CTR mode by8 optimization enabled Nov 3 16:21:12.852367 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 3 16:21:12.862240 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 3 16:21:12.917293 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 3 16:21:12.919214 systemd-networkd[703]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 3 16:21:12.933321 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Nov 3 16:21:12.919220 systemd-networkd[703]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 3 16:21:12.919321 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 3 16:21:12.919693 systemd-networkd[703]: eth0: Link UP Nov 3 16:21:12.921101 systemd-networkd[703]: eth0: Gained carrier Nov 3 16:21:12.921110 systemd-networkd[703]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 3 16:21:12.924195 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 3 16:21:12.931292 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 3 16:21:12.944176 systemd-networkd[703]: eth0: DHCPv4 address 10.0.0.59/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 3 16:21:13.043121 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 3 16:21:13.065985 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 3 16:21:13.070519 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 3 16:21:13.072674 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 3 16:21:13.076508 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 3 16:21:13.079669 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 3 16:21:13.107760 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 3 16:21:13.124173 disk-uuid[820]: Primary Header is updated. Nov 3 16:21:13.124173 disk-uuid[820]: Secondary Entries is updated. Nov 3 16:21:13.124173 disk-uuid[820]: Secondary Header is updated. Nov 3 16:21:13.238397 systemd-resolved[360]: Detected conflict on linux IN A 10.0.0.59 Nov 3 16:21:13.238416 systemd-resolved[360]: Hostname conflict, changing published hostname from 'linux' to 'linux4'. Nov 3 16:21:14.171245 disk-uuid[857]: Warning: The kernel is still using the old partition table. Nov 3 16:21:14.171245 disk-uuid[857]: The new table will be used at the next reboot or after you Nov 3 16:21:14.171245 disk-uuid[857]: run partprobe(8) or kpartx(8) Nov 3 16:21:14.171245 disk-uuid[857]: The operation has completed successfully. Nov 3 16:21:14.185898 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 3 16:21:14.186061 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 3 16:21:14.189216 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 3 16:21:14.274127 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (867) Nov 3 16:21:14.277529 kernel: BTRFS info (device vda6): first mount of filesystem 78119da2-288c-42f1-b313-2f60b0c42ea0 Nov 3 16:21:14.277580 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 3 16:21:14.282604 kernel: BTRFS info (device vda6): turning on async discard Nov 3 16:21:14.282647 kernel: BTRFS info (device vda6): enabling free space tree Nov 3 16:21:14.291119 kernel: BTRFS info (device vda6): last unmount of filesystem 78119da2-288c-42f1-b313-2f60b0c42ea0 Nov 3 16:21:14.292729 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 3 16:21:14.294708 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 3 16:21:14.343272 systemd-networkd[703]: eth0: Gained IPv6LL Nov 3 16:21:14.722111 ignition[886]: Ignition 2.22.0 Nov 3 16:21:14.722125 ignition[886]: Stage: fetch-offline Nov 3 16:21:14.722170 ignition[886]: no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:14.722206 ignition[886]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:14.722309 ignition[886]: parsed url from cmdline: "" Nov 3 16:21:14.722313 ignition[886]: no config URL provided Nov 3 16:21:14.722318 ignition[886]: reading system config file "/usr/lib/ignition/user.ign" Nov 3 16:21:14.722329 ignition[886]: no config at "/usr/lib/ignition/user.ign" Nov 3 16:21:14.722375 ignition[886]: op(1): [started] loading QEMU firmware config module Nov 3 16:21:14.722380 ignition[886]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 3 16:21:14.740665 ignition[886]: op(1): [finished] loading QEMU firmware config module Nov 3 16:21:14.742560 ignition[886]: parsing config with SHA512: b18707f4d832e5b571057c8ff1db80e6117f35856ab187b9ef3de41e370205805ba854d9abe9fe486ac59dd1f0c9bf61b7856cea2e6bb1f2b2d0205717ca757c Nov 3 16:21:14.748170 unknown[886]: fetched base config from "system" Nov 3 16:21:14.748189 unknown[886]: fetched user config from "qemu" Nov 3 16:21:14.748504 ignition[886]: fetch-offline: fetch-offline passed Nov 3 16:21:14.748593 ignition[886]: Ignition finished successfully Nov 3 16:21:14.752056 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 3 16:21:14.753027 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 3 16:21:14.757227 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 3 16:21:14.813008 ignition[898]: Ignition 2.22.0 Nov 3 16:21:14.813022 ignition[898]: Stage: kargs Nov 3 16:21:14.813186 ignition[898]: no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:14.813197 ignition[898]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:14.813741 ignition[898]: kargs: kargs passed Nov 3 16:21:14.813787 ignition[898]: Ignition finished successfully Nov 3 16:21:14.822046 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 3 16:21:14.826247 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 3 16:21:14.923949 ignition[906]: Ignition 2.22.0 Nov 3 16:21:14.923963 ignition[906]: Stage: disks Nov 3 16:21:14.928537 ignition[906]: no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:14.928559 ignition[906]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:14.930237 ignition[906]: disks: disks passed Nov 3 16:21:14.930306 ignition[906]: Ignition finished successfully Nov 3 16:21:14.936994 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 3 16:21:14.940760 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 3 16:21:14.944510 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 3 16:21:14.948308 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 3 16:21:14.948934 systemd[1]: Reached target sysinit.target - System Initialization. Nov 3 16:21:14.952560 systemd[1]: Reached target basic.target - Basic System. Nov 3 16:21:14.957459 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 3 16:21:15.007343 systemd-fsck[916]: ROOT: clean, 15/456736 files, 38230/456704 blocks Nov 3 16:21:15.016461 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 3 16:21:15.021481 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 3 16:21:15.144097 kernel: EXT4-fs (vda9): mounted filesystem 1ffbd672-550b-441b-a3fe-835a1dd6d831 r/w with ordered data mode. Quota mode: none. Nov 3 16:21:15.144558 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 3 16:21:15.146317 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 3 16:21:15.150455 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 3 16:21:15.153210 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 3 16:21:15.155056 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 3 16:21:15.155115 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 3 16:21:15.155141 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 3 16:21:15.168280 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 3 16:21:15.177045 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (924) Nov 3 16:21:15.177107 kernel: BTRFS info (device vda6): first mount of filesystem 78119da2-288c-42f1-b313-2f60b0c42ea0 Nov 3 16:21:15.177130 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 3 16:21:15.170933 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 3 16:21:15.183404 kernel: BTRFS info (device vda6): turning on async discard Nov 3 16:21:15.183424 kernel: BTRFS info (device vda6): enabling free space tree Nov 3 16:21:15.185610 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 3 16:21:15.247747 initrd-setup-root[948]: cut: /sysroot/etc/passwd: No such file or directory Nov 3 16:21:15.253059 initrd-setup-root[955]: cut: /sysroot/etc/group: No such file or directory Nov 3 16:21:15.258437 initrd-setup-root[962]: cut: /sysroot/etc/shadow: No such file or directory Nov 3 16:21:15.264912 initrd-setup-root[969]: cut: /sysroot/etc/gshadow: No such file or directory Nov 3 16:21:15.380372 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 3 16:21:15.383879 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 3 16:21:15.386399 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 3 16:21:15.411231 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 3 16:21:15.413624 kernel: BTRFS info (device vda6): last unmount of filesystem 78119da2-288c-42f1-b313-2f60b0c42ea0 Nov 3 16:21:15.426158 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 3 16:21:15.477728 ignition[1038]: INFO : Ignition 2.22.0 Nov 3 16:21:15.477728 ignition[1038]: INFO : Stage: mount Nov 3 16:21:15.480406 ignition[1038]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:15.480406 ignition[1038]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:15.480406 ignition[1038]: INFO : mount: mount passed Nov 3 16:21:15.480406 ignition[1038]: INFO : Ignition finished successfully Nov 3 16:21:15.489583 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 3 16:21:15.491953 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 3 16:21:15.525871 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 3 16:21:15.565105 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1050) Nov 3 16:21:15.568926 kernel: BTRFS info (device vda6): first mount of filesystem 78119da2-288c-42f1-b313-2f60b0c42ea0 Nov 3 16:21:15.568955 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 3 16:21:15.573178 kernel: BTRFS info (device vda6): turning on async discard Nov 3 16:21:15.573220 kernel: BTRFS info (device vda6): enabling free space tree Nov 3 16:21:15.575130 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 3 16:21:15.628110 ignition[1067]: INFO : Ignition 2.22.0 Nov 3 16:21:15.628110 ignition[1067]: INFO : Stage: files Nov 3 16:21:15.630784 ignition[1067]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:15.630784 ignition[1067]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:15.630784 ignition[1067]: DEBUG : files: compiled without relabeling support, skipping Nov 3 16:21:15.636650 ignition[1067]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 3 16:21:15.636650 ignition[1067]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 3 16:21:15.643934 ignition[1067]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 3 16:21:15.646248 ignition[1067]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 3 16:21:15.646248 ignition[1067]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 3 16:21:15.645081 unknown[1067]: wrote ssh authorized keys file for user: core Nov 3 16:21:15.652315 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Nov 3 16:21:15.652315 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Nov 3 16:21:15.658569 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 3 16:21:15.658569 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 3 16:21:15.658569 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 3 16:21:15.668361 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 3 16:21:15.668361 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 3 16:21:15.668361 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-x86-64.raw: attempt #1 Nov 3 16:21:15.992359 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Nov 3 16:21:16.532945 ignition[1067]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 3 16:21:16.532945 ignition[1067]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Nov 3 16:21:16.539192 ignition[1067]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 3 16:21:16.539192 ignition[1067]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 3 16:21:16.539192 ignition[1067]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Nov 3 16:21:16.539192 ignition[1067]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Nov 3 16:21:16.568448 ignition[1067]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 3 16:21:16.572691 ignition[1067]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 3 16:21:16.575311 ignition[1067]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Nov 3 16:21:16.575311 ignition[1067]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 3 16:21:16.575311 ignition[1067]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 3 16:21:16.575311 ignition[1067]: INFO : files: files passed Nov 3 16:21:16.575311 ignition[1067]: INFO : Ignition finished successfully Nov 3 16:21:16.586468 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 3 16:21:16.590902 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 3 16:21:16.595260 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 3 16:21:16.608522 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 3 16:21:16.608711 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 3 16:21:16.617386 initrd-setup-root-after-ignition[1098]: grep: /sysroot/oem/oem-release: No such file or directory Nov 3 16:21:16.623006 initrd-setup-root-after-ignition[1100]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 3 16:21:16.625614 initrd-setup-root-after-ignition[1100]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 3 16:21:16.628161 initrd-setup-root-after-ignition[1104]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 3 16:21:16.631462 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 3 16:21:16.636418 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 3 16:21:16.641306 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 3 16:21:16.713030 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 3 16:21:16.713197 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 3 16:21:16.714277 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 3 16:21:16.718958 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 3 16:21:16.722997 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 3 16:21:16.724053 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 3 16:21:16.765320 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 3 16:21:16.768332 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 3 16:21:16.793350 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 3 16:21:16.793661 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 3 16:21:16.794765 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 3 16:21:16.795588 systemd[1]: Stopped target timers.target - Timer Units. Nov 3 16:21:16.806061 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 3 16:21:16.806328 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 3 16:21:16.811709 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 3 16:21:16.812513 systemd[1]: Stopped target basic.target - Basic System. Nov 3 16:21:16.815634 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 3 16:21:16.818741 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 3 16:21:16.821832 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 3 16:21:16.828237 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 3 16:21:16.829034 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 3 16:21:16.832688 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 3 16:21:16.836573 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 3 16:21:16.840669 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 3 16:21:16.843863 systemd[1]: Stopped target swap.target - Swaps. Nov 3 16:21:16.844639 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 3 16:21:16.844830 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 3 16:21:16.851853 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 3 16:21:16.852940 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 3 16:21:16.857144 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 3 16:21:16.857285 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 3 16:21:16.860808 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 3 16:21:16.860943 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 3 16:21:16.867372 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 3 16:21:16.867527 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 3 16:21:16.868610 systemd[1]: Stopped target paths.target - Path Units. Nov 3 16:21:16.925543 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 3 16:21:16.932692 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 3 16:21:16.933697 systemd[1]: Stopped target slices.target - Slice Units. Nov 3 16:21:16.938158 systemd[1]: Stopped target sockets.target - Socket Units. Nov 3 16:21:16.941135 systemd[1]: iscsid.socket: Deactivated successfully. Nov 3 16:21:16.941238 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 3 16:21:16.943916 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 3 16:21:16.944002 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 3 16:21:16.946668 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 3 16:21:16.946802 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 3 16:21:16.949603 systemd[1]: ignition-files.service: Deactivated successfully. Nov 3 16:21:16.949713 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 3 16:21:16.957556 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 3 16:21:16.958633 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 3 16:21:16.958744 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 3 16:21:16.977731 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 3 16:21:16.979274 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 3 16:21:16.979403 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 3 16:21:16.981491 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 3 16:21:16.981599 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 3 16:21:16.984915 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 3 16:21:16.985092 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 3 16:21:16.993786 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 3 16:21:16.993914 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 3 16:21:17.008350 ignition[1124]: INFO : Ignition 2.22.0 Nov 3 16:21:17.008350 ignition[1124]: INFO : Stage: umount Nov 3 16:21:17.011280 ignition[1124]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 3 16:21:17.011280 ignition[1124]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 3 16:21:17.011280 ignition[1124]: INFO : umount: umount passed Nov 3 16:21:17.011280 ignition[1124]: INFO : Ignition finished successfully Nov 3 16:21:17.015257 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 3 16:21:17.015397 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 3 16:21:17.019369 systemd[1]: Stopped target network.target - Network. Nov 3 16:21:17.019966 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 3 16:21:17.020035 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 3 16:21:17.023903 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 3 16:21:17.023963 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 3 16:21:17.026691 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 3 16:21:17.026749 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 3 16:21:17.029719 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 3 16:21:17.029781 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 3 16:21:17.032818 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 3 16:21:17.036319 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 3 16:21:17.044983 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 3 16:21:17.050027 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 3 16:21:17.050226 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 3 16:21:17.055992 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 3 16:21:17.060909 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 3 16:21:17.060963 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 3 16:21:17.062516 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 3 16:21:17.064869 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 3 16:21:17.064941 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 3 16:21:17.065774 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 3 16:21:17.077218 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 3 16:21:17.082335 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 3 16:21:17.087855 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 3 16:21:17.087974 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 3 16:21:17.088975 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 3 16:21:17.089025 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 3 16:21:17.097574 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 3 16:21:17.097704 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 3 16:21:17.099777 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 3 16:21:17.099948 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 3 16:21:17.104132 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 3 16:21:17.104211 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 3 16:21:17.106146 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 3 16:21:17.106188 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 3 16:21:17.110168 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 3 16:21:17.110227 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 3 16:21:17.111606 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 3 16:21:17.111656 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 3 16:21:17.118320 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 3 16:21:17.118383 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 3 16:21:17.120511 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 3 16:21:17.120577 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 3 16:21:17.126549 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 3 16:21:17.128664 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 3 16:21:17.128724 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 3 16:21:17.131557 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 3 16:21:17.131611 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 3 16:21:17.152204 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 3 16:21:17.152274 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 3 16:21:17.168224 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 3 16:21:17.169858 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 3 16:21:17.173576 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 3 16:21:17.173711 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 3 16:21:17.178893 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 3 16:21:17.180615 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 3 16:21:17.209715 systemd[1]: Switching root. Nov 3 16:21:17.252941 systemd-journald[317]: Journal stopped Nov 3 16:21:18.683448 systemd-journald[317]: Received SIGTERM from PID 1 (systemd). Nov 3 16:21:18.683536 kernel: SELinux: policy capability network_peer_controls=1 Nov 3 16:21:18.683561 kernel: SELinux: policy capability open_perms=1 Nov 3 16:21:18.683579 kernel: SELinux: policy capability extended_socket_class=1 Nov 3 16:21:18.683599 kernel: SELinux: policy capability always_check_network=0 Nov 3 16:21:18.683622 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 3 16:21:18.683645 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 3 16:21:18.683661 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 3 16:21:18.683676 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 3 16:21:18.683702 kernel: SELinux: policy capability userspace_initial_context=0 Nov 3 16:21:18.683718 kernel: audit: type=1403 audit(1762186877.795:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 3 16:21:18.683746 systemd[1]: Successfully loaded SELinux policy in 64.114ms. Nov 3 16:21:18.683783 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.112ms. Nov 3 16:21:18.683802 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 3 16:21:18.683819 systemd[1]: Detected virtualization kvm. Nov 3 16:21:18.683839 systemd[1]: Detected architecture x86-64. Nov 3 16:21:18.683863 systemd[1]: Detected first boot. Nov 3 16:21:18.683879 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 3 16:21:18.683896 kernel: Guest personality initialized and is inactive Nov 3 16:21:18.683912 zram_generator::config[1169]: No configuration found. Nov 3 16:21:18.683930 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Nov 3 16:21:18.683944 kernel: Initialized host personality Nov 3 16:21:18.683962 kernel: NET: Registered PF_VSOCK protocol family Nov 3 16:21:18.683980 systemd[1]: Populated /etc with preset unit settings. Nov 3 16:21:18.683993 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 3 16:21:18.684007 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 3 16:21:18.684026 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 3 16:21:18.684039 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 3 16:21:18.684058 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 3 16:21:18.684099 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 3 16:21:18.684114 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 3 16:21:18.684127 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 3 16:21:18.684146 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 3 16:21:18.684160 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 3 16:21:18.684175 systemd[1]: Created slice user.slice - User and Session Slice. Nov 3 16:21:18.684188 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 3 16:21:18.684201 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 3 16:21:18.684215 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 3 16:21:18.684228 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 3 16:21:18.684243 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 3 16:21:18.684256 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 3 16:21:18.684278 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 3 16:21:18.684291 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 3 16:21:18.684304 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 3 16:21:18.684316 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 3 16:21:18.684329 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 3 16:21:18.684343 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 3 16:21:18.684359 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 3 16:21:18.684373 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 3 16:21:18.684390 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 3 16:21:18.684408 systemd[1]: Reached target slices.target - Slice Units. Nov 3 16:21:18.684425 systemd[1]: Reached target swap.target - Swaps. Nov 3 16:21:18.684444 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 3 16:21:18.684462 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 3 16:21:18.684482 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 3 16:21:18.684509 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 3 16:21:18.684525 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 3 16:21:18.684541 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 3 16:21:18.684559 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 3 16:21:18.684576 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 3 16:21:18.684593 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 3 16:21:18.684611 systemd[1]: Mounting media.mount - External Media Directory... Nov 3 16:21:18.684633 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:18.684647 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 3 16:21:18.684659 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 3 16:21:18.684672 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 3 16:21:18.684685 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). Nov 3 16:21:18.684698 systemd[1]: Reached target machines.target - Containers. Nov 3 16:21:18.684710 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 3 16:21:18.684735 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 3 16:21:18.684750 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 3 16:21:18.684763 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 3 16:21:18.684777 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 3 16:21:18.684794 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 3 16:21:18.684812 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 3 16:21:18.684839 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 3 16:21:18.684861 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 3 16:21:18.684879 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 3 16:21:18.684897 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 3 16:21:18.684914 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 3 16:21:18.684931 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 3 16:21:18.684948 systemd[1]: Stopped systemd-fsck-usr.service. Nov 3 16:21:18.684976 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 3 16:21:18.684995 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 3 16:21:18.685012 kernel: fuse: init (API version 7.41) Nov 3 16:21:18.685028 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 3 16:21:18.685044 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 3 16:21:18.685061 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 3 16:21:18.685188 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 3 16:21:18.685211 kernel: ACPI: bus type drm_connector registered Nov 3 16:21:18.685224 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 3 16:21:18.685238 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:18.685251 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 3 16:21:18.685274 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 3 16:21:18.685294 systemd[1]: Mounted media.mount - External Media Directory. Nov 3 16:21:18.685311 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 3 16:21:18.685360 systemd-journald[1247]: Collecting audit messages is disabled. Nov 3 16:21:18.685392 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 3 16:21:18.685411 systemd-journald[1247]: Journal started Nov 3 16:21:18.685450 systemd-journald[1247]: Runtime Journal (/run/log/journal/7b4e45c6458c4de488a79791ba7c5999) is 6M, max 48.2M, 42.2M free. Nov 3 16:21:18.685499 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 3 16:21:18.373273 systemd[1]: Queued start job for default target multi-user.target. Nov 3 16:21:18.387241 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 3 16:21:18.387812 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 3 16:21:18.690113 systemd[1]: Started systemd-journald.service - Journal Service. Nov 3 16:21:18.692636 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 3 16:21:18.694847 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 3 16:21:18.697159 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 3 16:21:18.697385 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 3 16:21:18.699545 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 3 16:21:18.699788 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 3 16:21:18.701895 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 3 16:21:18.702126 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 3 16:21:18.704408 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 3 16:21:18.704628 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 3 16:21:18.706873 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 3 16:21:18.707191 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 3 16:21:18.709336 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 3 16:21:18.709558 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 3 16:21:18.711776 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 3 16:21:18.714038 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 3 16:21:18.717128 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 3 16:21:18.719719 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 3 16:21:18.741020 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 3 16:21:18.743253 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Nov 3 16:21:18.745293 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 3 16:21:18.745326 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 3 16:21:18.747942 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 3 16:21:18.750124 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 3 16:21:18.751494 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 3 16:21:18.754236 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 3 16:21:18.756113 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 3 16:21:18.758742 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 3 16:21:18.761246 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 3 16:21:18.765259 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 3 16:21:18.769400 systemd-journald[1247]: Time spent on flushing to /var/log/journal/7b4e45c6458c4de488a79791ba7c5999 is 17.402ms for 946 entries. Nov 3 16:21:18.769400 systemd-journald[1247]: System Journal (/var/log/journal/7b4e45c6458c4de488a79791ba7c5999) is 8M, max 163.5M, 155.5M free. Nov 3 16:21:18.806518 systemd-journald[1247]: Received client request to flush runtime journal. Nov 3 16:21:18.806624 kernel: loop1: detected capacity change from 0 to 119080 Nov 3 16:21:18.771016 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 3 16:21:18.776212 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 3 16:21:18.778857 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 3 16:21:18.781314 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 3 16:21:18.784704 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 3 16:21:18.794702 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 3 16:21:18.798882 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 3 16:21:18.808854 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 3 16:21:18.829110 kernel: loop2: detected capacity change from 0 to 224512 Nov 3 16:21:18.829613 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 3 16:21:18.832258 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 3 16:21:18.837828 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 3 16:21:18.842226 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 3 16:21:18.860790 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 3 16:21:18.864113 kernel: loop3: detected capacity change from 0 to 111544 Nov 3 16:21:18.877028 systemd-tmpfiles[1304]: ACLs are not supported, ignoring. Nov 3 16:21:18.877047 systemd-tmpfiles[1304]: ACLs are not supported, ignoring. Nov 3 16:21:18.882225 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 3 16:21:18.896094 kernel: loop4: detected capacity change from 0 to 119080 Nov 3 16:21:18.905091 kernel: loop5: detected capacity change from 0 to 224512 Nov 3 16:21:18.908818 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 3 16:21:18.914098 kernel: loop6: detected capacity change from 0 to 111544 Nov 3 16:21:18.920575 (sd-merge)[1309]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'kubernetes.raw'. Nov 3 16:21:18.924789 (sd-merge)[1309]: Merged extensions into '/usr'. Nov 3 16:21:18.929680 systemd[1]: Reload requested from client PID 1286 ('systemd-sysext') (unit systemd-sysext.service)... Nov 3 16:21:18.929786 systemd[1]: Reloading... Nov 3 16:21:18.983502 systemd-resolved[1302]: Positive Trust Anchors: Nov 3 16:21:18.983521 systemd-resolved[1302]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 3 16:21:18.983526 systemd-resolved[1302]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 3 16:21:18.983557 systemd-resolved[1302]: 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 Nov 3 16:21:18.990610 systemd-resolved[1302]: Defaulting to hostname 'linux'. Nov 3 16:21:19.060124 zram_generator::config[1343]: No configuration found. Nov 3 16:21:19.305302 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 3 16:21:19.305396 systemd[1]: Reloading finished in 375 ms. Nov 3 16:21:19.338836 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 3 16:21:19.341230 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 3 16:21:19.345868 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 3 16:21:19.366693 systemd[1]: Starting ensure-sysext.service... Nov 3 16:21:19.369161 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 3 16:21:19.389980 systemd-tmpfiles[1380]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 3 16:21:19.390022 systemd-tmpfiles[1380]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 3 16:21:19.390345 systemd-tmpfiles[1380]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 3 16:21:19.390627 systemd-tmpfiles[1380]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 3 16:21:19.390944 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 3 16:21:19.393325 systemd-tmpfiles[1380]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 3 16:21:19.393607 systemd-tmpfiles[1380]: ACLs are not supported, ignoring. Nov 3 16:21:19.393684 systemd-tmpfiles[1380]: ACLs are not supported, ignoring. Nov 3 16:21:19.393865 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 3 16:21:19.403270 systemd[1]: Reload requested from client PID 1379 ('systemctl') (unit ensure-sysext.service)... Nov 3 16:21:19.403457 systemd[1]: Reloading... Nov 3 16:21:19.403554 systemd-tmpfiles[1380]: Detected autofs mount point /boot during canonicalization of boot. Nov 3 16:21:19.403571 systemd-tmpfiles[1380]: Skipping /boot Nov 3 16:21:19.419367 systemd-tmpfiles[1380]: Detected autofs mount point /boot during canonicalization of boot. Nov 3 16:21:19.419383 systemd-tmpfiles[1380]: Skipping /boot Nov 3 16:21:19.457384 zram_generator::config[1412]: No configuration found. Nov 3 16:21:19.655985 systemd[1]: Reloading finished in 252 ms. Nov 3 16:21:19.679874 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 3 16:21:19.706217 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 3 16:21:19.709480 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 3 16:21:19.711567 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 3 16:21:19.723609 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 3 16:21:19.726473 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 3 16:21:19.740616 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 3 16:21:19.744681 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 3 16:21:19.748960 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 3 16:21:19.755622 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 3 16:21:19.760256 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.760420 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 3 16:21:19.767286 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 3 16:21:19.772668 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 3 16:21:19.779402 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 3 16:21:19.781168 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 3 16:21:19.781288 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 3 16:21:19.781407 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.782748 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 3 16:21:19.784487 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 3 16:21:19.792365 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 3 16:21:19.794831 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 3 16:21:19.799629 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 3 16:21:19.802377 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 3 16:21:19.802468 systemd-udevd[1458]: Using default interface naming scheme 'v257'. Nov 3 16:21:19.802648 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 3 16:21:19.810906 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 3 16:21:19.825298 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.825841 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 3 16:21:19.828912 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 3 16:21:19.850088 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 3 16:21:19.854214 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 3 16:21:19.856104 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 3 16:21:19.856284 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 3 16:21:19.856478 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.857682 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 3 16:21:19.865240 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 3 16:21:19.868974 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 3 16:21:19.869464 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 3 16:21:19.874088 augenrules[1489]: No rules Nov 3 16:21:19.876591 systemd[1]: audit-rules.service: Deactivated successfully. Nov 3 16:21:19.876925 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 3 16:21:19.879523 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 3 16:21:19.879791 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 3 16:21:19.882315 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 3 16:21:19.898149 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.898464 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 3 16:21:19.902159 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 3 16:21:19.906268 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 3 16:21:19.910775 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 3 16:21:19.914469 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 3 16:21:19.914531 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 3 16:21:19.918343 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 3 16:21:19.921189 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 3 16:21:19.921832 systemd[1]: Finished ensure-sysext.service. Nov 3 16:21:19.935227 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 3 16:21:19.939133 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 3 16:21:19.942586 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 3 16:21:19.942836 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 3 16:21:19.945447 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 3 16:21:19.945672 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 3 16:21:19.948036 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 3 16:21:19.948420 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 3 16:21:19.964503 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 3 16:21:19.964583 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 3 16:21:19.964613 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). Nov 3 16:21:19.970168 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 3 16:21:20.075164 kernel: mousedev: PS/2 mouse device common for all mice Nov 3 16:21:20.094928 systemd-networkd[1520]: lo: Link UP Nov 3 16:21:20.094939 systemd-networkd[1520]: lo: Gained carrier Nov 3 16:21:20.096554 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 3 16:21:20.098197 systemd-networkd[1520]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 3 16:21:20.098212 systemd-networkd[1520]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 3 16:21:20.099292 systemd-networkd[1520]: eth0: Link UP Nov 3 16:21:20.099602 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 3 16:21:20.099605 systemd-networkd[1520]: eth0: Gained carrier Nov 3 16:21:20.099626 systemd-networkd[1520]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 3 16:21:20.106781 systemd[1]: Reached target network.target - Network. Nov 3 16:21:20.109490 systemd[1]: Reached target time-set.target - System Time Set. Nov 3 16:21:20.115277 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 3 16:21:20.120139 systemd-networkd[1520]: eth0: DHCPv4 address 10.0.0.59/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 3 16:21:20.120458 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 3 16:21:20.124119 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Nov 3 16:21:20.125168 systemd-timesyncd[1522]: Network configuration changed, trying to establish connection. Nov 3 16:21:20.129180 systemd-timesyncd[1522]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 3 16:21:20.129260 systemd-timesyncd[1522]: Initial clock synchronization to Mon 2025-11-03 16:21:20.208163 UTC. Nov 3 16:21:20.140095 kernel: ACPI: button: Power Button [PWRF] Nov 3 16:21:20.146655 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 3 16:21:20.156559 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 3 16:21:20.200324 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 3 16:21:20.206863 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 3 16:21:20.207255 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 3 16:21:20.250319 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 3 16:21:20.377501 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 3 16:21:20.423435 kernel: kvm_amd: TSC scaling supported Nov 3 16:21:20.423562 kernel: kvm_amd: Nested Virtualization enabled Nov 3 16:21:20.423578 kernel: kvm_amd: Nested Paging enabled Nov 3 16:21:20.423591 kernel: kvm_amd: LBR virtualization supported Nov 3 16:21:20.425528 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Nov 3 16:21:20.425563 kernel: kvm_amd: Virtual GIF supported Nov 3 16:21:20.477108 kernel: EDAC MC: Ver: 3.0.0 Nov 3 16:21:20.479937 ldconfig[1455]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 3 16:21:20.487914 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 3 16:21:20.551248 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 3 16:21:20.557061 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 3 16:21:20.583623 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 3 16:21:20.585618 systemd[1]: Reached target sysinit.target - System Initialization. Nov 3 16:21:20.587396 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 3 16:21:20.589374 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 3 16:21:20.591355 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 3 16:21:20.593359 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 3 16:21:20.595214 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 3 16:21:20.597204 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 3 16:21:20.599194 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 3 16:21:20.599227 systemd[1]: Reached target paths.target - Path Units. Nov 3 16:21:20.600664 systemd[1]: Reached target timers.target - Timer Units. Nov 3 16:21:20.602931 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 3 16:21:20.606207 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 3 16:21:20.609868 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 3 16:21:20.612044 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 3 16:21:20.614087 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 3 16:21:20.618356 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 3 16:21:20.620310 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 3 16:21:20.622792 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 3 16:21:20.625290 systemd[1]: Reached target sockets.target - Socket Units. Nov 3 16:21:20.626889 systemd[1]: Reached target basic.target - Basic System. Nov 3 16:21:20.628414 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 3 16:21:20.628447 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 3 16:21:20.629637 systemd[1]: Starting containerd.service - containerd container runtime... Nov 3 16:21:20.632371 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 3 16:21:20.634970 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 3 16:21:20.638429 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 3 16:21:20.641444 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 3 16:21:20.643143 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). Nov 3 16:21:20.644447 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 3 16:21:20.647604 jq[1578]: false Nov 3 16:21:20.649268 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 3 16:21:20.653250 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 3 16:21:20.655704 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Refreshing passwd entry cache Nov 3 16:21:20.656018 oslogin_cache_refresh[1580]: Refreshing passwd entry cache Nov 3 16:21:20.658905 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 3 16:21:20.663453 extend-filesystems[1579]: Found /dev/vda6 Nov 3 16:21:20.666178 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Failure getting users, quitting Nov 3 16:21:20.666178 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 3 16:21:20.666178 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Refreshing group entry cache Nov 3 16:21:20.665286 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 3 16:21:20.665138 oslogin_cache_refresh[1580]: Failure getting users, quitting Nov 3 16:21:20.665158 oslogin_cache_refresh[1580]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 3 16:21:20.665206 oslogin_cache_refresh[1580]: Refreshing group entry cache Nov 3 16:21:20.667013 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 3 16:21:20.667568 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 3 16:21:20.669221 systemd[1]: Starting update-engine.service - Update Engine... Nov 3 16:21:20.672564 extend-filesystems[1579]: Found /dev/vda9 Nov 3 16:21:20.675974 extend-filesystems[1579]: Checking size of /dev/vda9 Nov 3 16:21:20.676771 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Failure getting groups, quitting Nov 3 16:21:20.676771 google_oslogin_nss_cache[1580]: oslogin_cache_refresh[1580]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 3 16:21:20.676365 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 3 16:21:20.676346 oslogin_cache_refresh[1580]: Failure getting groups, quitting Nov 3 16:21:20.676362 oslogin_cache_refresh[1580]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 3 16:21:20.683651 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 3 16:21:20.686058 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 3 16:21:20.686363 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 3 16:21:20.686777 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 3 16:21:20.687044 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 3 16:21:20.689497 systemd[1]: motdgen.service: Deactivated successfully. Nov 3 16:21:20.689780 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 3 16:21:20.690395 extend-filesystems[1579]: Resized partition /dev/vda9 Nov 3 16:21:20.692017 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 3 16:21:20.694635 extend-filesystems[1607]: resize2fs 1.47.3 (8-Jul-2025) Nov 3 16:21:20.698570 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 3 16:21:20.704121 jq[1596]: true Nov 3 16:21:20.706102 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Nov 3 16:21:20.723239 update_engine[1594]: I20251103 16:21:20.723165 1594 main.cc:92] Flatcar Update Engine starting Nov 3 16:21:20.726339 jq[1615]: true Nov 3 16:21:20.746101 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Nov 3 16:21:20.847441 dbus-daemon[1576]: [system] SELinux support is enabled Nov 3 16:21:20.850254 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 3 16:21:20.881222 update_engine[1594]: I20251103 16:21:20.860514 1594 update_check_scheduler.cc:74] Next update check in 11m36s Nov 3 16:21:20.882780 extend-filesystems[1607]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 3 16:21:20.882780 extend-filesystems[1607]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 3 16:21:20.882780 extend-filesystems[1607]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Nov 3 16:21:20.891828 extend-filesystems[1579]: Resized filesystem in /dev/vda9 Nov 3 16:21:20.883225 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). Nov 3 16:21:20.883257 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 3 16:21:20.883808 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). Nov 3 16:21:20.883822 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 3 16:21:20.887387 systemd[1]: Started update-engine.service - Update Engine. Nov 3 16:21:20.892949 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 3 16:21:20.893593 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 3 16:21:20.893699 systemd-logind[1593]: Watching system buttons on /dev/input/event2 (Power Button) Nov 3 16:21:20.893723 systemd-logind[1593]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 3 16:21:20.894321 systemd-logind[1593]: New seat seat0. Nov 3 16:21:20.896629 systemd[1]: Started systemd-logind.service - User Login Management. Nov 3 16:21:20.903323 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 3 16:21:20.913937 bash[1641]: Updated "/home/core/.ssh/authorized_keys" Nov 3 16:21:20.920223 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 3 16:21:20.925133 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 3 16:21:20.957479 locksmithd[1642]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 3 16:21:21.301696 containerd[1612]: time="2025-11-03T16:21:21Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 3 16:21:21.302765 containerd[1612]: time="2025-11-03T16:21:21.302721816Z" level=info msg="starting containerd" revision=75cb2b7193e4e490e9fbdc236c0e811ccaba3376 version=v2.1.4 Nov 3 16:21:21.316291 containerd[1612]: time="2025-11-03T16:21:21.316203833Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="18.539µs" Nov 3 16:21:21.316291 containerd[1612]: time="2025-11-03T16:21:21.316271656Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 3 16:21:21.316451 containerd[1612]: time="2025-11-03T16:21:21.316328065Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 3 16:21:21.316451 containerd[1612]: time="2025-11-03T16:21:21.316347424Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 3 16:21:21.316649 containerd[1612]: time="2025-11-03T16:21:21.316614639Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 3 16:21:21.316649 containerd[1612]: time="2025-11-03T16:21:21.316639776Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 3 16:21:21.316749 containerd[1612]: time="2025-11-03T16:21:21.316717375Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 3 16:21:21.316749 containerd[1612]: time="2025-11-03T16:21:21.316736907Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317083 containerd[1612]: time="2025-11-03T16:21:21.317035270Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317083 containerd[1612]: time="2025-11-03T16:21:21.317059832Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317174 containerd[1612]: time="2025-11-03T16:21:21.317075143Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317174 containerd[1612]: time="2025-11-03T16:21:21.317164765Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317422 containerd[1612]: time="2025-11-03T16:21:21.317383060Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317422 containerd[1612]: time="2025-11-03T16:21:21.317407136Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317543 containerd[1612]: time="2025-11-03T16:21:21.317516804Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317815 containerd[1612]: time="2025-11-03T16:21:21.317781550Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317903 containerd[1612]: time="2025-11-03T16:21:21.317875654Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 3 16:21:21.317903 containerd[1612]: time="2025-11-03T16:21:21.317895419Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 3 16:21:21.317983 containerd[1612]: time="2025-11-03T16:21:21.317974951Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 3 16:21:21.318303 containerd[1612]: time="2025-11-03T16:21:21.318268872Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 3 16:21:21.318379 containerd[1612]: time="2025-11-03T16:21:21.318358281Z" level=info msg="metadata content store policy set" policy=shared Nov 3 16:21:21.324551 containerd[1612]: time="2025-11-03T16:21:21.324504945Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 3 16:21:21.324593 containerd[1612]: time="2025-11-03T16:21:21.324563094Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 3 16:21:21.324728 containerd[1612]: time="2025-11-03T16:21:21.324695351Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 3 16:21:21.324728 containerd[1612]: time="2025-11-03T16:21:21.324726783Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 3 16:21:21.324800 containerd[1612]: time="2025-11-03T16:21:21.324751921Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 3 16:21:21.324800 containerd[1612]: time="2025-11-03T16:21:21.324765714Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 3 16:21:21.324800 containerd[1612]: time="2025-11-03T16:21:21.324776602Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 3 16:21:21.324800 containerd[1612]: time="2025-11-03T16:21:21.324786966Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 3 16:21:21.324800 containerd[1612]: time="2025-11-03T16:21:21.324801245Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 3 16:21:21.324896 containerd[1612]: time="2025-11-03T16:21:21.324813500Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 3 16:21:21.324896 containerd[1612]: time="2025-11-03T16:21:21.324826433Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 3 16:21:21.324896 containerd[1612]: time="2025-11-03T16:21:21.324837767Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 3 16:21:21.324896 containerd[1612]: time="2025-11-03T16:21:21.324849406Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 3 16:21:21.324896 containerd[1612]: time="2025-11-03T16:21:21.324862227Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 3 16:21:21.325043 containerd[1612]: time="2025-11-03T16:21:21.325017648Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 3 16:21:21.325078 containerd[1612]: time="2025-11-03T16:21:21.325043797Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 3 16:21:21.325078 containerd[1612]: time="2025-11-03T16:21:21.325057125Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 3 16:21:21.325136 containerd[1612]: time="2025-11-03T16:21:21.325108271Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 3 16:21:21.325136 containerd[1612]: time="2025-11-03T16:21:21.325120597Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 3 16:21:21.325136 containerd[1612]: time="2025-11-03T16:21:21.325130647Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 3 16:21:21.325195 containerd[1612]: time="2025-11-03T16:21:21.325141110Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 3 16:21:21.325195 containerd[1612]: time="2025-11-03T16:21:21.325165327Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 3 16:21:21.325195 containerd[1612]: time="2025-11-03T16:21:21.325177512Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 3 16:21:21.325195 containerd[1612]: time="2025-11-03T16:21:21.325187763Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 3 16:21:21.325276 containerd[1612]: time="2025-11-03T16:21:21.325198297Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 3 16:21:21.325276 containerd[1612]: time="2025-11-03T16:21:21.325226785Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 3 16:21:21.325313 containerd[1612]: time="2025-11-03T16:21:21.325295580Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 3 16:21:21.325313 containerd[1612]: time="2025-11-03T16:21:21.325308989Z" level=info msg="Start snapshots syncer" Nov 3 16:21:21.325350 containerd[1612]: time="2025-11-03T16:21:21.325342455Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 3 16:21:21.325702 containerd[1612]: time="2025-11-03T16:21:21.325648045Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 3 16:21:21.325877 containerd[1612]: time="2025-11-03T16:21:21.325700638Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 3 16:21:21.325877 containerd[1612]: time="2025-11-03T16:21:21.325824231Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 3 16:21:21.325967 containerd[1612]: time="2025-11-03T16:21:21.325942947Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 3 16:21:21.325991 containerd[1612]: time="2025-11-03T16:21:21.325966264Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 3 16:21:21.325991 containerd[1612]: time="2025-11-03T16:21:21.325976738Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 3 16:21:21.325991 containerd[1612]: time="2025-11-03T16:21:21.325985805Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 3 16:21:21.326062 containerd[1612]: time="2025-11-03T16:21:21.325996077Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 3 16:21:21.326062 containerd[1612]: time="2025-11-03T16:21:21.326007451Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 3 16:21:21.326062 containerd[1612]: time="2025-11-03T16:21:21.326031314Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 3 16:21:21.326062 containerd[1612]: time="2025-11-03T16:21:21.326042254Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 3 16:21:21.326062 containerd[1612]: time="2025-11-03T16:21:21.326053062Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326096881Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326109450Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326117677Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326126300Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326137037Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326146579Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 3 16:21:21.326176 containerd[1612]: time="2025-11-03T16:21:21.326157903Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 3 16:21:21.326310 containerd[1612]: time="2025-11-03T16:21:21.326183547Z" level=info msg="runtime interface created" Nov 3 16:21:21.326310 containerd[1612]: time="2025-11-03T16:21:21.326190581Z" level=info msg="created NRI interface" Nov 3 16:21:21.326310 containerd[1612]: time="2025-11-03T16:21:21.326211367Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 3 16:21:21.326310 containerd[1612]: time="2025-11-03T16:21:21.326223460Z" level=info msg="Connect containerd service" Nov 3 16:21:21.326310 containerd[1612]: time="2025-11-03T16:21:21.326245562Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 3 16:21:21.327368 containerd[1612]: time="2025-11-03T16:21:21.327336979Z" 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" Nov 3 16:21:21.331482 sshd_keygen[1608]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 3 16:21:21.359499 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 3 16:21:21.363253 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 3 16:21:21.386973 systemd[1]: issuegen.service: Deactivated successfully. Nov 3 16:21:21.387323 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 3 16:21:21.391127 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 3 16:21:21.416222 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 3 16:21:21.420759 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 3 16:21:21.423625 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 3 16:21:21.425934 systemd[1]: Reached target getty.target - Login Prompts. Nov 3 16:21:21.620310 containerd[1612]: time="2025-11-03T16:21:21.620118312Z" level=info msg="Start subscribing containerd event" Nov 3 16:21:21.620534 containerd[1612]: time="2025-11-03T16:21:21.620312492Z" level=info msg="Start recovering state" Nov 3 16:21:21.620534 containerd[1612]: time="2025-11-03T16:21:21.620460890Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 3 16:21:21.620578 containerd[1612]: time="2025-11-03T16:21:21.620542335Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 3 16:21:21.620708 containerd[1612]: time="2025-11-03T16:21:21.620671160Z" level=info msg="Start event monitor" Nov 3 16:21:21.620708 containerd[1612]: time="2025-11-03T16:21:21.620721163Z" level=info msg="Start cni network conf syncer for default" Nov 3 16:21:21.620708 containerd[1612]: time="2025-11-03T16:21:21.620734025Z" level=info msg="Start streaming server" Nov 3 16:21:21.620891 containerd[1612]: time="2025-11-03T16:21:21.620766186Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 3 16:21:21.620891 containerd[1612]: time="2025-11-03T16:21:21.620782388Z" level=info msg="runtime interface starting up..." Nov 3 16:21:21.620891 containerd[1612]: time="2025-11-03T16:21:21.620791091Z" level=info msg="starting plugins..." Nov 3 16:21:21.620891 containerd[1612]: time="2025-11-03T16:21:21.620826106Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 3 16:21:21.621196 containerd[1612]: time="2025-11-03T16:21:21.621170343Z" level=info msg="containerd successfully booted in 0.320151s" Nov 3 16:21:21.621388 systemd[1]: Started containerd.service - containerd container runtime. Nov 3 16:21:21.896145 systemd-networkd[1520]: eth0: Gained IPv6LL Nov 3 16:21:21.899945 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 3 16:21:21.902638 systemd[1]: Reached target network-online.target - Network is Online. Nov 3 16:21:21.906017 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 3 16:21:21.909191 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 3 16:21:21.912123 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 3 16:21:21.940651 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 3 16:21:21.941126 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 3 16:21:21.944509 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 3 16:21:21.946783 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 3 16:21:23.507304 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 3 16:21:23.509795 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 3 16:21:23.511841 systemd[1]: Startup finished in 3.730s (kernel) + 6.399s (initrd) + 5.778s (userspace) = 15.907s. Nov 3 16:21:23.559466 (kubelet)[1710]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 3 16:21:23.771647 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 3 16:21:23.773532 systemd[1]: Started sshd@0-10.0.0.59:22-10.0.0.1:34102.service - OpenSSH per-connection server daemon (10.0.0.1:34102). Nov 3 16:21:23.883568 sshd[1719]: Accepted publickey for core from 10.0.0.1 port 34102 ssh2: RSA SHA256:6IgjKsfLloMODYUZWLJOfDFsK2vE75XcxHBEtXf0d48 Nov 3 16:21:23.887173 sshd-session[1719]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 3 16:21:23.932355 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 3 16:21:23.934072 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 3 16:21:23.945287 systemd-logind[1593]: New session 1 of user core. Nov 3 16:21:23.986008 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 3 16:21:23.988817 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 3 16:21:24.019946 (systemd)[1726]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 3 16:21:24.023643 systemd-logind[1593]: New session c1 of user core. Nov 3 16:21:24.206042 systemd[1726]: Queued start job for default target default.target. Nov 3 16:21:24.218460 systemd[1726]: Created slice app.slice - User Application Slice. Nov 3 16:21:24.218500 systemd[1726]: Reached target paths.target - Paths. Nov 3 16:21:24.218548 systemd[1726]: Reached target timers.target - Timers. Nov 3 16:21:24.220261 systemd[1726]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 3 16:21:24.235464 systemd[1726]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 3 16:21:24.235614 systemd[1726]: Reached target sockets.target - Sockets. Nov 3 16:21:24.235658 systemd[1726]: Reached target basic.target - Basic System. Nov 3 16:21:24.235706 systemd[1726]: Reached target default.target - Main User Target. Nov 3 16:21:24.235738 systemd[1726]: Startup finished in 199ms. Nov 3 16:21:24.236207 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 3 16:21:24.238559 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 3 16:21:24.255554 systemd[1]: Started sshd@1-10.0.0.59:22-10.0.0.1:34108.service - OpenSSH per-connection server daemon (10.0.0.1:34108). Nov 3 16:21:24.316803 sshd[1738]: Accepted publickey for core from 10.0.0.1 port 34108 ssh2: RSA SHA256:6IgjKsfLloMODYUZWLJOfDFsK2vE75XcxHBEtXf0d48 Nov 3 16:21:24.318769 sshd-session[1738]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 3 16:21:24.325024 systemd-logind[1593]: New session 2 of user core. Nov 3 16:21:24.332223 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 3 16:21:24.456369 sshd[1741]: Connection closed by 10.0.0.1 port 34108 Nov 3 16:21:24.456868 sshd-session[1738]: pam_unix(sshd:session): session closed for user core Nov 3 16:21:24.457846 kubelet[1710]: E1103 16:21:24.457509 1710 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" Nov 3 16:21:24.467891 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 3 16:21:24.468110 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 3 16:21:24.468484 systemd[1]: kubelet.service: Consumed 2.279s CPU time, 265.9M memory peak. Nov 3 16:21:24.468927 systemd[1]: sshd@1-10.0.0.59:22-10.0.0.1:34108.service: Deactivated successfully. Nov 3 16:21:24.470954 systemd[1]: session-2.scope: Deactivated successfully. Nov 3 16:21:24.471739 systemd-logind[1593]: Session 2 logged out. Waiting for processes to exit. Nov 3 16:21:24.475607 systemd[1]: Started sshd@2-10.0.0.59:22-10.0.0.1:34124.service - OpenSSH per-connection server daemon (10.0.0.1:34124). Nov 3 16:21:24.476488 systemd-logind[1593]: Removed session 2. Nov 3 16:21:24.533260 sshd[1748]: Accepted publickey for core from 10.0.0.1 port 34124 ssh2: RSA SHA256:6IgjKsfLloMODYUZWLJOfDFsK2vE75XcxHBEtXf0d48 Nov 3 16:21:24.536098 sshd-session[1748]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 3 16:21:24.545979 systemd-logind[1593]: New session 3 of user core. Nov 3 16:21:24.559349 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 3 16:21:24.570657 sshd[1752]: Connection closed by 10.0.0.1 port 34124 Nov 3 16:21:24.571134 sshd-session[1748]: pam_unix(sshd:session): session closed for user core Nov 3 16:21:24.587928 systemd[1]: sshd@2-10.0.0.59:22-10.0.0.1:34124.service: Deactivated successfully. Nov 3 16:21:24.589909 systemd[1]: session-3.scope: Deactivated successfully. Nov 3 16:21:24.590701 systemd-logind[1593]: Session 3 logged out. Waiting for processes to exit. Nov 3 16:21:24.593692 systemd[1]: Started sshd@3-10.0.0.59:22-10.0.0.1:34140.service - OpenSSH per-connection server daemon (10.0.0.1:34140). Nov 3 16:21:24.594648 systemd-logind[1593]: Removed session 3. Nov 3 16:21:24.654702 sshd[1758]: Accepted publickey for core from 10.0.0.1 port 34140 ssh2: RSA SHA256:6IgjKsfLloMODYUZWLJOfDFsK2vE75XcxHBEtXf0d48 Nov 3 16:21:24.656621 sshd-session[1758]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 3 16:21:24.662146 systemd-logind[1593]: New session 4 of user core. Nov 3 16:21:24.676299 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 3 16:21:24.692539 sshd[1761]: Connection closed by 10.0.0.1 port 34140 Nov 3 16:21:24.692881 sshd-session[1758]: pam_unix(sshd:session): session closed for user core Nov 3 16:21:24.703947 systemd[1]: sshd@3-10.0.0.59:22-10.0.0.1:34140.service: Deactivated successfully. Nov 3 16:21:24.706309 systemd[1]: session-4.scope: Deactivated successfully. Nov 3 16:21:24.707169 systemd-logind[1593]: Session 4 logged out. Waiting for processes to exit. Nov 3 16:21:24.710907 systemd[1]: Started sshd@4-10.0.0.59:22-10.0.0.1:34144.service - OpenSSH per-connection server daemon (10.0.0.1:34144). Nov 3 16:21:24.711765 systemd-logind[1593]: Removed session 4. Nov 3 16:21:24.770710 sshd[1767]: Accepted publickey for core from 10.0.0.1 port 34144 ssh2: RSA SHA256:6IgjKsfLloMODYUZWLJOfDFsK2vE75XcxHBEtXf0d48 Nov 3 16:21:24.772135 sshd-session[1767]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 3 16:21:24.777285 systemd-logind[1593]: New session 5 of user core. Nov 3 16:21:24.787276 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 3 16:21:24.811421 sudo[1771]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 3 16:21:24.811845 sudo[1771]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 3 16:21:24.828208 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 3 16:21:24.912571 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 3 16:21:24.912874 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 3 16:21:25.571658 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 3 16:21:25.571835 systemd[1]: kubelet.service: Consumed 2.279s CPU time, 265.9M memory peak. Nov 3 16:21:25.574281 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 3 16:21:25.600468 systemd[1]: Reload requested from client PID 1813 ('systemctl') (unit session-5.scope)... Nov 3 16:21:25.600484 systemd[1]: Reloading... Nov 3 16:21:25.689103 zram_generator::config[1855]: No configuration found. Nov 3 16:21:25.977046 systemd[1]: Reloading finished in 376 ms. Nov 3 16:21:26.040955 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Nov 3 16:21:26.041059 systemd[1]: kubelet.service: Failed with result 'signal'. Nov 3 16:21:26.041466 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 3 16:21:26.041526 systemd[1]: kubelet.service: Consumed 238ms CPU time, 98.4M memory peak. Nov 3 16:21:26.043391 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 3 16:21:26.252289 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 3 16:21:26.270506 (kubelet)[1903]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Nov 3 16:21:26.328730 kubelet[1903]: 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. Nov 3 16:21:26.328730 kubelet[1903]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 3 16:21:26.328730 kubelet[1903]: 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. Nov 3 16:21:26.329161 kubelet[1903]: I1103 16:21:26.328866 1903 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Nov 3 16:21:27.206839 kubelet[1903]: I1103 16:21:27.206779 1903 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Nov 3 16:21:27.206839 kubelet[1903]: I1103 16:21:27.206813 1903 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 3 16:21:27.207156 kubelet[1903]: I1103 16:21:27.207130 1903 server.go:954] "Client rotation is on, will bootstrap in background" Nov 3 16:21:27.237047 kubelet[1903]: I1103 16:21:27.236993 1903 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 3 16:21:27.250089 kubelet[1903]: I1103 16:21:27.250025 1903 server.go:1444] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Nov 3 16:21:27.256089 kubelet[1903]: I1103 16:21:27.256030 1903 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Nov 3 16:21:27.257334 kubelet[1903]: I1103 16:21:27.257273 1903 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 3 16:21:27.257638 kubelet[1903]: I1103 16:21:27.257320 1903 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.59","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Nov 3 16:21:27.257921 kubelet[1903]: I1103 16:21:27.257645 1903 topology_manager.go:138] "Creating topology manager with none policy" Nov 3 16:21:27.257921 kubelet[1903]: I1103 16:21:27.257654 1903 container_manager_linux.go:304] "Creating device plugin manager" Nov 3 16:21:27.257921 kubelet[1903]: I1103 16:21:27.257886 1903 state_mem.go:36] "Initialized new in-memory state store" Nov 3 16:21:27.260278 kubelet[1903]: I1103 16:21:27.260248 1903 kubelet.go:446] "Attempting to sync node with API server" Nov 3 16:21:27.260315 kubelet[1903]: I1103 16:21:27.260298 1903 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 3 16:21:27.260336 kubelet[1903]: I1103 16:21:27.260330 1903 kubelet.go:352] "Adding apiserver pod source" Nov 3 16:21:27.260361 kubelet[1903]: I1103 16:21:27.260348 1903 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 3 16:21:27.260533 kubelet[1903]: E1103 16:21:27.260467 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:27.260595 kubelet[1903]: E1103 16:21:27.260563 1903 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:27.263408 kubelet[1903]: I1103 16:21:27.263389 1903 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v2.1.4" apiVersion="v1" Nov 3 16:21:27.263825 kubelet[1903]: I1103 16:21:27.263807 1903 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Nov 3 16:21:27.264402 kubelet[1903]: W1103 16:21:27.264362 1903 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 3 16:21:27.266357 kubelet[1903]: I1103 16:21:27.266325 1903 watchdog_linux.go:99] "Systemd watchdog is not enabled" Nov 3 16:21:27.266425 kubelet[1903]: I1103 16:21:27.266371 1903 server.go:1287] "Started kubelet" Nov 3 16:21:27.266475 kubelet[1903]: I1103 16:21:27.266441 1903 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Nov 3 16:21:27.267719 kubelet[1903]: I1103 16:21:27.267674 1903 server.go:479] "Adding debug handlers to kubelet server" Nov 3 16:21:27.268568 kubelet[1903]: I1103 16:21:27.268526 1903 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 3 16:21:27.270107 kubelet[1903]: I1103 16:21:27.270000 1903 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 3 16:21:27.270763 kubelet[1903]: I1103 16:21:27.270329 1903 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 3 16:21:27.271575 kubelet[1903]: W1103 16:21:27.271539 1903 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Nov 3 16:21:27.271645 kubelet[1903]: E1103 16:21:27.271611 1903 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Nov 3 16:21:27.271802 kubelet[1903]: I1103 16:21:27.271773 1903 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 3 16:21:27.272997 kubelet[1903]: E1103 16:21:27.271596 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3335c9bdf default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.266343903 +0000 UTC m=+0.987748534,LastTimestamp:2025-11-03 16:21:27.266343903 +0000 UTC m=+0.987748534,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.273651 kubelet[1903]: W1103 16:21:27.273594 1903 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.59" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Nov 3 16:21:27.273701 kubelet[1903]: E1103 16:21:27.273672 1903 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Nov 3 16:21:27.273752 kubelet[1903]: E1103 16:21:27.273716 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:27.273752 kubelet[1903]: I1103 16:21:27.273744 1903 volume_manager.go:297] "Starting Kubelet Volume Manager" Nov 3 16:21:27.273991 kubelet[1903]: I1103 16:21:27.273956 1903 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Nov 3 16:21:27.274041 kubelet[1903]: I1103 16:21:27.274001 1903 reconciler.go:26] "Reconciler: start to sync state" Nov 3 16:21:27.275747 kubelet[1903]: I1103 16:21:27.275706 1903 factory.go:221] Registration of the systemd container factory successfully Nov 3 16:21:27.275834 kubelet[1903]: I1103 16:21:27.275796 1903 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 Nov 3 16:21:27.278653 kubelet[1903]: E1103 16:21:27.278626 1903 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 3 16:21:27.279804 kubelet[1903]: E1103 16:21:27.279747 1903 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Nov 3 16:21:27.279971 kubelet[1903]: E1103 16:21:27.279759 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba33417dfee default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.278616558 +0000 UTC m=+1.000021199,LastTimestamp:2025-11-03 16:21:27.278616558 +0000 UTC m=+1.000021199,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.279971 kubelet[1903]: W1103 16:21:27.279838 1903 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Nov 3 16:21:27.279971 kubelet[1903]: E1103 16:21:27.279867 1903 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Nov 3 16:21:27.284010 kubelet[1903]: I1103 16:21:27.283951 1903 factory.go:221] Registration of the containerd container factory successfully Nov 3 16:21:27.297095 kubelet[1903]: I1103 16:21:27.297032 1903 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 3 16:21:27.297095 kubelet[1903]: I1103 16:21:27.297087 1903 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 3 16:21:27.297095 kubelet[1903]: I1103 16:21:27.297112 1903 state_mem.go:36] "Initialized new in-memory state store" Nov 3 16:21:27.301113 kubelet[1903]: E1103 16:21:27.300993 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351e6c7d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.59 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295822973 +0000 UTC m=+1.017227614,LastTimestamp:2025-11-03 16:21:27.295822973 +0000 UTC m=+1.017227614,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.305140 kubelet[1903]: E1103 16:21:27.304952 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351eae9d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasNoDiskPressure,Message:Node 10.0.0.59 status is now: NodeHasNoDiskPressure,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295839901 +0000 UTC m=+1.017244542,LastTimestamp:2025-11-03 16:21:27.295839901 +0000 UTC m=+1.017244542,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.309390 kubelet[1903]: E1103 16:21:27.309320 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351ebcce default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.59 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295843534 +0000 UTC m=+1.017248185,LastTimestamp:2025-11-03 16:21:27.295843534 +0000 UTC m=+1.017248185,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.374591 kubelet[1903]: E1103 16:21:27.374509 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:27.404938 kubelet[1903]: I1103 16:21:27.404859 1903 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Nov 3 16:21:27.406594 kubelet[1903]: I1103 16:21:27.406542 1903 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Nov 3 16:21:27.406923 kubelet[1903]: I1103 16:21:27.406610 1903 status_manager.go:227] "Starting to sync pod status with apiserver" Nov 3 16:21:27.406923 kubelet[1903]: I1103 16:21:27.406647 1903 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 3 16:21:27.406923 kubelet[1903]: I1103 16:21:27.406662 1903 kubelet.go:2382] "Starting kubelet main sync loop" Nov 3 16:21:27.406923 kubelet[1903]: E1103 16:21:27.406738 1903 kubelet.go:2406] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Nov 3 16:21:27.413410 kubelet[1903]: W1103 16:21:27.413321 1903 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.RuntimeClass: runtimeclasses.node.k8s.io is forbidden: User "system:anonymous" cannot list resource "runtimeclasses" in API group "node.k8s.io" at the cluster scope Nov 3 16:21:27.413410 kubelet[1903]: E1103 16:21:27.413363 1903 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.RuntimeClass: failed to list *v1.RuntimeClass: runtimeclasses.node.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"runtimeclasses\" in API group \"node.k8s.io\" at the cluster scope" logger="UnhandledError" Nov 3 16:21:27.435055 kubelet[1903]: I1103 16:21:27.435019 1903 policy_none.go:49] "None policy: Start" Nov 3 16:21:27.435136 kubelet[1903]: I1103 16:21:27.435060 1903 memory_manager.go:186] "Starting memorymanager" policy="None" Nov 3 16:21:27.435136 kubelet[1903]: I1103 16:21:27.435112 1903 state_mem.go:35] "Initializing new in-memory state store" Nov 3 16:21:27.475602 kubelet[1903]: E1103 16:21:27.475434 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:27.485396 kubelet[1903]: E1103 16:21:27.485290 1903 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="400ms" Nov 3 16:21:27.507605 kubelet[1903]: E1103 16:21:27.507561 1903 kubelet.go:2406] "Skipping pod synchronization" err="container runtime status check may not have completed yet" Nov 3 16:21:27.576014 kubelet[1903]: E1103 16:21:27.575952 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:27.593492 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Nov 3 16:21:27.613015 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Nov 3 16:21:27.616275 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Nov 3 16:21:27.633235 kubelet[1903]: I1103 16:21:27.633202 1903 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Nov 3 16:21:27.633482 kubelet[1903]: I1103 16:21:27.633463 1903 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 3 16:21:27.633547 kubelet[1903]: I1103 16:21:27.633480 1903 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 3 16:21:27.633808 kubelet[1903]: I1103 16:21:27.633770 1903 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 3 16:21:27.636737 kubelet[1903]: E1103 16:21:27.636715 1903 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 3 16:21:27.636813 kubelet[1903]: E1103 16:21:27.636760 1903 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.59\" not found" Nov 3 16:21:27.640370 kubelet[1903]: E1103 16:21:27.640276 1903 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba34955490b default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeAllocatableEnforced,Message:Updated Node Allocatable limit across pods,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.634962699 +0000 UTC m=+1.356367340,LastTimestamp:2025-11-03 16:21:27.634962699 +0000 UTC m=+1.356367340,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.734696 kubelet[1903]: I1103 16:21:27.734561 1903 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.59" Nov 3 16:21:27.739716 kubelet[1903]: E1103 16:21:27.739594 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351e6c7d\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351e6c7d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.59 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295822973 +0000 UTC m=+1.017227614,LastTimestamp:2025-11-03 16:21:27.734509259 +0000 UTC m=+1.455913901,Count:2,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.745706 kubelet[1903]: E1103 16:21:27.745664 1903 kubelet_node_status.go:113] "Unable to register node with API server, error getting existing node" err="nodes \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot get resource \"nodes\" in API group \"\" at the cluster scope" node="10.0.0.59" Nov 3 16:21:27.745874 kubelet[1903]: E1103 16:21:27.745744 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351eae9d\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351eae9d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasNoDiskPressure,Message:Node 10.0.0.59 status is now: NodeHasNoDiskPressure,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295839901 +0000 UTC m=+1.017244542,LastTimestamp:2025-11-03 16:21:27.734517371 +0000 UTC m=+1.455922012,Count:2,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.750914 kubelet[1903]: E1103 16:21:27.750782 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351ebcce\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351ebcce default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.59 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295843534 +0000 UTC m=+1.017248185,LastTimestamp:2025-11-03 16:21:27.734526128 +0000 UTC m=+1.455930769,Count:2,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.890610 kubelet[1903]: E1103 16:21:27.890554 1903 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="800ms" Nov 3 16:21:27.947190 kubelet[1903]: I1103 16:21:27.947133 1903 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.59" Nov 3 16:21:27.953085 kubelet[1903]: E1103 16:21:27.952881 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351e6c7d\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351e6c7d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.59 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295822973 +0000 UTC m=+1.017227614,LastTimestamp:2025-11-03 16:21:27.947061825 +0000 UTC m=+1.668466466,Count:3,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.957507 kubelet[1903]: E1103 16:21:27.957419 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351eae9d\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351eae9d default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasNoDiskPressure,Message:Node 10.0.0.59 status is now: NodeHasNoDiskPressure,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295839901 +0000 UTC m=+1.017244542,LastTimestamp:2025-11-03 16:21:27.947087066 +0000 UTC m=+1.668491707,Count:3,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:27.957889 kubelet[1903]: E1103 16:21:27.957857 1903 kubelet_node_status.go:113] "Unable to register node with API server, error getting existing node" err="nodes \"10.0.0.59\" is forbidden: User \"system:anonymous\" cannot get resource \"nodes\" in API group \"\" at the cluster scope" node="10.0.0.59" Nov 3 16:21:27.961037 kubelet[1903]: E1103 16:21:27.960936 1903 event.go:359] "Server rejected event (will not retry!)" err="events \"10.0.0.59.18748ba3351ebcce\" is forbidden: User \"system:anonymous\" cannot patch resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.59.18748ba3351ebcce default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.59,UID:10.0.0.59,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.59 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.59,},FirstTimestamp:2025-11-03 16:21:27.295843534 +0000 UTC m=+1.017248185,LastTimestamp:2025-11-03 16:21:27.947089733 +0000 UTC m=+1.668494374,Count:3,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.59,}" Nov 3 16:21:28.209654 kubelet[1903]: I1103 16:21:28.209572 1903 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 3 16:21:28.209901 kubelet[1903]: W1103 16:21:28.209869 1903 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.Node 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 Nov 3 16:21:28.261220 kubelet[1903]: I1103 16:21:28.261152 1903 apiserver.go:52] "Watching apiserver" Nov 3 16:21:28.261220 kubelet[1903]: E1103 16:21:28.261195 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:28.274921 kubelet[1903]: I1103 16:21:28.274886 1903 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Nov 3 16:21:28.358888 kubelet[1903]: I1103 16:21:28.358831 1903 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.59" Nov 3 16:21:28.442035 kubelet[1903]: I1103 16:21:28.441962 1903 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.59" Nov 3 16:21:28.442035 kubelet[1903]: E1103 16:21:28.442012 1903 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.59\": node \"10.0.0.59\" not found" Nov 3 16:21:28.769849 kubelet[1903]: E1103 16:21:28.769798 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:28.782424 systemd[1]: Created slice kubepods-burstable-pod0ea561b5_2c19_46d3_bdbb_97a89658a9bd.slice - libcontainer container kubepods-burstable-pod0ea561b5_2c19_46d3_bdbb_97a89658a9bd.slice. Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782417 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/f2fb6307-bb94-4e30-b657-65aa11cbb3bc-kube-proxy\") pod \"kube-proxy-k2wm6\" (UID: \"f2fb6307-bb94-4e30-b657-65aa11cbb3bc\") " pod="kube-system/kube-proxy-k2wm6" Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782457 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/f2fb6307-bb94-4e30-b657-65aa11cbb3bc-lib-modules\") pod \"kube-proxy-k2wm6\" (UID: \"f2fb6307-bb94-4e30-b657-65aa11cbb3bc\") " pod="kube-system/kube-proxy-k2wm6" Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782493 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-run\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782517 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-cni\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782550 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-flannel-cfg\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.782817 kubelet[1903]: I1103 16:21:28.782575 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/f2fb6307-bb94-4e30-b657-65aa11cbb3bc-xtables-lock\") pod \"kube-proxy-k2wm6\" (UID: \"f2fb6307-bb94-4e30-b657-65aa11cbb3bc\") " pod="kube-system/kube-proxy-k2wm6" Nov 3 16:21:28.783016 kubelet[1903]: I1103 16:21:28.782603 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qcz4x\" (UniqueName: \"kubernetes.io/projected/f2fb6307-bb94-4e30-b657-65aa11cbb3bc-kube-api-access-qcz4x\") pod \"kube-proxy-k2wm6\" (UID: \"f2fb6307-bb94-4e30-b657-65aa11cbb3bc\") " pod="kube-system/kube-proxy-k2wm6" Nov 3 16:21:28.783016 kubelet[1903]: I1103 16:21:28.782643 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-cni-plugin\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.783016 kubelet[1903]: I1103 16:21:28.782671 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-xtables-lock\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.783016 kubelet[1903]: I1103 16:21:28.782697 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zf86s\" (UniqueName: \"kubernetes.io/projected/0ea561b5-2c19-46d3-bdbb-97a89658a9bd-kube-api-access-zf86s\") pod \"kube-flannel-ds-qb82k\" (UID: \"0ea561b5-2c19-46d3-bdbb-97a89658a9bd\") " pod="kube-flannel/kube-flannel-ds-qb82k" Nov 3 16:21:28.797262 sudo[1771]: pam_unix(sudo:session): session closed for user root Nov 3 16:21:28.799200 sshd[1770]: Connection closed by 10.0.0.1 port 34144 Nov 3 16:21:28.799916 sshd-session[1767]: pam_unix(sshd:session): session closed for user core Nov 3 16:21:28.804750 systemd[1]: Created slice kubepods-besteffort-podf2fb6307_bb94_4e30_b657_65aa11cbb3bc.slice - libcontainer container kubepods-besteffort-podf2fb6307_bb94_4e30_b657_65aa11cbb3bc.slice. Nov 3 16:21:28.805225 systemd[1]: sshd@4-10.0.0.59:22-10.0.0.1:34144.service: Deactivated successfully. Nov 3 16:21:28.807806 systemd[1]: session-5.scope: Deactivated successfully. Nov 3 16:21:28.808051 systemd[1]: session-5.scope: Consumed 706ms CPU time, 75.2M memory peak. Nov 3 16:21:28.809323 systemd-logind[1593]: Session 5 logged out. Waiting for processes to exit. Nov 3 16:21:28.825794 systemd-logind[1593]: Removed session 5. Nov 3 16:21:28.870719 kubelet[1903]: E1103 16:21:28.870581 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:28.971120 kubelet[1903]: E1103 16:21:28.970960 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.072119 kubelet[1903]: E1103 16:21:29.071990 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.101287 kubelet[1903]: E1103 16:21:29.101157 1903 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" Nov 3 16:21:29.102244 containerd[1612]: time="2025-11-03T16:21:29.102148633Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-qb82k,Uid:0ea561b5-2c19-46d3-bdbb-97a89658a9bd,Namespace:kube-flannel,Attempt:0,}" Nov 3 16:21:29.126238 kubelet[1903]: E1103 16:21:29.126195 1903 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" Nov 3 16:21:29.126705 containerd[1612]: time="2025-11-03T16:21:29.126655810Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-k2wm6,Uid:f2fb6307-bb94-4e30-b657-65aa11cbb3bc,Namespace:kube-system,Attempt:0,}" Nov 3 16:21:29.172523 kubelet[1903]: E1103 16:21:29.172449 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.261682 kubelet[1903]: E1103 16:21:29.261612 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:29.273211 kubelet[1903]: E1103 16:21:29.273154 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.374306 kubelet[1903]: E1103 16:21:29.374136 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.474864 kubelet[1903]: E1103 16:21:29.474800 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.575956 kubelet[1903]: E1103 16:21:29.575829 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.677104 kubelet[1903]: E1103 16:21:29.676961 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.777362 kubelet[1903]: E1103 16:21:29.777301 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.800672 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3774280241.mount: Deactivated successfully. Nov 3 16:21:29.811857 containerd[1612]: time="2025-11-03T16:21:29.811790575Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 3 16:21:29.813860 containerd[1612]: time="2025-11-03T16:21:29.813801028Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 3 16:21:29.815043 containerd[1612]: time="2025-11-03T16:21:29.815004997Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 3 16:21:29.816153 containerd[1612]: time="2025-11-03T16:21:29.816045968Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 3 16:21:29.817170 containerd[1612]: time="2025-11-03T16:21:29.817125415Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 3 16:21:29.819379 containerd[1612]: time="2025-11-03T16:21:29.819332965Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 3 16:21:29.820178 containerd[1612]: time="2025-11-03T16:21:29.820128350Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 709.062448ms" Nov 3 16:21:29.821872 containerd[1612]: time="2025-11-03T16:21:29.821805045Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 690.919188ms" Nov 3 16:21:29.849258 containerd[1612]: time="2025-11-03T16:21:29.849203302Z" level=info msg="connecting to shim dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca" address="unix:///run/containerd/s/57359582ca29dedb0ea3879b7822629a169ea06d2a926774d790c7eef9891b03" namespace=k8s.io protocol=ttrpc version=3 Nov 3 16:21:29.850918 containerd[1612]: time="2025-11-03T16:21:29.850872085Z" level=info msg="connecting to shim b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577" address="unix:///run/containerd/s/7d46dced655482546a25e46f60d050ae61beb3ab11692fed6696b843d159c75d" namespace=k8s.io protocol=ttrpc version=3 Nov 3 16:21:29.878506 kubelet[1903]: E1103 16:21:29.877623 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:29.886263 systemd[1]: Started cri-containerd-dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca.scope - libcontainer container dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca. Nov 3 16:21:29.891318 systemd[1]: Started cri-containerd-b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577.scope - libcontainer container b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577. Nov 3 16:21:29.922317 containerd[1612]: time="2025-11-03T16:21:29.922243711Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-k2wm6,Uid:f2fb6307-bb94-4e30-b657-65aa11cbb3bc,Namespace:kube-system,Attempt:0,} returns sandbox id \"dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca\"" Nov 3 16:21:29.923710 kubelet[1903]: E1103 16:21:29.923680 1903 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" Nov 3 16:21:29.924980 containerd[1612]: time="2025-11-03T16:21:29.924946890Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\"" Nov 3 16:21:29.954273 containerd[1612]: time="2025-11-03T16:21:29.954108263Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-qb82k,Uid:0ea561b5-2c19-46d3-bdbb-97a89658a9bd,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\"" Nov 3 16:21:29.955446 kubelet[1903]: E1103 16:21:29.955414 1903 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" Nov 3 16:21:29.978093 kubelet[1903]: E1103 16:21:29.978020 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.079192 kubelet[1903]: E1103 16:21:30.079057 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.179968 kubelet[1903]: E1103 16:21:30.179904 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.262895 kubelet[1903]: E1103 16:21:30.262796 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:30.280377 kubelet[1903]: E1103 16:21:30.280338 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.381309 kubelet[1903]: E1103 16:21:30.381236 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.481678 kubelet[1903]: E1103 16:21:30.481605 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.582779 kubelet[1903]: E1103 16:21:30.582627 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.683629 kubelet[1903]: E1103 16:21:30.683566 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.783974 kubelet[1903]: E1103 16:21:30.783898 1903 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.59\" not found" Nov 3 16:21:30.885710 kubelet[1903]: I1103 16:21:30.885597 1903 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 3 16:21:30.886187 containerd[1612]: time="2025-11-03T16:21:30.886145394Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 3 16:21:30.886593 kubelet[1903]: I1103 16:21:30.886458 1903 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 3 16:21:30.935199 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1367036621.mount: Deactivated successfully. Nov 3 16:21:31.263472 kubelet[1903]: E1103 16:21:31.263066 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:31.523317 containerd[1612]: time="2025-11-03T16:21:31.523242611Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:31.524622 containerd[1612]: time="2025-11-03T16:21:31.524585026Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.9: active requests=0, bytes read=0" Nov 3 16:21:31.526164 containerd[1612]: time="2025-11-03T16:21:31.526099799Z" level=info msg="ImageCreate event name:\"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:31.529790 containerd[1612]: time="2025-11-03T16:21:31.528499669Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:31.531562 containerd[1612]: time="2025-11-03T16:21:31.531487746Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.32.9\" with image id \"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\", repo tag \"registry.k8s.io/kube-proxy:v1.32.9\", repo digest \"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\", size \"30923225\" in 1.60649672s" Nov 3 16:21:31.531562 containerd[1612]: time="2025-11-03T16:21:31.531533071Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\" returns image reference \"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\"" Nov 3 16:21:31.533298 containerd[1612]: time="2025-11-03T16:21:31.533188158Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Nov 3 16:21:31.535143 containerd[1612]: time="2025-11-03T16:21:31.535097844Z" level=info msg="CreateContainer within sandbox \"dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 3 16:21:31.579549 containerd[1612]: time="2025-11-03T16:21:31.579483372Z" level=info msg="Container b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:21:31.588764 containerd[1612]: time="2025-11-03T16:21:31.588705871Z" level=info msg="CreateContainer within sandbox \"dd3e6a087f6f83817922bab2655c4bcd318ca9addb86cc32f9a464249aa18cca\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13\"" Nov 3 16:21:31.589517 containerd[1612]: time="2025-11-03T16:21:31.589430414Z" level=info msg="StartContainer for \"b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13\"" Nov 3 16:21:31.591219 containerd[1612]: time="2025-11-03T16:21:31.591194362Z" level=info msg="connecting to shim b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13" address="unix:///run/containerd/s/57359582ca29dedb0ea3879b7822629a169ea06d2a926774d790c7eef9891b03" protocol=ttrpc version=3 Nov 3 16:21:31.622255 systemd[1]: Started cri-containerd-b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13.scope - libcontainer container b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13. Nov 3 16:21:31.679329 containerd[1612]: time="2025-11-03T16:21:31.678499143Z" level=info msg="StartContainer for \"b0887fded70456097e366254c57beaf468d5a561c7056493b3dbe9258177bf13\" returns successfully" Nov 3 16:21:32.264274 kubelet[1903]: E1103 16:21:32.264204 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:32.423978 kubelet[1903]: E1103 16:21:32.423931 1903 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" Nov 3 16:21:32.444434 kubelet[1903]: I1103 16:21:32.444338 1903 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-k2wm6" podStartSLOduration=2.835930232 podStartE2EDuration="4.444312508s" podCreationTimestamp="2025-11-03 16:21:28 +0000 UTC" firstStartedPulling="2025-11-03 16:21:29.924523336 +0000 UTC m=+3.645927977" lastFinishedPulling="2025-11-03 16:21:31.532905612 +0000 UTC m=+5.254310253" observedRunningTime="2025-11-03 16:21:32.443586196 +0000 UTC m=+6.164990837" watchObservedRunningTime="2025-11-03 16:21:32.444312508 +0000 UTC m=+6.165717149" Nov 3 16:21:33.264826 kubelet[1903]: E1103 16:21:33.264776 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:33.425355 kubelet[1903]: E1103 16:21:33.425294 1903 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" Nov 3 16:21:33.870314 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1336383370.mount: Deactivated successfully. Nov 3 16:21:33.911923 containerd[1612]: time="2025-11-03T16:21:33.911858698Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:33.912714 containerd[1612]: time="2025-11-03T16:21:33.912676797Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=1010623" Nov 3 16:21:33.913819 containerd[1612]: time="2025-11-03T16:21:33.913788010Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:33.916088 containerd[1612]: time="2025-11-03T16:21:33.916049217Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:33.916907 containerd[1612]: time="2025-11-03T16:21:33.916872608Z" 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.383653123s" Nov 3 16:21:33.916907 containerd[1612]: time="2025-11-03T16:21:33.916900416Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Nov 3 16:21:33.919010 containerd[1612]: time="2025-11-03T16:21:33.918970135Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 3 16:21:33.928389 containerd[1612]: time="2025-11-03T16:21:33.928323325Z" level=info msg="Container edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:21:33.935259 containerd[1612]: time="2025-11-03T16:21:33.935213923Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0\"" Nov 3 16:21:33.935727 containerd[1612]: time="2025-11-03T16:21:33.935706735Z" level=info msg="StartContainer for \"edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0\"" Nov 3 16:21:33.936539 containerd[1612]: time="2025-11-03T16:21:33.936504716Z" level=info msg="connecting to shim edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0" address="unix:///run/containerd/s/7d46dced655482546a25e46f60d050ae61beb3ab11692fed6696b843d159c75d" protocol=ttrpc version=3 Nov 3 16:21:33.995225 systemd[1]: Started cri-containerd-edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0.scope - libcontainer container edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0. Nov 3 16:21:34.034044 systemd[1]: cri-containerd-edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0.scope: Deactivated successfully. Nov 3 16:21:34.036536 containerd[1612]: time="2025-11-03T16:21:34.036485685Z" level=info msg="StartContainer for \"edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0\" returns successfully" Nov 3 16:21:34.036671 containerd[1612]: time="2025-11-03T16:21:34.036494547Z" level=info msg="received exit event container_id:\"edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0\" id:\"edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0\" pid:2236 exited_at:{seconds:1762186894 nanos:35919510}" Nov 3 16:21:34.265325 kubelet[1903]: E1103 16:21:34.265104 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:34.428405 kubelet[1903]: E1103 16:21:34.428351 1903 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" Nov 3 16:21:34.794240 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-edc713599b5a7bc199736dc19167e4c786f14a37545f9b71b8a524dbdf658bf0-rootfs.mount: Deactivated successfully. Nov 3 16:21:35.265917 kubelet[1903]: E1103 16:21:35.265722 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:35.431772 kubelet[1903]: E1103 16:21:35.431714 1903 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" Nov 3 16:21:35.432570 containerd[1612]: time="2025-11-03T16:21:35.432526118Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Nov 3 16:21:36.266288 kubelet[1903]: E1103 16:21:36.266192 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:37.266823 kubelet[1903]: E1103 16:21:37.266762 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:38.267035 kubelet[1903]: E1103 16:21:38.266998 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:39.238531 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3552481358.mount: Deactivated successfully. Nov 3 16:21:39.267182 kubelet[1903]: E1103 16:21:39.267130 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:39.812408 containerd[1612]: time="2025-11-03T16:21:39.812339957Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:39.813235 containerd[1612]: time="2025-11-03T16:21:39.813178953Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26851496" Nov 3 16:21:39.816431 containerd[1612]: time="2025-11-03T16:21:39.816392872Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:39.875526 containerd[1612]: time="2025-11-03T16:21:39.875447327Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:39.876528 containerd[1612]: time="2025-11-03T16:21:39.876470626Z" 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 4.44389061s" Nov 3 16:21:39.876528 containerd[1612]: time="2025-11-03T16:21:39.876515491Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Nov 3 16:21:39.878974 containerd[1612]: time="2025-11-03T16:21:39.878926604Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 3 16:21:40.268535 kubelet[1903]: E1103 16:21:40.268395 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:40.511053 containerd[1612]: time="2025-11-03T16:21:40.510992025Z" level=info msg="Container aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:21:40.876021 containerd[1612]: time="2025-11-03T16:21:40.875975796Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9\"" Nov 3 16:21:40.876454 containerd[1612]: time="2025-11-03T16:21:40.876360443Z" level=info msg="StartContainer for \"aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9\"" Nov 3 16:21:40.877180 containerd[1612]: time="2025-11-03T16:21:40.877158455Z" level=info msg="connecting to shim aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9" address="unix:///run/containerd/s/7d46dced655482546a25e46f60d050ae61beb3ab11692fed6696b843d159c75d" protocol=ttrpc version=3 Nov 3 16:21:40.916276 systemd[1]: Started cri-containerd-aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9.scope - libcontainer container aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9. Nov 3 16:21:41.073361 systemd[1]: cri-containerd-aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9.scope: Deactivated successfully. Nov 3 16:21:41.147493 kubelet[1903]: I1103 16:21:41.147357 1903 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Nov 3 16:21:41.169234 containerd[1612]: time="2025-11-03T16:21:41.169172534Z" level=info msg="received exit event container_id:\"aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9\" id:\"aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9\" pid:2312 exited_at:{seconds:1762186901 nanos:73459633}" Nov 3 16:21:41.170779 containerd[1612]: time="2025-11-03T16:21:41.170314271Z" level=info msg="StartContainer for \"aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9\" returns successfully" Nov 3 16:21:41.194831 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-aa66142103bd2c11265fcbb8ba4ac9388b32c397d9c864a175265f17ec2083b9-rootfs.mount: Deactivated successfully. Nov 3 16:21:41.269573 kubelet[1903]: E1103 16:21:41.269456 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:41.442685 kubelet[1903]: E1103 16:21:41.442543 1903 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" Nov 3 16:21:42.269724 kubelet[1903]: E1103 16:21:42.269653 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:42.446239 kubelet[1903]: E1103 16:21:42.446202 1903 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" Nov 3 16:21:42.450092 containerd[1612]: time="2025-11-03T16:21:42.448182814Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 3 16:21:42.636376 containerd[1612]: time="2025-11-03T16:21:42.636292863Z" level=info msg="Container 0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:21:42.646623 containerd[1612]: time="2025-11-03T16:21:42.646560332Z" level=info msg="CreateContainer within sandbox \"b3d5e7d383463b3f79a3326b62d9edfde4bb9d1fcecf8e82cc517c585e077577\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe\"" Nov 3 16:21:42.647234 containerd[1612]: time="2025-11-03T16:21:42.647191721Z" level=info msg="StartContainer for \"0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe\"" Nov 3 16:21:42.648223 containerd[1612]: time="2025-11-03T16:21:42.648193499Z" level=info msg="connecting to shim 0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe" address="unix:///run/containerd/s/7d46dced655482546a25e46f60d050ae61beb3ab11692fed6696b843d159c75d" protocol=ttrpc version=3 Nov 3 16:21:42.676242 systemd[1]: Started cri-containerd-0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe.scope - libcontainer container 0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe. Nov 3 16:21:42.711924 containerd[1612]: time="2025-11-03T16:21:42.711881640Z" level=info msg="StartContainer for \"0f5054ca3b490716da4bc6b9d5953ea575a3e4bffd01050a83b233a7839d37fe\" returns successfully" Nov 3 16:21:43.270382 kubelet[1903]: E1103 16:21:43.270220 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:43.451171 kubelet[1903]: E1103 16:21:43.451099 1903 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" Nov 3 16:21:43.461314 kubelet[1903]: I1103 16:21:43.461235 1903 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-qb82k" podStartSLOduration=5.539572665 podStartE2EDuration="15.461202334s" podCreationTimestamp="2025-11-03 16:21:28 +0000 UTC" firstStartedPulling="2025-11-03 16:21:29.955917504 +0000 UTC m=+3.677322145" lastFinishedPulling="2025-11-03 16:21:39.877547173 +0000 UTC m=+13.598951814" observedRunningTime="2025-11-03 16:21:43.460986414 +0000 UTC m=+17.182391065" watchObservedRunningTime="2025-11-03 16:21:43.461202334 +0000 UTC m=+17.182606975" Nov 3 16:21:43.758279 systemd-networkd[1520]: flannel.1: Link UP Nov 3 16:21:43.758290 systemd-networkd[1520]: flannel.1: Gained carrier Nov 3 16:21:44.271315 kubelet[1903]: E1103 16:21:44.271254 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:44.453363 kubelet[1903]: E1103 16:21:44.453325 1903 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" Nov 3 16:21:44.904347 systemd[1]: Created slice kubepods-besteffort-pod62fa5688_1a0d_453a_b939_5e81773ea608.slice - libcontainer container kubepods-besteffort-pod62fa5688_1a0d_453a_b939_5e81773ea608.slice. Nov 3 16:21:44.989245 kubelet[1903]: I1103 16:21:44.989164 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-6f25t\" (UniqueName: \"kubernetes.io/projected/62fa5688-1a0d-453a-b939-5e81773ea608-kube-api-access-6f25t\") pod \"nginx-deployment-7fcdb87857-lg55d\" (UID: \"62fa5688-1a0d-453a-b939-5e81773ea608\") " pod="default/nginx-deployment-7fcdb87857-lg55d" Nov 3 16:21:45.208293 containerd[1612]: time="2025-11-03T16:21:45.208156817Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-lg55d,Uid:62fa5688-1a0d-453a-b939-5e81773ea608,Namespace:default,Attempt:0,}" Nov 3 16:21:45.228352 systemd-networkd[1520]: cni0: Link UP Nov 3 16:21:45.228363 systemd-networkd[1520]: cni0: Gained carrier Nov 3 16:21:45.228752 systemd-networkd[1520]: cni0: Lost carrier Nov 3 16:21:45.240505 kernel: cni0: port 1(vethc92e3def) entered blocking state Nov 3 16:21:45.240590 kernel: cni0: port 1(vethc92e3def) entered disabled state Nov 3 16:21:45.243770 kernel: vethc92e3def: entered allmulticast mode Nov 3 16:21:45.243870 kernel: vethc92e3def: entered promiscuous mode Nov 3 16:21:45.243997 systemd-networkd[1520]: vethc92e3def: Link UP Nov 3 16:21:45.271182 kernel: cni0: port 1(vethc92e3def) entered blocking state Nov 3 16:21:45.271283 kernel: cni0: port 1(vethc92e3def) entered forwarding state Nov 3 16:21:45.271470 kubelet[1903]: E1103 16:21:45.271408 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:45.271507 systemd-networkd[1520]: vethc92e3def: Gained carrier Nov 3 16:21:45.272382 systemd-networkd[1520]: cni0: Gained carrier Nov 3 16:21:45.277201 containerd[1612]: 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)(0xc0001288e8), "name":"cbr0", "type":"bridge"} Nov 3 16:21:45.277201 containerd[1612]: delegateAdd: netconf sent to delegate plugin: Nov 3 16:21:45.318592 containerd[1612]: {"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-11-03T16:21:45.318517659Z" level=info msg="connecting to shim e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4" address="unix:///run/containerd/s/29b55b72403849760c7e3256fb6fbb394598d2819b6f83e8f3309232ab2fe3b0" namespace=k8s.io protocol=ttrpc version=3 Nov 3 16:21:45.355210 systemd[1]: Started cri-containerd-e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4.scope - libcontainer container e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4. Nov 3 16:21:45.367593 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 3 16:21:45.383212 systemd-networkd[1520]: flannel.1: Gained IPv6LL Nov 3 16:21:45.479445 containerd[1612]: time="2025-11-03T16:21:45.479288828Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-lg55d,Uid:62fa5688-1a0d-453a-b939-5e81773ea608,Namespace:default,Attempt:0,} returns sandbox id \"e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4\"" Nov 3 16:21:45.480726 containerd[1612]: time="2025-11-03T16:21:45.480680676Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 3 16:21:46.272320 kubelet[1903]: E1103 16:21:46.272247 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:46.855234 systemd-networkd[1520]: vethc92e3def: Gained IPv6LL Nov 3 16:21:46.983284 systemd-networkd[1520]: cni0: Gained IPv6LL Nov 3 16:21:47.261417 kubelet[1903]: E1103 16:21:47.261176 1903 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:47.272692 kubelet[1903]: E1103 16:21:47.272625 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:48.273713 kubelet[1903]: E1103 16:21:48.273646 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:48.620901 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2666293160.mount: Deactivated successfully. Nov 3 16:21:49.274092 kubelet[1903]: E1103 16:21:49.274025 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:49.846192 containerd[1612]: time="2025-11-03T16:21:49.846107414Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:49.875091 containerd[1612]: time="2025-11-03T16:21:49.875001718Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73300687" Nov 3 16:21:49.921056 containerd[1612]: time="2025-11-03T16:21:49.920971487Z" level=info msg="ImageCreate event name:\"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:49.932128 containerd[1612]: time="2025-11-03T16:21:49.931974071Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:21:49.932804 containerd[1612]: time="2025-11-03T16:21:49.932737116Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 4.452015207s" Nov 3 16:21:49.932804 containerd[1612]: time="2025-11-03T16:21:49.932784185Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 3 16:21:49.935689 containerd[1612]: time="2025-11-03T16:21:49.934862980Z" level=info msg="CreateContainer within sandbox \"e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 3 16:21:49.945922 containerd[1612]: time="2025-11-03T16:21:49.945861616Z" level=info msg="Container d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:21:49.951792 containerd[1612]: time="2025-11-03T16:21:49.951756420Z" level=info msg="CreateContainer within sandbox \"e7dee3ea44f1eae153de53f2809036e4e181d7aef1b098d33919279b8b2697d4\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e\"" Nov 3 16:21:49.953092 containerd[1612]: time="2025-11-03T16:21:49.952195679Z" level=info msg="StartContainer for \"d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e\"" Nov 3 16:21:49.953092 containerd[1612]: time="2025-11-03T16:21:49.952985168Z" level=info msg="connecting to shim d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e" address="unix:///run/containerd/s/29b55b72403849760c7e3256fb6fbb394598d2819b6f83e8f3309232ab2fe3b0" protocol=ttrpc version=3 Nov 3 16:21:49.987293 systemd[1]: Started cri-containerd-d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e.scope - libcontainer container d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e. Nov 3 16:21:50.018603 containerd[1612]: time="2025-11-03T16:21:50.018456662Z" level=info msg="StartContainer for \"d0ff9e1c524c432037ed266ebe0ec85efdcadffa797a7ed71f9ee3a4f34d069e\" returns successfully" Nov 3 16:21:50.274541 kubelet[1903]: E1103 16:21:50.274455 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:51.275263 kubelet[1903]: E1103 16:21:51.275199 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:52.276335 kubelet[1903]: E1103 16:21:52.276287 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:53.277353 kubelet[1903]: E1103 16:21:53.277274 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:54.278213 kubelet[1903]: E1103 16:21:54.278133 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:55.278467 kubelet[1903]: E1103 16:21:55.278347 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:56.279015 kubelet[1903]: E1103 16:21:56.278908 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:56.348243 kubelet[1903]: I1103 16:21:56.348103 1903 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-lg55d" podStartSLOduration=7.894773927 podStartE2EDuration="12.34802955s" podCreationTimestamp="2025-11-03 16:21:44 +0000 UTC" firstStartedPulling="2025-11-03 16:21:45.480336611 +0000 UTC m=+19.201741252" lastFinishedPulling="2025-11-03 16:21:49.933592234 +0000 UTC m=+23.654996875" observedRunningTime="2025-11-03 16:21:50.477300292 +0000 UTC m=+24.198704933" watchObservedRunningTime="2025-11-03 16:21:56.34802955 +0000 UTC m=+30.069434191" Nov 3 16:21:56.352361 kubelet[1903]: I1103 16:21:56.352329 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-xplrh\" (UniqueName: \"kubernetes.io/projected/9d60cbb2-78e8-4b7c-987e-be30d295dc35-kube-api-access-xplrh\") pod \"nfs-server-provisioner-0\" (UID: \"9d60cbb2-78e8-4b7c-987e-be30d295dc35\") " pod="default/nfs-server-provisioner-0" Nov 3 16:21:56.352598 kubelet[1903]: I1103 16:21:56.352534 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/9d60cbb2-78e8-4b7c-987e-be30d295dc35-data\") pod \"nfs-server-provisioner-0\" (UID: \"9d60cbb2-78e8-4b7c-987e-be30d295dc35\") " pod="default/nfs-server-provisioner-0" Nov 3 16:21:56.357371 systemd[1]: Created slice kubepods-besteffort-pod9d60cbb2_78e8_4b7c_987e_be30d295dc35.slice - libcontainer container kubepods-besteffort-pod9d60cbb2_78e8_4b7c_987e_be30d295dc35.slice. Nov 3 16:21:56.661801 containerd[1612]: time="2025-11-03T16:21:56.661599886Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:9d60cbb2-78e8-4b7c-987e-be30d295dc35,Namespace:default,Attempt:0,}" Nov 3 16:21:56.701344 systemd-networkd[1520]: vethe0357eca: Link UP Nov 3 16:21:56.703805 kernel: cni0: port 2(vethe0357eca) entered blocking state Nov 3 16:21:56.704037 kernel: cni0: port 2(vethe0357eca) entered disabled state Nov 3 16:21:56.704100 kernel: vethe0357eca: entered allmulticast mode Nov 3 16:21:56.705675 kernel: vethe0357eca: entered promiscuous mode Nov 3 16:21:56.729535 kernel: cni0: port 2(vethe0357eca) entered blocking state Nov 3 16:21:56.729621 kernel: cni0: port 2(vethe0357eca) entered forwarding state Nov 3 16:21:56.729785 systemd-networkd[1520]: vethe0357eca: Gained carrier Nov 3 16:21:56.732452 containerd[1612]: 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)(0xc0000ae8e8), "name":"cbr0", "type":"bridge"} Nov 3 16:21:56.732452 containerd[1612]: delegateAdd: netconf sent to delegate plugin: Nov 3 16:21:56.767917 containerd[1612]: {"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-11-03T16:21:56.767864767Z" level=info msg="connecting to shim 4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31" address="unix:///run/containerd/s/0d383a26c4d48be3944be4ef62bae3c09291ed1c0dcdd6feca96c872dea28225" namespace=k8s.io protocol=ttrpc version=3 Nov 3 16:21:56.800279 systemd[1]: Started cri-containerd-4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31.scope - libcontainer container 4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31. Nov 3 16:21:56.820222 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 3 16:21:56.856598 containerd[1612]: time="2025-11-03T16:21:56.856537581Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:9d60cbb2-78e8-4b7c-987e-be30d295dc35,Namespace:default,Attempt:0,} returns sandbox id \"4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31\"" Nov 3 16:21:56.858226 containerd[1612]: time="2025-11-03T16:21:56.858200670Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 3 16:21:57.279595 kubelet[1903]: E1103 16:21:57.279531 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:58.280165 kubelet[1903]: E1103 16:21:58.280090 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:58.567303 systemd-networkd[1520]: vethe0357eca: Gained IPv6LL Nov 3 16:21:59.280572 kubelet[1903]: E1103 16:21:59.280520 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:21:59.758917 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1583287919.mount: Deactivated successfully. Nov 3 16:22:00.281793 kubelet[1903]: E1103 16:22:00.281727 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:01.282796 kubelet[1903]: E1103 16:22:01.282734 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:01.889622 containerd[1612]: time="2025-11-03T16:22:01.889556895Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:22:01.890558 containerd[1612]: time="2025-11-03T16:22:01.890512977Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91029831" Nov 3 16:22:01.891887 containerd[1612]: time="2025-11-03T16:22:01.891834604Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:22:01.894602 containerd[1612]: time="2025-11-03T16:22:01.894565081Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:22:01.895671 containerd[1612]: time="2025-11-03T16:22:01.895631873Z" 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.037398207s" Nov 3 16:22:01.895671 containerd[1612]: time="2025-11-03T16:22:01.895669117Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Nov 3 16:22:01.898118 containerd[1612]: time="2025-11-03T16:22:01.898066896Z" level=info msg="CreateContainer within sandbox \"4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 3 16:22:01.906524 containerd[1612]: time="2025-11-03T16:22:01.906476066Z" level=info msg="Container 8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:22:01.914419 containerd[1612]: time="2025-11-03T16:22:01.914385738Z" level=info msg="CreateContainer within sandbox \"4c03275ec88ae3e3eb3a733d8987a88bc97a9e6f52dfc826e9fe6c6654940f31\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968\"" Nov 3 16:22:01.914981 containerd[1612]: time="2025-11-03T16:22:01.914945767Z" level=info msg="StartContainer for \"8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968\"" Nov 3 16:22:01.915862 containerd[1612]: time="2025-11-03T16:22:01.915837553Z" level=info msg="connecting to shim 8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968" address="unix:///run/containerd/s/0d383a26c4d48be3944be4ef62bae3c09291ed1c0dcdd6feca96c872dea28225" protocol=ttrpc version=3 Nov 3 16:22:01.941244 systemd[1]: Started cri-containerd-8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968.scope - libcontainer container 8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968. Nov 3 16:22:01.980442 containerd[1612]: time="2025-11-03T16:22:01.980375694Z" level=info msg="StartContainer for \"8c6dc2ef452001ed32449dc5030b36db808a3fd49695c7982a7ccd749634f968\" returns successfully" Nov 3 16:22:02.283518 kubelet[1903]: E1103 16:22:02.283475 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:02.538631 kubelet[1903]: I1103 16:22:02.538446 1903 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.500027023 podStartE2EDuration="6.538421863s" podCreationTimestamp="2025-11-03 16:21:56 +0000 UTC" firstStartedPulling="2025-11-03 16:21:56.857929895 +0000 UTC m=+30.579334526" lastFinishedPulling="2025-11-03 16:22:01.896324725 +0000 UTC m=+35.617729366" observedRunningTime="2025-11-03 16:22:02.538264302 +0000 UTC m=+36.259668953" watchObservedRunningTime="2025-11-03 16:22:02.538421863 +0000 UTC m=+36.259826504" Nov 3 16:22:03.284382 kubelet[1903]: E1103 16:22:03.284297 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:04.284732 kubelet[1903]: E1103 16:22:04.284631 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:05.285902 kubelet[1903]: E1103 16:22:05.285809 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:06.286212 kubelet[1903]: E1103 16:22:06.286150 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:06.609141 update_engine[1594]: I20251103 16:22:06.608881 1594 update_attempter.cc:509] Updating boot flags... Nov 3 16:22:07.260701 kubelet[1903]: E1103 16:22:07.260615 1903 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:07.287277 kubelet[1903]: E1103 16:22:07.287193 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:07.806129 kernel: clocksource: Long readout interval, skipping watchdog check: cs_nsec: 1012394018 wd_nsec: 1012393828 Nov 3 16:22:08.287673 kubelet[1903]: E1103 16:22:08.287608 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:09.288854 kubelet[1903]: E1103 16:22:09.288758 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:10.289230 kubelet[1903]: E1103 16:22:10.289156 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:11.289973 kubelet[1903]: E1103 16:22:11.289910 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:12.290487 kubelet[1903]: E1103 16:22:12.290375 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:12.407565 systemd[1]: Created slice kubepods-besteffort-pod4cfdde68_287c_473c_9b08_cc336d2ad7ff.slice - libcontainer container kubepods-besteffort-pod4cfdde68_287c_473c_9b08_cc336d2ad7ff.slice. Nov 3 16:22:12.530464 kubelet[1903]: I1103 16:22:12.530390 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-g5rp9\" (UniqueName: \"kubernetes.io/projected/4cfdde68-287c-473c-9b08-cc336d2ad7ff-kube-api-access-g5rp9\") pod \"test-pod-1\" (UID: \"4cfdde68-287c-473c-9b08-cc336d2ad7ff\") " pod="default/test-pod-1" Nov 3 16:22:12.530464 kubelet[1903]: I1103 16:22:12.530465 1903 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-bf786466-074e-4046-a200-cdc546334f5e\" (UniqueName: \"kubernetes.io/nfs/4cfdde68-287c-473c-9b08-cc336d2ad7ff-pvc-bf786466-074e-4046-a200-cdc546334f5e\") pod \"test-pod-1\" (UID: \"4cfdde68-287c-473c-9b08-cc336d2ad7ff\") " pod="default/test-pod-1" Nov 3 16:22:12.671125 kernel: netfs: FS-Cache loaded Nov 3 16:22:12.745420 kernel: RPC: Registered named UNIX socket transport module. Nov 3 16:22:12.745615 kernel: RPC: Registered udp transport module. Nov 3 16:22:12.745681 kernel: RPC: Registered tcp transport module. Nov 3 16:22:12.746269 kernel: RPC: Registered tcp-with-tls transport module. Nov 3 16:22:12.747234 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 3 16:22:12.990547 kernel: NFS: Registering the id_resolver key type Nov 3 16:22:12.990703 kernel: Key type id_resolver registered Nov 3 16:22:12.990758 kernel: Key type id_legacy registered Nov 3 16:22:13.101620 nfsidmap[2960]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 3 16:22:13.102555 nfsidmap[2960]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 3 16:22:13.107556 nfsidmap[2963]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 3 16:22:13.107767 nfsidmap[2963]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 3 16:22:13.115065 nfsrahead[2967]: setting /var/lib/kubelet/pods/4cfdde68-287c-473c-9b08-cc336d2ad7ff/volumes/kubernetes.io~nfs/pvc-bf786466-074e-4046-a200-cdc546334f5e readahead to 128 Nov 3 16:22:13.291591 kubelet[1903]: E1103 16:22:13.291519 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:13.311560 containerd[1612]: time="2025-11-03T16:22:13.311476319Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4cfdde68-287c-473c-9b08-cc336d2ad7ff,Namespace:default,Attempt:0,}" Nov 3 16:22:13.548061 systemd-networkd[1520]: vethdc132951: Link UP Nov 3 16:22:13.550361 kernel: cni0: port 3(vethdc132951) entered blocking state Nov 3 16:22:13.550421 kernel: cni0: port 3(vethdc132951) entered disabled state Nov 3 16:22:13.550441 kernel: vethdc132951: entered allmulticast mode Nov 3 16:22:13.552225 kernel: vethdc132951: entered promiscuous mode Nov 3 16:22:13.563538 kernel: cni0: port 3(vethdc132951) entered blocking state Nov 3 16:22:13.563621 kernel: cni0: port 3(vethdc132951) entered forwarding state Nov 3 16:22:13.563792 systemd-networkd[1520]: vethdc132951: Gained carrier Nov 3 16:22:13.565570 containerd[1612]: 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)(0xc00011a8e8), "name":"cbr0", "type":"bridge"} Nov 3 16:22:13.565570 containerd[1612]: delegateAdd: netconf sent to delegate plugin: Nov 3 16:22:13.663882 containerd[1612]: {"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-11-03T16:22:13.663793931Z" level=info msg="connecting to shim ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf" address="unix:///run/containerd/s/d83e942a3828bce28c60959c051a8c657a334f6eebb248cf4a209ed9dfba4b6b" namespace=k8s.io protocol=ttrpc version=3 Nov 3 16:22:13.694337 systemd[1]: Started cri-containerd-ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf.scope - libcontainer container ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf. Nov 3 16:22:13.712429 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 3 16:22:13.746467 containerd[1612]: time="2025-11-03T16:22:13.746404358Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:4cfdde68-287c-473c-9b08-cc336d2ad7ff,Namespace:default,Attempt:0,} returns sandbox id \"ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf\"" Nov 3 16:22:13.748212 containerd[1612]: time="2025-11-03T16:22:13.748171735Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 3 16:22:14.163536 containerd[1612]: time="2025-11-03T16:22:14.163436172Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 3 16:22:14.164277 containerd[1612]: time="2025-11-03T16:22:14.164245165Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=0" Nov 3 16:22:14.166789 containerd[1612]: time="2025-11-03T16:22:14.166752285Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 418.529582ms" Nov 3 16:22:14.166830 containerd[1612]: time="2025-11-03T16:22:14.166787113Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 3 16:22:14.168971 containerd[1612]: time="2025-11-03T16:22:14.168931843Z" level=info msg="CreateContainer within sandbox \"ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 3 16:22:14.177086 containerd[1612]: time="2025-11-03T16:22:14.177019098Z" level=info msg="Container 9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253: CDI devices from CRI Config.CDIDevices: []" Nov 3 16:22:14.180689 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2023497187.mount: Deactivated successfully. Nov 3 16:22:14.184368 containerd[1612]: time="2025-11-03T16:22:14.184329292Z" level=info msg="CreateContainer within sandbox \"ff942273cccdd470ea61223d8067e6366ba6f753b18a0d6316a8402904ee8acf\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253\"" Nov 3 16:22:14.184838 containerd[1612]: time="2025-11-03T16:22:14.184794591Z" level=info msg="StartContainer for \"9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253\"" Nov 3 16:22:14.185699 containerd[1612]: time="2025-11-03T16:22:14.185678317Z" level=info msg="connecting to shim 9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253" address="unix:///run/containerd/s/d83e942a3828bce28c60959c051a8c657a334f6eebb248cf4a209ed9dfba4b6b" protocol=ttrpc version=3 Nov 3 16:22:14.209211 systemd[1]: Started cri-containerd-9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253.scope - libcontainer container 9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253. Nov 3 16:22:14.241924 containerd[1612]: time="2025-11-03T16:22:14.241880580Z" level=info msg="StartContainer for \"9d1e090f7e4b97a95792e8e44db3120bb11163c3221449d18c37b133b17b9253\" returns successfully" Nov 3 16:22:14.292182 kubelet[1903]: E1103 16:22:14.292118 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:14.564731 kubelet[1903]: I1103 16:22:14.564618 1903 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=18.144645087 podStartE2EDuration="18.564571717s" podCreationTimestamp="2025-11-03 16:21:56 +0000 UTC" firstStartedPulling="2025-11-03 16:22:13.747678872 +0000 UTC m=+47.469083513" lastFinishedPulling="2025-11-03 16:22:14.167605502 +0000 UTC m=+47.889010143" observedRunningTime="2025-11-03 16:22:14.564382351 +0000 UTC m=+48.285787012" watchObservedRunningTime="2025-11-03 16:22:14.564571717 +0000 UTC m=+48.285976358" Nov 3 16:22:15.292828 kubelet[1903]: E1103 16:22:15.292746 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:15.527364 systemd-networkd[1520]: vethdc132951: Gained IPv6LL Nov 3 16:22:16.293502 kubelet[1903]: E1103 16:22:16.293387 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:17.294253 kubelet[1903]: E1103 16:22:17.294172 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 3 16:22:18.294769 kubelet[1903]: E1103 16:22:18.294688 1903 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"