Apr 17 23:25:23.856722 kernel: Linux version 6.6.127-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Fri Apr 17 22:11:20 -00 2026 Apr 17 23:25:23.856741 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=e69cfa144bf8cf6f0b7e7881c91c17228ba9dbcb6c99d9692bced9ddba34ee3a Apr 17 23:25:23.856751 kernel: BIOS-provided physical RAM map: Apr 17 23:25:23.856757 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Apr 17 23:25:23.856765 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Apr 17 23:25:23.856772 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Apr 17 23:25:23.856782 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Apr 17 23:25:23.856790 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Apr 17 23:25:23.856796 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Apr 17 23:25:23.856803 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Apr 17 23:25:23.856808 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Apr 17 23:25:23.856813 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Apr 17 23:25:23.856818 kernel: NX (Execute Disable) protection: active Apr 17 23:25:23.856824 kernel: APIC: Static calls initialized Apr 17 23:25:23.856830 kernel: SMBIOS 2.8 present. Apr 17 23:25:23.856837 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Apr 17 23:25:23.856843 kernel: Hypervisor detected: KVM Apr 17 23:25:23.856848 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Apr 17 23:25:23.856854 kernel: kvm-clock: using sched offset of 3388523413 cycles Apr 17 23:25:23.856860 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Apr 17 23:25:23.856866 kernel: tsc: Detected 2793.438 MHz processor Apr 17 23:25:23.856872 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 17 23:25:23.856877 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 17 23:25:23.856883 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x10000000000 Apr 17 23:25:23.856890 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Apr 17 23:25:23.856896 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 17 23:25:23.856902 kernel: Using GB pages for direct mapping Apr 17 23:25:23.856907 kernel: ACPI: Early table checksum verification disabled Apr 17 23:25:23.856911 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Apr 17 23:25:23.856916 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856921 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856926 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856930 kernel: ACPI: FACS 0x000000009CFE0000 000040 Apr 17 23:25:23.856936 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856941 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856945 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856950 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 17 23:25:23.856954 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Apr 17 23:25:23.856959 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Apr 17 23:25:23.856964 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Apr 17 23:25:23.856971 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Apr 17 23:25:23.856977 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Apr 17 23:25:23.856982 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Apr 17 23:25:23.856987 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Apr 17 23:25:23.856991 kernel: No NUMA configuration found Apr 17 23:25:23.856996 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Apr 17 23:25:23.857001 kernel: NODE_DATA(0) allocated [mem 0x9cfd6000-0x9cfdbfff] Apr 17 23:25:23.857007 kernel: Zone ranges: Apr 17 23:25:23.857012 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 17 23:25:23.857017 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Apr 17 23:25:23.857022 kernel: Normal empty Apr 17 23:25:23.857027 kernel: Movable zone start for each node Apr 17 23:25:23.857032 kernel: Early memory node ranges Apr 17 23:25:23.857037 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Apr 17 23:25:23.857042 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Apr 17 23:25:23.857046 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Apr 17 23:25:23.857051 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 17 23:25:23.857058 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Apr 17 23:25:23.857063 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Apr 17 23:25:23.857068 kernel: ACPI: PM-Timer IO Port: 0x608 Apr 17 23:25:23.857073 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Apr 17 23:25:23.857077 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Apr 17 23:25:23.857082 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 17 23:25:23.857087 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Apr 17 23:25:23.857092 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 17 23:25:23.857097 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Apr 17 23:25:23.857103 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Apr 17 23:25:23.857108 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 17 23:25:23.857113 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 17 23:25:23.857118 kernel: TSC deadline timer available Apr 17 23:25:23.857123 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Apr 17 23:25:23.857128 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Apr 17 23:25:23.857133 kernel: kvm-guest: KVM setup pv remote TLB flush Apr 17 23:25:23.857137 kernel: kvm-guest: setup PV sched yield Apr 17 23:25:23.857142 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Apr 17 23:25:23.857149 kernel: Booting paravirtualized kernel on KVM Apr 17 23:25:23.857154 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 17 23:25:23.857159 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Apr 17 23:25:23.857164 kernel: percpu: Embedded 57 pages/cpu s196328 r8192 d28952 u524288 Apr 17 23:25:23.857169 kernel: pcpu-alloc: s196328 r8192 d28952 u524288 alloc=1*2097152 Apr 17 23:25:23.857174 kernel: pcpu-alloc: [0] 0 1 2 3 Apr 17 23:25:23.857178 kernel: kvm-guest: PV spinlocks enabled Apr 17 23:25:23.857183 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 17 23:25:23.857189 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=e69cfa144bf8cf6f0b7e7881c91c17228ba9dbcb6c99d9692bced9ddba34ee3a Apr 17 23:25:23.857195 kernel: random: crng init done Apr 17 23:25:23.857200 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 17 23:25:23.857328 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 17 23:25:23.857334 kernel: Fallback order for Node 0: 0 Apr 17 23:25:23.857339 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632732 Apr 17 23:25:23.857343 kernel: Policy zone: DMA32 Apr 17 23:25:23.857348 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 17 23:25:23.857354 kernel: Memory: 2433652K/2571752K available (12288K kernel code, 2288K rwdata, 22752K rodata, 42892K init, 2304K bss, 137896K reserved, 0K cma-reserved) Apr 17 23:25:23.857361 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 17 23:25:23.857366 kernel: ftrace: allocating 37996 entries in 149 pages Apr 17 23:25:23.857371 kernel: ftrace: allocated 149 pages with 4 groups Apr 17 23:25:23.857378 kernel: Dynamic Preempt: voluntary Apr 17 23:25:23.857387 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 17 23:25:23.857396 kernel: rcu: RCU event tracing is enabled. Apr 17 23:25:23.857404 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 17 23:25:23.857409 kernel: Trampoline variant of Tasks RCU enabled. Apr 17 23:25:23.857414 kernel: Rude variant of Tasks RCU enabled. Apr 17 23:25:23.857420 kernel: Tracing variant of Tasks RCU enabled. Apr 17 23:25:23.857425 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 17 23:25:23.857430 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 17 23:25:23.857435 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Apr 17 23:25:23.857440 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 17 23:25:23.857445 kernel: Console: colour VGA+ 80x25 Apr 17 23:25:23.857450 kernel: printk: console [ttyS0] enabled Apr 17 23:25:23.857455 kernel: ACPI: Core revision 20230628 Apr 17 23:25:23.857460 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Apr 17 23:25:23.857465 kernel: APIC: Switch to symmetric I/O mode setup Apr 17 23:25:23.857471 kernel: x2apic enabled Apr 17 23:25:23.857476 kernel: APIC: Switched APIC routing to: physical x2apic Apr 17 23:25:23.857481 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Apr 17 23:25:23.857486 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Apr 17 23:25:23.857510 kernel: kvm-guest: setup PV IPIs Apr 17 23:25:23.857515 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Apr 17 23:25:23.857521 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 17 23:25:23.857532 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Apr 17 23:25:23.857538 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Apr 17 23:25:23.857543 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Apr 17 23:25:23.857548 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Apr 17 23:25:23.857555 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 17 23:25:23.857560 kernel: Spectre V2 : Mitigation: Retpolines Apr 17 23:25:23.857566 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Apr 17 23:25:23.857572 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Apr 17 23:25:23.857581 kernel: RETBleed: Vulnerable Apr 17 23:25:23.857592 kernel: Speculative Store Bypass: Vulnerable Apr 17 23:25:23.857603 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Apr 17 23:25:23.857618 kernel: GDS: Unknown: Dependent on hypervisor status Apr 17 23:25:23.857624 kernel: active return thunk: its_return_thunk Apr 17 23:25:23.857629 kernel: ITS: Mitigation: Aligned branch/return thunks Apr 17 23:25:23.857635 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 17 23:25:23.857640 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 17 23:25:23.857649 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 17 23:25:23.857698 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Apr 17 23:25:23.857709 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Apr 17 23:25:23.857715 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Apr 17 23:25:23.857720 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 17 23:25:23.857725 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Apr 17 23:25:23.857731 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Apr 17 23:25:23.857736 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Apr 17 23:25:23.857742 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Apr 17 23:25:23.857747 kernel: Freeing SMP alternatives memory: 32K Apr 17 23:25:23.857753 kernel: pid_max: default: 32768 minimum: 301 Apr 17 23:25:23.857760 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 17 23:25:23.857765 kernel: landlock: Up and running. Apr 17 23:25:23.857771 kernel: SELinux: Initializing. Apr 17 23:25:23.857776 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 17 23:25:23.857781 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 17 23:25:23.857787 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Apr 17 23:25:23.857793 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 17 23:25:23.857798 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 17 23:25:23.857805 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 17 23:25:23.857811 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Apr 17 23:25:23.857816 kernel: signal: max sigframe size: 3632 Apr 17 23:25:23.857822 kernel: rcu: Hierarchical SRCU implementation. Apr 17 23:25:23.857827 kernel: rcu: Max phase no-delay instances is 400. Apr 17 23:25:23.857833 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Apr 17 23:25:23.857838 kernel: smp: Bringing up secondary CPUs ... Apr 17 23:25:23.857843 kernel: smpboot: x86: Booting SMP configuration: Apr 17 23:25:23.857849 kernel: .... node #0, CPUs: #1 #2 #3 Apr 17 23:25:23.857856 kernel: smp: Brought up 1 node, 4 CPUs Apr 17 23:25:23.857866 kernel: smpboot: Max logical packages: 1 Apr 17 23:25:23.857875 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Apr 17 23:25:23.857884 kernel: devtmpfs: initialized Apr 17 23:25:23.857894 kernel: x86/mm: Memory block size: 128MB Apr 17 23:25:23.857902 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 17 23:25:23.857908 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 17 23:25:23.857913 kernel: pinctrl core: initialized pinctrl subsystem Apr 17 23:25:23.857918 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 17 23:25:23.857924 kernel: audit: initializing netlink subsys (disabled) Apr 17 23:25:23.857931 kernel: audit: type=2000 audit(1776468323.306:1): state=initialized audit_enabled=0 res=1 Apr 17 23:25:23.857936 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 17 23:25:23.857942 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 17 23:25:23.857947 kernel: cpuidle: using governor menu Apr 17 23:25:23.857952 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 17 23:25:23.857958 kernel: dca service started, version 1.12.1 Apr 17 23:25:23.857964 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Apr 17 23:25:23.857969 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Apr 17 23:25:23.857976 kernel: PCI: Using configuration type 1 for base access Apr 17 23:25:23.857981 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 17 23:25:23.857987 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 17 23:25:23.857992 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Apr 17 23:25:23.857997 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 17 23:25:23.858003 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Apr 17 23:25:23.858008 kernel: ACPI: Added _OSI(Module Device) Apr 17 23:25:23.858014 kernel: ACPI: Added _OSI(Processor Device) Apr 17 23:25:23.858019 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 17 23:25:23.858026 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 17 23:25:23.858032 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Apr 17 23:25:23.858038 kernel: ACPI: Interpreter enabled Apr 17 23:25:23.858043 kernel: ACPI: PM: (supports S0 S3 S5) Apr 17 23:25:23.858048 kernel: ACPI: Using IOAPIC for interrupt routing Apr 17 23:25:23.858054 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 17 23:25:23.858059 kernel: PCI: Using E820 reservations for host bridge windows Apr 17 23:25:23.858065 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Apr 17 23:25:23.858070 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 17 23:25:23.858365 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 17 23:25:23.858445 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Apr 17 23:25:23.858644 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Apr 17 23:25:23.858658 kernel: PCI host bridge to bus 0000:00 Apr 17 23:25:23.858723 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Apr 17 23:25:23.858787 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 17 23:25:23.858848 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 17 23:25:23.858916 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Apr 17 23:25:23.858965 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Apr 17 23:25:23.859013 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Apr 17 23:25:23.859061 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 17 23:25:23.859126 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Apr 17 23:25:23.859190 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Apr 17 23:25:23.859284 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Apr 17 23:25:23.859339 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Apr 17 23:25:23.859393 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Apr 17 23:25:23.859448 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 17 23:25:23.859533 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Apr 17 23:25:23.859612 kernel: pci 0000:00:02.0: reg 0x10: [io 0xc0c0-0xc0df] Apr 17 23:25:23.859667 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Apr 17 23:25:23.859725 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Apr 17 23:25:23.859784 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Apr 17 23:25:23.859839 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc07f] Apr 17 23:25:23.859894 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Apr 17 23:25:23.859948 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Apr 17 23:25:23.860006 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Apr 17 23:25:23.860061 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc0e0-0xc0ff] Apr 17 23:25:23.860118 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Apr 17 23:25:23.860172 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Apr 17 23:25:23.860256 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Apr 17 23:25:23.860315 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Apr 17 23:25:23.860371 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Apr 17 23:25:23.860429 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Apr 17 23:25:23.860506 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc100-0xc11f] Apr 17 23:25:23.860563 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfebd4000-0xfebd4fff] Apr 17 23:25:23.860622 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Apr 17 23:25:23.860675 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Apr 17 23:25:23.860682 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Apr 17 23:25:23.860688 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Apr 17 23:25:23.860693 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Apr 17 23:25:23.860699 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Apr 17 23:25:23.860706 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Apr 17 23:25:23.860727 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Apr 17 23:25:23.860732 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Apr 17 23:25:23.860738 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Apr 17 23:25:23.860743 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Apr 17 23:25:23.860748 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Apr 17 23:25:23.860754 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Apr 17 23:25:23.860759 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Apr 17 23:25:23.860765 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Apr 17 23:25:23.860772 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Apr 17 23:25:23.860777 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Apr 17 23:25:23.860783 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Apr 17 23:25:23.860788 kernel: iommu: Default domain type: Translated Apr 17 23:25:23.860793 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 17 23:25:23.860799 kernel: PCI: Using ACPI for IRQ routing Apr 17 23:25:23.860804 kernel: PCI: pci_cache_line_size set to 64 bytes Apr 17 23:25:23.860810 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Apr 17 23:25:23.860815 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Apr 17 23:25:23.860873 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Apr 17 23:25:23.860926 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Apr 17 23:25:23.860980 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 17 23:25:23.860987 kernel: vgaarb: loaded Apr 17 23:25:23.860993 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 17 23:25:23.860998 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Apr 17 23:25:23.861004 kernel: clocksource: Switched to clocksource kvm-clock Apr 17 23:25:23.861009 kernel: VFS: Disk quotas dquot_6.6.0 Apr 17 23:25:23.861015 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 17 23:25:23.861022 kernel: pnp: PnP ACPI init Apr 17 23:25:23.861082 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Apr 17 23:25:23.861089 kernel: pnp: PnP ACPI: found 6 devices Apr 17 23:25:23.861095 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 17 23:25:23.861101 kernel: NET: Registered PF_INET protocol family Apr 17 23:25:23.861106 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 17 23:25:23.861112 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 17 23:25:23.861117 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 17 23:25:23.861125 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 17 23:25:23.861131 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 17 23:25:23.861136 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 17 23:25:23.861142 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 17 23:25:23.861147 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 17 23:25:23.861153 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 17 23:25:23.861158 kernel: NET: Registered PF_XDP protocol family Apr 17 23:25:23.861232 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Apr 17 23:25:23.861284 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Apr 17 23:25:23.861335 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Apr 17 23:25:23.861410 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Apr 17 23:25:23.861461 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Apr 17 23:25:23.861618 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Apr 17 23:25:23.861626 kernel: PCI: CLS 0 bytes, default 64 Apr 17 23:25:23.861632 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Apr 17 23:25:23.861638 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 17 23:25:23.861644 kernel: Initialise system trusted keyrings Apr 17 23:25:23.861652 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 17 23:25:23.861658 kernel: Key type asymmetric registered Apr 17 23:25:23.861663 kernel: Asymmetric key parser 'x509' registered Apr 17 23:25:23.861670 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Apr 17 23:25:23.861679 kernel: io scheduler mq-deadline registered Apr 17 23:25:23.861688 kernel: io scheduler kyber registered Apr 17 23:25:23.861697 kernel: io scheduler bfq registered Apr 17 23:25:23.861705 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 17 23:25:23.861711 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Apr 17 23:25:23.861719 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Apr 17 23:25:23.861724 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Apr 17 23:25:23.861729 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 17 23:25:23.861753 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 17 23:25:23.861759 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Apr 17 23:25:23.861774 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Apr 17 23:25:23.861780 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Apr 17 23:25:23.861785 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Apr 17 23:25:23.861949 kernel: rtc_cmos 00:04: RTC can wake from S4 Apr 17 23:25:23.862055 kernel: rtc_cmos 00:04: registered as rtc0 Apr 17 23:25:23.862109 kernel: rtc_cmos 00:04: setting system clock to 2026-04-17T23:25:23 UTC (1776468323) Apr 17 23:25:23.862159 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Apr 17 23:25:23.862166 kernel: intel_pstate: CPU model not supported Apr 17 23:25:23.862172 kernel: NET: Registered PF_INET6 protocol family Apr 17 23:25:23.862177 kernel: Segment Routing with IPv6 Apr 17 23:25:23.862183 kernel: In-situ OAM (IOAM) with IPv6 Apr 17 23:25:23.862188 kernel: NET: Registered PF_PACKET protocol family Apr 17 23:25:23.862196 kernel: Key type dns_resolver registered Apr 17 23:25:23.862226 kernel: IPI shorthand broadcast: enabled Apr 17 23:25:23.862232 kernel: sched_clock: Marking stable (774012027, 187791152)->(1009853495, -48050316) Apr 17 23:25:23.862237 kernel: registered taskstats version 1 Apr 17 23:25:23.862242 kernel: Loading compiled-in X.509 certificates Apr 17 23:25:23.862248 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.127-flatcar: 39e9969c7f49062f0fc1d1fb72e8f874436eb94f' Apr 17 23:25:23.862253 kernel: Key type .fscrypt registered Apr 17 23:25:23.862259 kernel: Key type fscrypt-provisioning registered Apr 17 23:25:23.862264 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 17 23:25:23.862273 kernel: ima: Allocated hash algorithm: sha1 Apr 17 23:25:23.862279 kernel: ima: No architecture policies found Apr 17 23:25:23.862284 kernel: clk: Disabling unused clocks Apr 17 23:25:23.862290 kernel: Freeing unused kernel image (initmem) memory: 42892K Apr 17 23:25:23.862295 kernel: Write protecting the kernel read-only data: 36864k Apr 17 23:25:23.862301 kernel: Freeing unused kernel image (rodata/data gap) memory: 1824K Apr 17 23:25:23.862306 kernel: Run /init as init process Apr 17 23:25:23.862312 kernel: with arguments: Apr 17 23:25:23.862317 kernel: /init Apr 17 23:25:23.862324 kernel: with environment: Apr 17 23:25:23.862329 kernel: HOME=/ Apr 17 23:25:23.862334 kernel: TERM=linux Apr 17 23:25:23.862341 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 17 23:25:23.862349 systemd[1]: Detected virtualization kvm. Apr 17 23:25:23.862355 systemd[1]: Detected architecture x86-64. Apr 17 23:25:23.862361 systemd[1]: Running in initrd. Apr 17 23:25:23.862366 systemd[1]: No hostname configured, using default hostname. Apr 17 23:25:23.862373 systemd[1]: Hostname set to . Apr 17 23:25:23.862380 systemd[1]: Initializing machine ID from VM UUID. Apr 17 23:25:23.862385 systemd[1]: Queued start job for default target initrd.target. Apr 17 23:25:23.862391 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 17 23:25:23.862397 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 17 23:25:23.862403 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 17 23:25:23.862409 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 17 23:25:23.862415 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 17 23:25:23.862423 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 17 23:25:23.862449 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 17 23:25:23.862455 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 17 23:25:23.862461 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 17 23:25:23.862469 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 17 23:25:23.862475 systemd[1]: Reached target paths.target - Path Units. Apr 17 23:25:23.862481 systemd[1]: Reached target slices.target - Slice Units. Apr 17 23:25:23.862556 systemd[1]: Reached target swap.target - Swaps. Apr 17 23:25:23.862574 systemd[1]: Reached target timers.target - Timer Units. Apr 17 23:25:23.862580 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 17 23:25:23.862586 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 17 23:25:23.862596 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 17 23:25:23.862602 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 17 23:25:23.862611 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 17 23:25:23.862617 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 17 23:25:23.862623 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 17 23:25:23.862629 systemd[1]: Reached target sockets.target - Socket Units. Apr 17 23:25:23.862635 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 17 23:25:23.862641 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 17 23:25:23.862647 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 17 23:25:23.862653 systemd[1]: Starting systemd-fsck-usr.service... Apr 17 23:25:23.862659 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 17 23:25:23.862670 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 17 23:25:23.862675 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 17 23:25:23.862681 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 17 23:25:23.862703 systemd-journald[194]: Collecting audit messages is disabled. Apr 17 23:25:23.862720 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 17 23:25:23.862726 systemd[1]: Finished systemd-fsck-usr.service. Apr 17 23:25:23.862736 systemd-journald[194]: Journal started Apr 17 23:25:23.862750 systemd-journald[194]: Runtime Journal (/run/log/journal/1a5d381235184e639c19ab864458336f) is 6.0M, max 48.4M, 42.3M free. Apr 17 23:25:23.866092 systemd-modules-load[195]: Inserted module 'overlay' Apr 17 23:25:23.869078 systemd[1]: Started systemd-journald.service - Journal Service. Apr 17 23:25:23.869426 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 17 23:25:23.876394 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 17 23:25:23.877989 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 17 23:25:23.881388 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 17 23:25:23.975133 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 17 23:25:23.975159 kernel: Bridge firewalling registered Apr 17 23:25:23.893965 systemd-modules-load[195]: Inserted module 'br_netfilter' Apr 17 23:25:23.975421 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 17 23:25:23.975846 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 17 23:25:23.999445 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 17 23:25:24.004373 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 17 23:25:24.006175 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 17 23:25:24.008636 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 17 23:25:24.019654 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 17 23:25:24.021794 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 17 23:25:24.031103 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 17 23:25:24.041351 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 17 23:25:24.045776 systemd-resolved[223]: Positive Trust Anchors: Apr 17 23:25:24.045801 systemd-resolved[223]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 17 23:25:24.045835 systemd-resolved[223]: 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 Apr 17 23:25:24.048328 systemd-resolved[223]: Defaulting to hostname 'linux'. Apr 17 23:25:24.049072 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 17 23:25:24.049862 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 17 23:25:24.071319 dracut-cmdline[229]: dracut-dracut-053 Apr 17 23:25:24.074259 dracut-cmdline[229]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=e69cfa144bf8cf6f0b7e7881c91c17228ba9dbcb6c99d9692bced9ddba34ee3a Apr 17 23:25:24.138329 kernel: SCSI subsystem initialized Apr 17 23:25:24.150270 kernel: Loading iSCSI transport class v2.0-870. Apr 17 23:25:24.160340 kernel: iscsi: registered transport (tcp) Apr 17 23:25:24.179311 kernel: iscsi: registered transport (qla4xxx) Apr 17 23:25:24.179373 kernel: QLogic iSCSI HBA Driver Apr 17 23:25:24.210233 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 17 23:25:24.218448 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 17 23:25:24.239771 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 17 23:25:24.239854 kernel: device-mapper: uevent: version 1.0.3 Apr 17 23:25:24.239864 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 17 23:25:24.278339 kernel: raid6: avx512x4 gen() 45673 MB/s Apr 17 23:25:24.295335 kernel: raid6: avx512x2 gen() 45521 MB/s Apr 17 23:25:24.312305 kernel: raid6: avx512x1 gen() 39043 MB/s Apr 17 23:25:24.329300 kernel: raid6: avx2x4 gen() 37501 MB/s Apr 17 23:25:24.346233 kernel: raid6: avx2x2 gen() 37340 MB/s Apr 17 23:25:24.363936 kernel: raid6: avx2x1 gen() 29159 MB/s Apr 17 23:25:24.363972 kernel: raid6: using algorithm avx512x4 gen() 45673 MB/s Apr 17 23:25:24.382025 kernel: raid6: .... xor() 10442 MB/s, rmw enabled Apr 17 23:25:24.382111 kernel: raid6: using avx512x2 recovery algorithm Apr 17 23:25:24.400256 kernel: xor: automatically using best checksumming function avx Apr 17 23:25:24.530357 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 17 23:25:24.538374 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 17 23:25:24.547390 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 17 23:25:24.556566 systemd-udevd[412]: Using default interface naming scheme 'v255'. Apr 17 23:25:24.559335 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 17 23:25:24.573588 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 17 23:25:24.584294 dracut-pre-trigger[420]: rd.md=0: removing MD RAID activation Apr 17 23:25:24.608450 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 17 23:25:24.621412 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 17 23:25:24.653256 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 17 23:25:24.662385 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 17 23:25:24.672880 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 17 23:25:24.674115 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 17 23:25:24.679448 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 17 23:25:24.681169 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 17 23:25:24.697238 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Apr 17 23:25:24.694447 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 17 23:25:24.702242 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Apr 17 23:25:24.702354 kernel: cryptd: max_cpu_qlen set to 1000 Apr 17 23:25:24.703089 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 17 23:25:24.703200 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 17 23:25:24.705441 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 17 23:25:24.706738 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 17 23:25:24.706883 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 17 23:25:24.714103 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 17 23:25:24.720929 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 17 23:25:24.734852 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 17 23:25:24.734871 kernel: GPT:9289727 != 19775487 Apr 17 23:25:24.734885 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 17 23:25:24.734892 kernel: GPT:9289727 != 19775487 Apr 17 23:25:24.734899 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 17 23:25:24.734906 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 17 23:25:24.734913 kernel: libata version 3.00 loaded. Apr 17 23:25:24.732040 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 17 23:25:24.742556 kernel: ahci 0000:00:1f.2: version 3.0 Apr 17 23:25:24.742752 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Apr 17 23:25:24.745267 kernel: AVX2 version of gcm_enc/dec engaged. Apr 17 23:25:24.745288 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Apr 17 23:25:24.745399 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Apr 17 23:25:24.746244 kernel: AES CTR mode by8 optimization enabled Apr 17 23:25:24.754909 kernel: scsi host0: ahci Apr 17 23:25:24.755035 kernel: scsi host1: ahci Apr 17 23:25:24.759807 kernel: scsi host2: ahci Apr 17 23:25:24.759930 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (456) Apr 17 23:25:24.759939 kernel: scsi host3: ahci Apr 17 23:25:24.760062 kernel: BTRFS: device fsid 81b0bf8a-1550-4880-b72f-76fa51dbb6c0 devid 1 transid 32 /dev/vda3 scanned by (udev-worker) (475) Apr 17 23:25:24.760269 kernel: scsi host4: ahci Apr 17 23:25:24.761243 kernel: scsi host5: ahci Apr 17 23:25:24.761349 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 34 Apr 17 23:25:24.761358 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 34 Apr 17 23:25:24.761370 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 34 Apr 17 23:25:24.761378 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 34 Apr 17 23:25:24.761385 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 34 Apr 17 23:25:24.761394 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 34 Apr 17 23:25:24.766445 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 17 23:25:24.854365 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 17 23:25:24.860879 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 17 23:25:24.869007 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 17 23:25:24.872679 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 17 23:25:24.881091 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 17 23:25:24.897371 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 17 23:25:24.902339 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 17 23:25:24.909372 disk-uuid[555]: Primary Header is updated. Apr 17 23:25:24.909372 disk-uuid[555]: Secondary Entries is updated. Apr 17 23:25:24.909372 disk-uuid[555]: Secondary Header is updated. Apr 17 23:25:24.916315 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 17 23:25:24.916904 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 17 23:25:24.922334 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 17 23:25:25.076350 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Apr 17 23:25:25.076492 kernel: ata2: SATA link down (SStatus 0 SControl 300) Apr 17 23:25:25.077343 kernel: ata4: SATA link down (SStatus 0 SControl 300) Apr 17 23:25:25.078301 kernel: ata1: SATA link down (SStatus 0 SControl 300) Apr 17 23:25:25.081252 kernel: ata5: SATA link down (SStatus 0 SControl 300) Apr 17 23:25:25.081286 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Apr 17 23:25:25.082347 kernel: ata3.00: applying bridge limits Apr 17 23:25:25.084259 kernel: ata6: SATA link down (SStatus 0 SControl 300) Apr 17 23:25:25.084284 kernel: ata3.00: configured for UDMA/100 Apr 17 23:25:25.086373 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Apr 17 23:25:25.129046 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Apr 17 23:25:25.129455 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 17 23:25:25.144328 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Apr 17 23:25:25.921065 disk-uuid[559]: The operation has completed successfully. Apr 17 23:25:25.923486 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 17 23:25:25.944102 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 17 23:25:25.944351 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 17 23:25:25.964573 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 17 23:25:25.968091 sh[592]: Success Apr 17 23:25:25.978242 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Apr 17 23:25:26.006179 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 17 23:25:26.024664 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 17 23:25:26.027258 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 17 23:25:26.039302 kernel: BTRFS info (device dm-0): first mount of filesystem 81b0bf8a-1550-4880-b72f-76fa51dbb6c0 Apr 17 23:25:26.039355 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Apr 17 23:25:26.042333 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 17 23:25:26.042408 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 17 23:25:26.044529 kernel: BTRFS info (device dm-0): using free space tree Apr 17 23:25:26.049148 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 17 23:25:26.052284 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 17 23:25:26.065645 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 17 23:25:26.067412 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 17 23:25:26.080349 kernel: BTRFS info (device vda6): first mount of filesystem a5a0fe13-59ac-4c21-ab23-7fd1bfa02f60 Apr 17 23:25:26.080381 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 17 23:25:26.080390 kernel: BTRFS info (device vda6): using free space tree Apr 17 23:25:26.084335 kernel: BTRFS info (device vda6): auto enabling async discard Apr 17 23:25:26.090107 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 17 23:25:26.092927 kernel: BTRFS info (device vda6): last unmount of filesystem a5a0fe13-59ac-4c21-ab23-7fd1bfa02f60 Apr 17 23:25:26.098934 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 17 23:25:26.106332 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 17 23:25:26.153340 ignition[689]: Ignition 2.19.0 Apr 17 23:25:26.153353 ignition[689]: Stage: fetch-offline Apr 17 23:25:26.153385 ignition[689]: no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:26.153395 ignition[689]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:26.153524 ignition[689]: parsed url from cmdline: "" Apr 17 23:25:26.153528 ignition[689]: no config URL provided Apr 17 23:25:26.153533 ignition[689]: reading system config file "/usr/lib/ignition/user.ign" Apr 17 23:25:26.153541 ignition[689]: no config at "/usr/lib/ignition/user.ign" Apr 17 23:25:26.153569 ignition[689]: op(1): [started] loading QEMU firmware config module Apr 17 23:25:26.153574 ignition[689]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 17 23:25:26.169587 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 17 23:25:26.169662 ignition[689]: op(1): [finished] loading QEMU firmware config module Apr 17 23:25:26.170645 ignition[689]: parsing config with SHA512: 606a0c70403f7b5bf85a20473dac74e782ec91bd814863f15307a646721cfb5d8d54333137283d0449171571a985eeea593e4eb01ed1e9b12d4bfa4d26783ed9 Apr 17 23:25:26.173568 unknown[689]: fetched base config from "system" Apr 17 23:25:26.173748 ignition[689]: fetch-offline: fetch-offline passed Apr 17 23:25:26.173573 unknown[689]: fetched user config from "qemu" Apr 17 23:25:26.173793 ignition[689]: Ignition finished successfully Apr 17 23:25:26.193751 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 17 23:25:26.195072 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 17 23:25:26.211325 systemd-networkd[782]: lo: Link UP Apr 17 23:25:26.211342 systemd-networkd[782]: lo: Gained carrier Apr 17 23:25:26.212326 systemd-networkd[782]: Enumeration completed Apr 17 23:25:26.212497 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 17 23:25:26.212797 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 17 23:25:26.212799 systemd-networkd[782]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 17 23:25:26.213625 systemd-networkd[782]: eth0: Link UP Apr 17 23:25:26.213627 systemd-networkd[782]: eth0: Gained carrier Apr 17 23:25:26.213632 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 17 23:25:26.214339 systemd[1]: Reached target network.target - Network. Apr 17 23:25:26.215815 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 17 23:25:26.234495 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 17 23:25:26.238268 systemd-networkd[782]: eth0: DHCPv4 address 10.0.0.9/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 17 23:25:26.249041 ignition[785]: Ignition 2.19.0 Apr 17 23:25:26.249058 ignition[785]: Stage: kargs Apr 17 23:25:26.249192 ignition[785]: no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:26.249229 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:26.249714 ignition[785]: kargs: kargs passed Apr 17 23:25:26.249740 ignition[785]: Ignition finished successfully Apr 17 23:25:26.256028 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 17 23:25:26.267484 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 17 23:25:26.278181 ignition[794]: Ignition 2.19.0 Apr 17 23:25:26.278251 ignition[794]: Stage: disks Apr 17 23:25:26.278378 ignition[794]: no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:26.278384 ignition[794]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:26.278943 ignition[794]: disks: disks passed Apr 17 23:25:26.278973 ignition[794]: Ignition finished successfully Apr 17 23:25:26.287644 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 17 23:25:26.292231 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 17 23:25:26.294615 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 17 23:25:26.297040 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 17 23:25:26.297697 systemd[1]: Reached target sysinit.target - System Initialization. Apr 17 23:25:26.301800 systemd[1]: Reached target basic.target - Basic System. Apr 17 23:25:26.317600 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 17 23:25:26.326360 systemd-resolved[223]: Detected conflict on linux IN A 10.0.0.9 Apr 17 23:25:26.326379 systemd-resolved[223]: Hostname conflict, changing published hostname from 'linux' to 'linux4'. Apr 17 23:25:26.328018 systemd-fsck[804]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 17 23:25:26.333539 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 17 23:25:26.338120 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 17 23:25:26.433274 kernel: EXT4-fs (vda9): mounted filesystem d3c199f8-8065-4f33-a75b-da2f09d4fc39 r/w with ordered data mode. Quota mode: none. Apr 17 23:25:26.434132 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 17 23:25:26.438039 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 17 23:25:26.456555 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 17 23:25:26.461859 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 17 23:25:26.469094 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (812) Apr 17 23:25:26.469142 kernel: BTRFS info (device vda6): first mount of filesystem a5a0fe13-59ac-4c21-ab23-7fd1bfa02f60 Apr 17 23:25:26.469151 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 17 23:25:26.469159 kernel: BTRFS info (device vda6): using free space tree Apr 17 23:25:26.466337 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 17 23:25:26.477052 kernel: BTRFS info (device vda6): auto enabling async discard Apr 17 23:25:26.466371 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 17 23:25:26.466389 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 17 23:25:26.474337 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 17 23:25:26.478015 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 17 23:25:26.489099 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 17 23:25:26.513517 initrd-setup-root[836]: cut: /sysroot/etc/passwd: No such file or directory Apr 17 23:25:26.518794 initrd-setup-root[843]: cut: /sysroot/etc/group: No such file or directory Apr 17 23:25:26.523015 initrd-setup-root[850]: cut: /sysroot/etc/shadow: No such file or directory Apr 17 23:25:26.528052 initrd-setup-root[857]: cut: /sysroot/etc/gshadow: No such file or directory Apr 17 23:25:26.606549 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 17 23:25:26.619736 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 17 23:25:26.621971 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 17 23:25:26.629263 kernel: BTRFS info (device vda6): last unmount of filesystem a5a0fe13-59ac-4c21-ab23-7fd1bfa02f60 Apr 17 23:25:26.665063 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 17 23:25:26.675560 ignition[925]: INFO : Ignition 2.19.0 Apr 17 23:25:26.675560 ignition[925]: INFO : Stage: mount Apr 17 23:25:26.679246 ignition[925]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:26.679246 ignition[925]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:26.679246 ignition[925]: INFO : mount: mount passed Apr 17 23:25:26.679246 ignition[925]: INFO : Ignition finished successfully Apr 17 23:25:26.701611 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 17 23:25:26.710600 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 17 23:25:27.038009 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 17 23:25:27.050459 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 17 23:25:27.059266 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (937) Apr 17 23:25:27.062382 kernel: BTRFS info (device vda6): first mount of filesystem a5a0fe13-59ac-4c21-ab23-7fd1bfa02f60 Apr 17 23:25:27.062464 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 17 23:25:27.062479 kernel: BTRFS info (device vda6): using free space tree Apr 17 23:25:27.067248 kernel: BTRFS info (device vda6): auto enabling async discard Apr 17 23:25:27.068860 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 17 23:25:27.103380 ignition[954]: INFO : Ignition 2.19.0 Apr 17 23:25:27.103380 ignition[954]: INFO : Stage: files Apr 17 23:25:27.103380 ignition[954]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:27.103380 ignition[954]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:27.109072 ignition[954]: DEBUG : files: compiled without relabeling support, skipping Apr 17 23:25:27.109072 ignition[954]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 17 23:25:27.109072 ignition[954]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 17 23:25:27.109072 ignition[954]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 17 23:25:27.109072 ignition[954]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 17 23:25:27.118405 ignition[954]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Apr 17 23:25:27.118405 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.35.1-x86-64.raw: attempt #1 Apr 17 23:25:27.109132 unknown[954]: wrote ssh authorized keys file for user: core Apr 17 23:25:27.244012 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Apr 17 23:25:27.639865 ignition[954]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Apr 17 23:25:27.639865 ignition[954]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Apr 17 23:25:27.646635 ignition[954]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 17 23:25:27.646635 ignition[954]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 17 23:25:27.646635 ignition[954]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Apr 17 23:25:27.646635 ignition[954]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Apr 17 23:25:27.667920 ignition[954]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Apr 17 23:25:27.671474 ignition[954]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Apr 17 23:25:27.674334 ignition[954]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Apr 17 23:25:27.674334 ignition[954]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 17 23:25:27.674334 ignition[954]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 17 23:25:27.674334 ignition[954]: INFO : files: files passed Apr 17 23:25:27.674334 ignition[954]: INFO : Ignition finished successfully Apr 17 23:25:27.680628 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 17 23:25:27.696606 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 17 23:25:27.700668 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 17 23:25:27.701834 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 17 23:25:27.701916 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 17 23:25:27.715485 initrd-setup-root-after-ignition[982]: grep: /sysroot/oem/oem-release: No such file or directory Apr 17 23:25:27.720105 initrd-setup-root-after-ignition[985]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 17 23:25:27.720105 initrd-setup-root-after-ignition[985]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 17 23:25:27.728127 initrd-setup-root-after-ignition[989]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 17 23:25:27.722356 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 17 23:25:27.725967 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 17 23:25:27.751739 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 17 23:25:27.775060 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 17 23:25:27.775239 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 17 23:25:27.778248 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 17 23:25:27.781892 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 17 23:25:27.786423 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 17 23:25:27.787294 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 17 23:25:27.806914 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 17 23:25:27.809125 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 17 23:25:27.822853 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 17 23:25:27.823632 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 17 23:25:27.827330 systemd[1]: Stopped target timers.target - Timer Units. Apr 17 23:25:27.830795 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 17 23:25:27.830906 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 17 23:25:27.835409 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 17 23:25:27.838629 systemd[1]: Stopped target basic.target - Basic System. Apr 17 23:25:27.841739 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 17 23:25:27.842780 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 17 23:25:27.847565 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 17 23:25:27.850548 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 17 23:25:27.854992 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 17 23:25:27.859006 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 17 23:25:27.859829 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 17 23:25:27.862873 systemd[1]: Stopped target swap.target - Swaps. Apr 17 23:25:27.866020 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 17 23:25:27.866183 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 17 23:25:27.870744 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 17 23:25:27.873333 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 17 23:25:27.873999 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 17 23:25:27.879957 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 17 23:25:27.885107 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 17 23:25:27.885348 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 17 23:25:27.891014 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 17 23:25:27.891243 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 17 23:25:27.894450 systemd[1]: Stopped target paths.target - Path Units. Apr 17 23:25:27.895111 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 17 23:25:27.902470 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 17 23:25:27.903252 systemd[1]: Stopped target slices.target - Slice Units. Apr 17 23:25:27.908829 systemd[1]: Stopped target sockets.target - Socket Units. Apr 17 23:25:27.912197 systemd[1]: iscsid.socket: Deactivated successfully. Apr 17 23:25:27.912317 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 17 23:25:27.920460 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 17 23:25:27.920573 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 17 23:25:27.924288 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 17 23:25:27.924431 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 17 23:25:27.928564 systemd[1]: ignition-files.service: Deactivated successfully. Apr 17 23:25:27.928762 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 17 23:25:27.945453 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 17 23:25:27.946191 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 17 23:25:27.946324 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 17 23:25:27.950479 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 17 23:25:27.953615 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 17 23:25:27.953745 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 17 23:25:27.964399 ignition[1009]: INFO : Ignition 2.19.0 Apr 17 23:25:27.964399 ignition[1009]: INFO : Stage: umount Apr 17 23:25:27.964399 ignition[1009]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 17 23:25:27.964399 ignition[1009]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 17 23:25:27.964399 ignition[1009]: INFO : umount: umount passed Apr 17 23:25:27.964399 ignition[1009]: INFO : Ignition finished successfully Apr 17 23:25:27.957892 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 17 23:25:27.957983 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 17 23:25:27.964750 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 17 23:25:27.964834 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 17 23:25:27.967851 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 17 23:25:27.967924 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 17 23:25:27.971055 systemd[1]: Stopped target network.target - Network. Apr 17 23:25:27.973052 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 17 23:25:27.973105 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 17 23:25:27.976008 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 17 23:25:27.976047 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 17 23:25:27.978871 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 17 23:25:27.978929 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 17 23:25:27.984294 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 17 23:25:27.984348 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 17 23:25:27.985305 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 17 23:25:27.989294 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 17 23:25:27.993411 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 17 23:25:27.995313 systemd-networkd[782]: eth0: DHCPv6 lease lost Apr 17 23:25:27.999703 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 17 23:25:28.000104 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 17 23:25:28.004113 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 17 23:25:28.004375 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 17 23:25:28.008121 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 17 23:25:28.008170 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 17 23:25:28.018409 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 17 23:25:28.019982 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 17 23:25:28.020040 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 17 23:25:28.020781 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 17 23:25:28.020812 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 17 23:25:28.030237 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 17 23:25:28.030295 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 17 23:25:28.031971 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 17 23:25:28.032003 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 17 23:25:28.034716 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 17 23:25:28.038868 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 17 23:25:28.038947 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 17 23:25:28.040477 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 17 23:25:28.040569 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 17 23:25:28.050992 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 17 23:25:28.051091 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 17 23:25:28.057762 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 17 23:25:28.057897 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 17 23:25:28.060402 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 17 23:25:28.060641 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 17 23:25:28.064642 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 17 23:25:28.064683 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 17 23:25:28.069620 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 17 23:25:28.069685 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 17 23:25:28.075461 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 17 23:25:28.075536 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 17 23:25:28.080582 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 17 23:25:28.080637 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 17 23:25:28.106504 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 17 23:25:28.107928 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 17 23:25:28.107992 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 17 23:25:28.111958 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 17 23:25:28.111993 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 17 23:25:28.117168 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 17 23:25:28.117343 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 17 23:25:28.121445 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 17 23:25:28.126443 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 17 23:25:28.141888 systemd[1]: Switching root. Apr 17 23:25:28.177481 systemd-journald[194]: Journal stopped Apr 17 23:25:28.893713 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). Apr 17 23:25:28.893763 kernel: SELinux: policy capability network_peer_controls=1 Apr 17 23:25:28.893777 kernel: SELinux: policy capability open_perms=1 Apr 17 23:25:28.893784 kernel: SELinux: policy capability extended_socket_class=1 Apr 17 23:25:28.893792 kernel: SELinux: policy capability always_check_network=0 Apr 17 23:25:28.893801 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 17 23:25:28.893808 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 17 23:25:28.893819 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 17 23:25:28.893827 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 17 23:25:28.893837 kernel: audit: type=1403 audit(1776468328.284:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 17 23:25:28.893848 systemd[1]: Successfully loaded SELinux policy in 35.117ms. Apr 17 23:25:28.893864 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.662ms. Apr 17 23:25:28.893873 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 17 23:25:28.893881 systemd[1]: Detected virtualization kvm. Apr 17 23:25:28.893891 systemd[1]: Detected architecture x86-64. Apr 17 23:25:28.893898 systemd[1]: Detected first boot. Apr 17 23:25:28.893906 systemd[1]: Initializing machine ID from VM UUID. Apr 17 23:25:28.893915 zram_generator::config[1054]: No configuration found. Apr 17 23:25:28.893925 systemd[1]: Populated /etc with preset unit settings. Apr 17 23:25:28.893934 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 17 23:25:28.893943 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 17 23:25:28.893951 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 17 23:25:28.893959 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 17 23:25:28.893968 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 17 23:25:28.893976 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 17 23:25:28.893983 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 17 23:25:28.893992 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 17 23:25:28.894001 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 17 23:25:28.894010 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 17 23:25:28.894018 systemd[1]: Created slice user.slice - User and Session Slice. Apr 17 23:25:28.894026 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 17 23:25:28.894034 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 17 23:25:28.894042 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 17 23:25:28.894051 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 17 23:25:28.894059 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 17 23:25:28.894066 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 17 23:25:28.894075 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 17 23:25:28.894083 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 17 23:25:28.894091 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 17 23:25:28.894099 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 17 23:25:28.894107 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 17 23:25:28.894115 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 17 23:25:28.894123 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 17 23:25:28.894131 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 17 23:25:28.894140 systemd[1]: Reached target slices.target - Slice Units. Apr 17 23:25:28.894148 systemd[1]: Reached target swap.target - Swaps. Apr 17 23:25:28.894156 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 17 23:25:28.894164 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 17 23:25:28.894172 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 17 23:25:28.894179 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 17 23:25:28.894187 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 17 23:25:28.894195 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 17 23:25:28.894274 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 17 23:25:28.894286 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 17 23:25:28.894293 systemd[1]: Mounting media.mount - External Media Directory... Apr 17 23:25:28.894302 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 17 23:25:28.894310 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 17 23:25:28.894318 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 17 23:25:28.894326 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 17 23:25:28.894336 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). Apr 17 23:25:28.894344 systemd[1]: Reached target machines.target - Containers. Apr 17 23:25:28.894353 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 17 23:25:28.894361 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 17 23:25:28.894370 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 17 23:25:28.894378 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 17 23:25:28.894386 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 17 23:25:28.894394 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 17 23:25:28.894402 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 17 23:25:28.894409 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 17 23:25:28.894417 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 17 23:25:28.894427 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 17 23:25:28.894435 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 17 23:25:28.894443 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 17 23:25:28.894451 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 17 23:25:28.894459 systemd[1]: Stopped systemd-fsck-usr.service. Apr 17 23:25:28.894466 kernel: fuse: init (API version 7.39) Apr 17 23:25:28.894473 kernel: loop: module loaded Apr 17 23:25:28.894481 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 17 23:25:28.894489 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 17 23:25:28.894498 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 17 23:25:28.894539 systemd-journald[1131]: Collecting audit messages is disabled. Apr 17 23:25:28.894559 kernel: ACPI: bus type drm_connector registered Apr 17 23:25:28.894567 systemd-journald[1131]: Journal started Apr 17 23:25:28.894584 systemd-journald[1131]: Runtime Journal (/run/log/journal/1a5d381235184e639c19ab864458336f) is 6.0M, max 48.4M, 42.3M free. Apr 17 23:25:28.641198 systemd[1]: Queued start job for default target multi-user.target. Apr 17 23:25:28.659988 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Apr 17 23:25:28.660440 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 17 23:25:28.897489 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 17 23:25:28.901337 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 17 23:25:28.905189 systemd[1]: verity-setup.service: Deactivated successfully. Apr 17 23:25:28.905285 systemd[1]: Stopped verity-setup.service. Apr 17 23:25:28.909257 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 17 23:25:28.912237 systemd[1]: Started systemd-journald.service - Journal Service. Apr 17 23:25:28.913366 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 17 23:25:28.914893 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 17 23:25:28.916445 systemd[1]: Mounted media.mount - External Media Directory. Apr 17 23:25:28.917852 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 17 23:25:28.919381 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 17 23:25:28.920978 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 17 23:25:28.922454 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 17 23:25:28.924252 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 17 23:25:28.926192 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 17 23:25:28.926361 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 17 23:25:28.928274 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 17 23:25:28.928384 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 17 23:25:28.930275 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 17 23:25:28.930367 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 17 23:25:28.932100 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 17 23:25:28.932371 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 17 23:25:28.934625 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 17 23:25:28.934738 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 17 23:25:28.936392 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 17 23:25:28.936503 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 17 23:25:28.938191 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 17 23:25:28.939999 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 17 23:25:28.941937 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 17 23:25:28.949035 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 17 23:25:28.955439 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 17 23:25:28.966437 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 17 23:25:28.970396 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 17 23:25:28.972014 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 17 23:25:28.972052 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 17 23:25:28.974129 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 17 23:25:28.976645 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 17 23:25:28.979066 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 17 23:25:28.979841 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 17 23:25:28.981305 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 17 23:25:28.983782 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 17 23:25:28.985590 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 17 23:25:28.986342 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 17 23:25:28.987197 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 17 23:25:28.990324 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 17 23:25:28.994834 systemd-journald[1131]: Time spent on flushing to /var/log/journal/1a5d381235184e639c19ab864458336f is 17.582ms for 934 entries. Apr 17 23:25:28.994834 systemd-journald[1131]: System Journal (/var/log/journal/1a5d381235184e639c19ab864458336f) is 8.0M, max 195.6M, 187.6M free. Apr 17 23:25:29.017546 systemd-journald[1131]: Received client request to flush runtime journal. Apr 17 23:25:29.017574 kernel: loop0: detected capacity change from 0 to 217752 Apr 17 23:25:28.995641 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 17 23:25:28.999706 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 17 23:25:29.004963 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 17 23:25:29.011848 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 17 23:25:29.014297 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 17 23:25:29.016488 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 17 23:25:29.022962 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 17 23:25:29.025585 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 17 23:25:29.027786 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 17 23:25:29.035633 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 17 23:25:29.042336 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 17 23:25:29.048027 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 17 23:25:29.051080 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 17 23:25:29.060423 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 17 23:25:29.063029 udevadm[1172]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Apr 17 23:25:29.069271 kernel: loop1: detected capacity change from 0 to 140768 Apr 17 23:25:29.073369 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 17 23:25:29.074729 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 17 23:25:29.086951 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Apr 17 23:25:29.086971 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Apr 17 23:25:29.093562 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 17 23:25:29.110360 kernel: loop2: detected capacity change from 0 to 142488 Apr 17 23:25:29.149253 kernel: loop3: detected capacity change from 0 to 217752 Apr 17 23:25:29.158253 kernel: loop4: detected capacity change from 0 to 140768 Apr 17 23:25:29.172266 kernel: loop5: detected capacity change from 0 to 142488 Apr 17 23:25:29.186297 (sd-merge)[1192]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Apr 17 23:25:29.186651 (sd-merge)[1192]: Merged extensions into '/usr'. Apr 17 23:25:29.190384 systemd[1]: Reloading requested from client PID 1169 ('systemd-sysext') (unit systemd-sysext.service)... Apr 17 23:25:29.190562 systemd[1]: Reloading... Apr 17 23:25:29.234258 zram_generator::config[1215]: No configuration found. Apr 17 23:25:29.292969 ldconfig[1164]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 17 23:25:29.330735 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 17 23:25:29.366435 systemd[1]: Reloading finished in 175 ms. Apr 17 23:25:29.402382 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 17 23:25:29.404494 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 17 23:25:29.407172 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 17 23:25:29.422782 systemd[1]: Starting ensure-sysext.service... Apr 17 23:25:29.425473 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 17 23:25:29.428838 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 17 23:25:29.432800 systemd[1]: Reloading requested from client PID 1256 ('systemctl') (unit ensure-sysext.service)... Apr 17 23:25:29.432812 systemd[1]: Reloading... Apr 17 23:25:29.440424 systemd-tmpfiles[1259]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 17 23:25:29.440667 systemd-tmpfiles[1259]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 17 23:25:29.441293 systemd-tmpfiles[1259]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 17 23:25:29.441460 systemd-tmpfiles[1259]: ACLs are not supported, ignoring. Apr 17 23:25:29.441511 systemd-tmpfiles[1259]: ACLs are not supported, ignoring. Apr 17 23:25:29.443543 systemd-tmpfiles[1259]: Detected autofs mount point /boot during canonicalization of boot. Apr 17 23:25:29.443554 systemd-tmpfiles[1259]: Skipping /boot Apr 17 23:25:29.449139 systemd-tmpfiles[1259]: Detected autofs mount point /boot during canonicalization of boot. Apr 17 23:25:29.449170 systemd-tmpfiles[1259]: Skipping /boot Apr 17 23:25:29.449369 systemd-udevd[1260]: Using default interface naming scheme 'v255'. Apr 17 23:25:29.479345 zram_generator::config[1286]: No configuration found. Apr 17 23:25:29.517256 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1294) Apr 17 23:25:29.552497 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Apr 17 23:25:29.569302 kernel: ACPI: button: Power Button [PWRF] Apr 17 23:25:29.571944 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Apr 17 23:25:29.572134 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Apr 17 23:25:29.572275 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Apr 17 23:25:29.579349 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Apr 17 23:25:29.589898 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 17 23:25:29.637874 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 17 23:25:29.640380 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 17 23:25:29.640696 systemd[1]: Reloading finished in 207 ms. Apr 17 23:25:29.675227 kernel: mousedev: PS/2 mouse device common for all mice Apr 17 23:25:29.685479 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 17 23:25:29.688659 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 17 23:25:29.731964 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 17 23:25:29.740723 systemd[1]: Finished ensure-sysext.service. Apr 17 23:25:29.753162 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 17 23:25:29.763988 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Apr 17 23:25:29.767619 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 17 23:25:29.769444 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 17 23:25:29.770666 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 17 23:25:29.774886 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 17 23:25:29.777566 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 17 23:25:29.785317 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 17 23:25:29.785445 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 17 23:25:29.789373 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 17 23:25:29.793695 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 17 23:25:29.797729 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 17 23:25:29.800566 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 17 23:25:29.808424 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 17 23:25:29.810425 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 17 23:25:29.813065 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 17 23:25:29.816383 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 17 23:25:29.819547 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 17 23:25:29.821007 augenrules[1382]: No rules Apr 17 23:25:29.821456 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 17 23:25:29.822083 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Apr 17 23:25:29.824138 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 17 23:25:29.826476 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 17 23:25:29.826619 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 17 23:25:29.828717 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 17 23:25:29.828937 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 17 23:25:29.830899 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 17 23:25:29.830987 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 17 23:25:29.833364 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 17 23:25:29.833731 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 17 23:25:29.835959 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 17 23:25:29.839952 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 17 23:25:29.844554 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 17 23:25:29.845545 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 17 23:25:29.854414 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 17 23:25:29.855000 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 17 23:25:29.855042 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 17 23:25:29.855914 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 17 23:25:29.857563 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 17 23:25:29.858397 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 17 23:25:29.859023 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). Apr 17 23:25:29.865286 lvm[1401]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 17 23:25:29.866853 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 17 23:25:29.886884 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 17 23:25:29.932185 systemd-networkd[1378]: lo: Link UP Apr 17 23:25:29.932457 systemd-networkd[1378]: lo: Gained carrier Apr 17 23:25:29.933356 systemd-networkd[1378]: Enumeration completed Apr 17 23:25:29.933867 systemd-networkd[1378]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 17 23:25:29.933930 systemd-networkd[1378]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 17 23:25:29.934600 systemd-networkd[1378]: eth0: Link UP Apr 17 23:25:29.934655 systemd-networkd[1378]: eth0: Gained carrier Apr 17 23:25:29.934666 systemd-networkd[1378]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 17 23:25:29.935051 systemd-resolved[1381]: Positive Trust Anchors: Apr 17 23:25:29.935077 systemd-resolved[1381]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 17 23:25:29.935114 systemd-resolved[1381]: 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 Apr 17 23:25:29.937966 systemd-resolved[1381]: Defaulting to hostname 'linux'. Apr 17 23:25:29.950270 systemd-networkd[1378]: eth0: DHCPv4 address 10.0.0.9/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 17 23:25:29.950918 systemd-timesyncd[1383]: Network configuration changed, trying to establish connection. Apr 17 23:25:30.632630 systemd-resolved[1381]: Clock change detected. Flushing caches. Apr 17 23:25:30.632652 systemd-timesyncd[1383]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 17 23:25:30.632682 systemd-timesyncd[1383]: Initial clock synchronization to Fri 2026-04-17 23:25:30.632581 UTC. Apr 17 23:25:30.637959 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 17 23:25:30.639624 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 17 23:25:30.641332 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 17 23:25:30.643143 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 17 23:25:30.644994 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 17 23:25:30.647781 systemd[1]: Reached target network.target - Network. Apr 17 23:25:30.649361 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 17 23:25:30.650998 systemd[1]: Reached target sysinit.target - System Initialization. Apr 17 23:25:30.653009 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 17 23:25:30.654762 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 17 23:25:30.656548 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 17 23:25:30.658558 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 17 23:25:30.658592 systemd[1]: Reached target paths.target - Path Units. Apr 17 23:25:30.660116 systemd[1]: Reached target time-set.target - System Time Set. Apr 17 23:25:30.661964 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 17 23:25:30.664074 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 17 23:25:30.666328 systemd[1]: Reached target timers.target - Timer Units. Apr 17 23:25:30.668532 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 17 23:25:30.671654 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 17 23:25:30.681917 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 17 23:25:30.685956 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 17 23:25:30.688422 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 17 23:25:30.690438 systemd[1]: Reached target sockets.target - Socket Units. Apr 17 23:25:30.692228 systemd[1]: Reached target basic.target - Basic System. Apr 17 23:25:30.693704 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 17 23:25:30.693741 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 17 23:25:30.694538 systemd[1]: Starting containerd.service - containerd container runtime... Apr 17 23:25:30.697054 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 17 23:25:30.699022 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 17 23:25:30.703446 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 17 23:25:30.705448 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). Apr 17 23:25:30.706371 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 17 23:25:30.709349 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 17 23:25:30.711096 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 17 23:25:30.714546 jq[1424]: false Apr 17 23:25:30.715517 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 17 23:25:30.720244 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 17 23:25:30.720539 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 17 23:25:30.722517 systemd[1]: Starting update-engine.service - Update Engine... Apr 17 23:25:30.727278 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 17 23:25:30.730604 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 17 23:25:30.730002 dbus-daemon[1423]: [system] SELinux support is enabled Apr 17 23:25:30.732921 jq[1437]: true Apr 17 23:25:30.734306 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 17 23:25:30.738974 update_engine[1436]: I20260417 23:25:30.737083 1436 main.cc:92] Flatcar Update Engine starting Apr 17 23:25:30.738974 update_engine[1436]: I20260417 23:25:30.738068 1436 update_check_scheduler.cc:74] Next update check in 2m24s Apr 17 23:25:30.740390 extend-filesystems[1425]: Found loop3 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found loop4 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found loop5 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found sr0 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda1 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda2 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda3 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found usr Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda4 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda6 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda7 Apr 17 23:25:30.740390 extend-filesystems[1425]: Found vda9 Apr 17 23:25:30.740390 extend-filesystems[1425]: Checking size of /dev/vda9 Apr 17 23:25:30.734440 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 17 23:25:30.772149 extend-filesystems[1425]: Resized partition /dev/vda9 Apr 17 23:25:30.734653 systemd[1]: motdgen.service: Deactivated successfully. Apr 17 23:25:30.774551 extend-filesystems[1466]: resize2fs 1.47.1 (20-May-2024) Apr 17 23:25:30.781671 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Apr 17 23:25:30.781691 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1307) Apr 17 23:25:30.734752 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 17 23:25:30.781759 jq[1442]: true Apr 17 23:25:30.736537 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 17 23:25:30.736707 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 17 23:25:30.747971 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). Apr 17 23:25:30.747994 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 17 23:25:30.750677 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). Apr 17 23:25:30.750698 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 17 23:25:30.755473 systemd[1]: Started update-engine.service - Update Engine. Apr 17 23:25:30.755727 (ntainerd)[1446]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 17 23:25:30.762601 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 17 23:25:30.776809 systemd-logind[1430]: Watching system buttons on /dev/input/event1 (Power Button) Apr 17 23:25:30.776825 systemd-logind[1430]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Apr 17 23:25:30.781656 systemd-logind[1430]: New seat seat0. Apr 17 23:25:30.791204 systemd[1]: Started systemd-logind.service - User Login Management. Apr 17 23:25:30.830401 locksmithd[1457]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 17 23:25:30.836220 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Apr 17 23:25:30.848623 extend-filesystems[1466]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Apr 17 23:25:30.848623 extend-filesystems[1466]: old_desc_blocks = 1, new_desc_blocks = 1 Apr 17 23:25:30.848623 extend-filesystems[1466]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Apr 17 23:25:30.856560 extend-filesystems[1425]: Resized filesystem in /dev/vda9 Apr 17 23:25:30.860105 bash[1469]: Updated "/home/core/.ssh/authorized_keys" Apr 17 23:25:30.850095 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 17 23:25:30.852224 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 17 23:25:30.857335 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 17 23:25:30.861893 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 17 23:25:30.934779 containerd[1446]: time="2026-04-17T23:25:30.934638273Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Apr 17 23:25:30.952879 containerd[1446]: time="2026-04-17T23:25:30.952795492Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.954742 containerd[1446]: time="2026-04-17T23:25:30.954656665Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.127-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 17 23:25:30.954742 containerd[1446]: time="2026-04-17T23:25:30.954727022Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 17 23:25:30.954742 containerd[1446]: time="2026-04-17T23:25:30.954740524Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 17 23:25:30.954881 containerd[1446]: time="2026-04-17T23:25:30.954863425Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 17 23:25:30.954897 containerd[1446]: time="2026-04-17T23:25:30.954885410Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.954942 containerd[1446]: time="2026-04-17T23:25:30.954924121Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 17 23:25:30.954958 containerd[1446]: time="2026-04-17T23:25:30.954942319Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955098 containerd[1446]: time="2026-04-17T23:25:30.955068993Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955098 containerd[1446]: time="2026-04-17T23:25:30.955091585Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955127 containerd[1446]: time="2026-04-17T23:25:30.955101643Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955127 containerd[1446]: time="2026-04-17T23:25:30.955109126Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955199 containerd[1446]: time="2026-04-17T23:25:30.955156228Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955367 containerd[1446]: time="2026-04-17T23:25:30.955339012Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955469 containerd[1446]: time="2026-04-17T23:25:30.955450832Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 17 23:25:30.955508 containerd[1446]: time="2026-04-17T23:25:30.955469397Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 17 23:25:30.955578 containerd[1446]: time="2026-04-17T23:25:30.955561114Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 17 23:25:30.955619 containerd[1446]: time="2026-04-17T23:25:30.955604434Z" level=info msg="metadata content store policy set" policy=shared Apr 17 23:25:30.961850 containerd[1446]: time="2026-04-17T23:25:30.961623840Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 17 23:25:30.961850 containerd[1446]: time="2026-04-17T23:25:30.961817927Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 17 23:25:30.961850 containerd[1446]: time="2026-04-17T23:25:30.961831780Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 17 23:25:30.961850 containerd[1446]: time="2026-04-17T23:25:30.961843262Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 17 23:25:30.961850 containerd[1446]: time="2026-04-17T23:25:30.961854639Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 17 23:25:30.962075 containerd[1446]: time="2026-04-17T23:25:30.962012194Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 17 23:25:30.962372 containerd[1446]: time="2026-04-17T23:25:30.962320412Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 17 23:25:30.962471 containerd[1446]: time="2026-04-17T23:25:30.962449777Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 17 23:25:30.962515 containerd[1446]: time="2026-04-17T23:25:30.962480690Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 17 23:25:30.962536 containerd[1446]: time="2026-04-17T23:25:30.962511514Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 17 23:25:30.962536 containerd[1446]: time="2026-04-17T23:25:30.962523368Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962565 containerd[1446]: time="2026-04-17T23:25:30.962536187Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962565 containerd[1446]: time="2026-04-17T23:25:30.962545580Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962565 containerd[1446]: time="2026-04-17T23:25:30.962555555Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962614 containerd[1446]: time="2026-04-17T23:25:30.962566288Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962614 containerd[1446]: time="2026-04-17T23:25:30.962576286Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962614 containerd[1446]: time="2026-04-17T23:25:30.962585096Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962614 containerd[1446]: time="2026-04-17T23:25:30.962593836Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 17 23:25:30.962614 containerd[1446]: time="2026-04-17T23:25:30.962609187Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962618744Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962628201Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962636903Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962645785Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962654556Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962663174Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962671974Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962681789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962692077Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962704347Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962719 containerd[1446]: time="2026-04-17T23:25:30.962718406Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962732237Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962750800Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962774083Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962796387Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962815299Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962866493Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962880331Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962889195Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962897856Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962904769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962913050Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 17 23:25:30.962922 containerd[1446]: time="2026-04-17T23:25:30.962919993Z" level=info msg="NRI interface is disabled by configuration." Apr 17 23:25:30.963142 containerd[1446]: time="2026-04-17T23:25:30.962926947Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 17 23:25:30.963265 containerd[1446]: time="2026-04-17T23:25:30.963209567Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Apr 17 23:25:30.963265 containerd[1446]: time="2026-04-17T23:25:30.963258965Z" level=info msg="Connect containerd service" Apr 17 23:25:30.963516 containerd[1446]: time="2026-04-17T23:25:30.963287234Z" level=info msg="using legacy CRI server" Apr 17 23:25:30.963516 containerd[1446]: time="2026-04-17T23:25:30.963292590Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 17 23:25:30.963516 containerd[1446]: time="2026-04-17T23:25:30.963439315Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 17 23:25:30.964096 containerd[1446]: time="2026-04-17T23:25:30.964058082Z" 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" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964266149Z" level=info msg="Start subscribing containerd event" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964334363Z" level=info msg="Start recovering state" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964389434Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964393604Z" level=info msg="Start event monitor" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964657764Z" level=info msg="Start snapshots syncer" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964674326Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964678412Z" level=info msg="Start cni network conf syncer for default" Apr 17 23:25:30.964726 containerd[1446]: time="2026-04-17T23:25:30.964696064Z" level=info msg="Start streaming server" Apr 17 23:25:30.965285 containerd[1446]: time="2026-04-17T23:25:30.964754597Z" level=info msg="containerd successfully booted in 0.032156s" Apr 17 23:25:30.964869 systemd[1]: Started containerd.service - containerd container runtime. Apr 17 23:25:31.092399 sshd_keygen[1447]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 17 23:25:31.113213 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 17 23:25:31.131115 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 17 23:25:31.138100 systemd[1]: issuegen.service: Deactivated successfully. Apr 17 23:25:31.138311 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 17 23:25:31.142244 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 17 23:25:31.158555 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 17 23:25:31.161726 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 17 23:25:31.164114 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 17 23:25:31.166015 systemd[1]: Reached target getty.target - Login Prompts. Apr 17 23:25:32.196266 systemd-networkd[1378]: eth0: Gained IPv6LL Apr 17 23:25:32.198874 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 17 23:25:32.201453 systemd[1]: Reached target network-online.target - Network is Online. Apr 17 23:25:32.216590 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 17 23:25:32.219581 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 17 23:25:32.222084 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 17 23:25:32.236412 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 17 23:25:32.236680 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 17 23:25:32.239296 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 17 23:25:32.242345 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 17 23:25:32.915935 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 17 23:25:32.917961 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 17 23:25:32.919475 (kubelet)[1527]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 17 23:25:32.923236 systemd[1]: Startup finished in 891ms (kernel) + 4.609s (initrd) + 3.990s (userspace) = 9.491s. Apr 17 23:25:33.312779 kubelet[1527]: E0417 23:25:33.312525 1527 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" Apr 17 23:25:33.317695 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 17 23:25:33.317827 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 17 23:25:36.983473 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 17 23:25:36.985660 systemd[1]: Started sshd@0-10.0.0.9:22-10.0.0.1:55114.service - OpenSSH per-connection server daemon (10.0.0.1:55114). Apr 17 23:25:37.032597 sshd[1540]: Accepted publickey for core from 10.0.0.1 port 55114 ssh2: RSA SHA256:E6pky6dhKlUTTc8PKl7cFvWht1oyD+LPE0dplBcc100 Apr 17 23:25:37.034357 sshd[1540]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 17 23:25:37.041515 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 17 23:25:37.054581 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 17 23:25:37.056131 systemd-logind[1430]: New session 1 of user core. Apr 17 23:25:37.068382 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 17 23:25:37.081515 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 17 23:25:37.083934 (systemd)[1544]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 17 23:25:37.152338 systemd[1544]: Queued start job for default target default.target. Apr 17 23:25:37.162360 systemd[1544]: Created slice app.slice - User Application Slice. Apr 17 23:25:37.162394 systemd[1544]: Reached target paths.target - Paths. Apr 17 23:25:37.162403 systemd[1544]: Reached target timers.target - Timers. Apr 17 23:25:37.163564 systemd[1544]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 17 23:25:37.178914 systemd[1544]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 17 23:25:37.179026 systemd[1544]: Reached target sockets.target - Sockets. Apr 17 23:25:37.179037 systemd[1544]: Reached target basic.target - Basic System. Apr 17 23:25:37.179064 systemd[1544]: Reached target default.target - Main User Target. Apr 17 23:25:37.179085 systemd[1544]: Startup finished in 89ms. Apr 17 23:25:37.179633 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 17 23:25:37.180938 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 17 23:25:37.255782 systemd[1]: Started sshd@1-10.0.0.9:22-10.0.0.1:55116.service - OpenSSH per-connection server daemon (10.0.0.1:55116). Apr 17 23:25:37.299916 sshd[1555]: Accepted publickey for core from 10.0.0.1 port 55116 ssh2: RSA SHA256:E6pky6dhKlUTTc8PKl7cFvWht1oyD+LPE0dplBcc100 Apr 17 23:25:37.302473 sshd[1555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 17 23:25:37.307678 systemd-logind[1430]: New session 2 of user core. Apr 17 23:25:37.317360 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 17 23:25:37.375264 sshd[1555]: pam_unix(sshd:session): session closed for user core Apr 17 23:25:37.389947 systemd[1]: sshd@1-10.0.0.9:22-10.0.0.1:55116.service: Deactivated successfully. Apr 17 23:25:37.390998 systemd[1]: session-2.scope: Deactivated successfully. Apr 17 23:25:37.392383 systemd-logind[1430]: Session 2 logged out. Waiting for processes to exit. Apr 17 23:25:37.393302 systemd[1]: Started sshd@2-10.0.0.9:22-10.0.0.1:55126.service - OpenSSH per-connection server daemon (10.0.0.1:55126). Apr 17 23:25:37.394035 systemd-logind[1430]: Removed session 2. Apr 17 23:25:37.428556 sshd[1562]: Accepted publickey for core from 10.0.0.1 port 55126 ssh2: RSA SHA256:E6pky6dhKlUTTc8PKl7cFvWht1oyD+LPE0dplBcc100 Apr 17 23:25:37.430668 sshd[1562]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 17 23:25:37.436227 systemd-logind[1430]: New session 3 of user core. Apr 17 23:25:37.453252 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 17 23:25:37.503620 sshd[1562]: pam_unix(sshd:session): session closed for user core Apr 17 23:25:37.515757 systemd[1]: sshd@2-10.0.0.9:22-10.0.0.1:55126.service: Deactivated successfully. Apr 17 23:25:37.516948 systemd[1]: session-3.scope: Deactivated successfully. Apr 17 23:25:37.517909 systemd-logind[1430]: Session 3 logged out. Waiting for processes to exit. Apr 17 23:25:37.518870 systemd[1]: Started sshd@3-10.0.0.9:22-10.0.0.1:55136.service - OpenSSH per-connection server daemon (10.0.0.1:55136). Apr 17 23:25:37.519447 systemd-logind[1430]: Removed session 3. Apr 17 23:25:37.550135 sshd[1569]: Accepted publickey for core from 10.0.0.1 port 55136 ssh2: RSA SHA256:E6pky6dhKlUTTc8PKl7cFvWht1oyD+LPE0dplBcc100 Apr 17 23:25:37.551333 sshd[1569]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 17 23:25:37.554865 systemd-logind[1430]: New session 4 of user core. Apr 17 23:25:37.566906 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 17 23:25:37.626085 sshd[1569]: pam_unix(sshd:session): session closed for user core Apr 17 23:25:37.641011 systemd[1]: sshd@3-10.0.0.9:22-10.0.0.1:55136.service: Deactivated successfully. Apr 17 23:25:37.642235 systemd[1]: session-4.scope: Deactivated successfully. Apr 17 23:25:37.643199 systemd-logind[1430]: Session 4 logged out. Waiting for processes to exit. Apr 17 23:25:37.644137 systemd[1]: Started sshd@4-10.0.0.9:22-10.0.0.1:55140.service - OpenSSH per-connection server daemon (10.0.0.1:55140). Apr 17 23:25:37.644773 systemd-logind[1430]: Removed session 4. Apr 17 23:25:37.681731 sshd[1576]: Accepted publickey for core from 10.0.0.1 port 55140 ssh2: RSA SHA256:E6pky6dhKlUTTc8PKl7cFvWht1oyD+LPE0dplBcc100 Apr 17 23:25:37.682852 sshd[1576]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 17 23:25:37.686744 systemd-logind[1430]: New session 5 of user core. Apr 17 23:25:37.697887 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 17 23:25:37.752925 sudo[1579]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Apr 17 23:25:37.753136 sudo[1579]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 17 23:25:37.777824 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 17 23:25:37.794031 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 17 23:25:37.794289 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 17 23:25:38.309880 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 17 23:25:38.319460 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 17 23:25:38.339848 systemd[1]: Reloading requested from client PID 1629 ('systemctl') (unit session-5.scope)... Apr 17 23:25:38.339870 systemd[1]: Reloading... Apr 17 23:25:38.396219 zram_generator::config[1667]: No configuration found. Apr 17 23:25:38.489485 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 17 23:25:38.537811 systemd[1]: Reloading finished in 197 ms. Apr 17 23:25:38.574826 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Apr 17 23:25:38.577341 systemd[1]: kubelet.service: Deactivated successfully. Apr 17 23:25:38.577510 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 17 23:25:38.578737 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 17 23:25:38.681348 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 17 23:25:38.685137 (kubelet)[1717]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Apr 17 23:25:38.721605 kubelet[1717]: 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. Apr 17 23:25:38.826650 kubelet[1717]: I0417 23:25:38.826493 1717 server.go:525] "Kubelet version" kubeletVersion="v1.35.1" Apr 17 23:25:38.826650 kubelet[1717]: I0417 23:25:38.826562 1717 server.go:527] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Apr 17 23:25:38.826650 kubelet[1717]: I0417 23:25:38.826574 1717 watchdog_linux.go:95] "Systemd watchdog is not enabled" Apr 17 23:25:38.826650 kubelet[1717]: I0417 23:25:38.826578 1717 watchdog_linux.go:138] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Apr 17 23:25:38.826818 kubelet[1717]: I0417 23:25:38.826796 1717 server.go:951] "Client rotation is on, will bootstrap in background" Apr 17 23:25:38.835508 kubelet[1717]: I0417 23:25:38.835466 1717 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Apr 17 23:25:38.838057 kubelet[1717]: E0417 23:25:38.838026 1717 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Apr 17 23:25:38.838144 kubelet[1717]: I0417 23:25:38.838083 1717 server.go:1395] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Apr 17 23:25:38.842365 kubelet[1717]: I0417 23:25:38.842246 1717 server.go:775] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Apr 17 23:25:38.842960 kubelet[1717]: I0417 23:25:38.842918 1717 container_manager_linux.go:272] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Apr 17 23:25:38.843102 kubelet[1717]: I0417 23:25:38.842957 1717 container_manager_linux.go:277] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.9","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":"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},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Apr 17 23:25:38.843203 kubelet[1717]: I0417 23:25:38.843102 1717 topology_manager.go:143] "Creating topology manager with none policy" Apr 17 23:25:38.843203 kubelet[1717]: I0417 23:25:38.843112 1717 container_manager_linux.go:308] "Creating device plugin manager" Apr 17 23:25:38.843244 kubelet[1717]: I0417 23:25:38.843234 1717 container_manager_linux.go:317] "Creating Dynamic Resource Allocation (DRA) manager" Apr 17 23:25:38.895665 kubelet[1717]: I0417 23:25:38.895587 1717 state_mem.go:41] "Initialized" logger="CPUManager state memory" Apr 17 23:25:38.895945 kubelet[1717]: I0417 23:25:38.895915 1717 kubelet.go:482] "Attempting to sync node with API server" Apr 17 23:25:38.896006 kubelet[1717]: I0417 23:25:38.895980 1717 kubelet.go:383] "Adding static pod path" path="/etc/kubernetes/manifests" Apr 17 23:25:38.896025 kubelet[1717]: I0417 23:25:38.896014 1717 kubelet.go:394] "Adding apiserver pod source" Apr 17 23:25:38.896041 kubelet[1717]: I0417 23:25:38.896025 1717 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Apr 17 23:25:38.896507 kubelet[1717]: E0417 23:25:38.896393 1717 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:38.896843 kubelet[1717]: E0417 23:25:38.896796 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:38.898397 kubelet[1717]: I0417 23:25:38.898371 1717 kuberuntime_manager.go:294] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Apr 17 23:25:38.900734 kubelet[1717]: I0417 23:25:38.900670 1717 kubelet.go:943] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Apr 17 23:25:38.900734 kubelet[1717]: I0417 23:25:38.900733 1717 kubelet.go:970] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Apr 17 23:25:38.900904 kubelet[1717]: W0417 23:25:38.900783 1717 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Apr 17 23:25:38.904509 kubelet[1717]: I0417 23:25:38.903560 1717 server.go:1257] "Started kubelet" Apr 17 23:25:38.904509 kubelet[1717]: I0417 23:25:38.904283 1717 server.go:182] "Starting to listen" address="0.0.0.0" port=10250 Apr 17 23:25:38.906005 kubelet[1717]: I0417 23:25:38.905404 1717 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Apr 17 23:25:38.906005 kubelet[1717]: I0417 23:25:38.904250 1717 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Apr 17 23:25:38.906005 kubelet[1717]: I0417 23:25:38.905767 1717 server_v1.go:49] "podresources" method="list" useActivePods=true Apr 17 23:25:38.906005 kubelet[1717]: I0417 23:25:38.905930 1717 server.go:254] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Apr 17 23:25:38.906122 kubelet[1717]: I0417 23:25:38.906097 1717 server.go:317] "Adding debug handlers to kubelet server" Apr 17 23:25:38.912355 kubelet[1717]: I0417 23:25:38.911910 1717 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Apr 17 23:25:38.914976 kubelet[1717]: I0417 23:25:38.913793 1717 volume_manager.go:311] "Starting Kubelet Volume Manager" Apr 17 23:25:38.914976 kubelet[1717]: E0417 23:25:38.914395 1717 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.9\" not found" Apr 17 23:25:38.915883 kubelet[1717]: I0417 23:25:38.915609 1717 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Apr 17 23:25:38.915883 kubelet[1717]: I0417 23:25:38.915720 1717 reconciler.go:29] "Reconciler: start to sync state" Apr 17 23:25:38.916382 kubelet[1717]: E0417 23:25:38.916349 1717 kubelet.go:1656] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Apr 17 23:25:38.916523 kubelet[1717]: I0417 23:25:38.916495 1717 factory.go:223] Registration of the systemd container factory successfully Apr 17 23:25:38.916632 kubelet[1717]: I0417 23:25:38.916598 1717 factory.go:221] 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 Apr 17 23:25:38.918598 kubelet[1717]: I0417 23:25:38.918553 1717 factory.go:223] Registration of the containerd container factory successfully Apr 17 23:25:38.921914 kubelet[1717]: E0417 23:25:38.921493 1717 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.9\" not found" node="10.0.0.9" Apr 17 23:25:38.926158 kubelet[1717]: I0417 23:25:38.926120 1717 cpu_manager.go:225] "Starting" policy="none" Apr 17 23:25:38.926158 kubelet[1717]: I0417 23:25:38.926143 1717 cpu_manager.go:226] "Reconciling" reconcilePeriod="10s" Apr 17 23:25:38.926273 kubelet[1717]: I0417 23:25:38.926191 1717 state_mem.go:41] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Apr 17 23:25:38.928373 kubelet[1717]: I0417 23:25:38.928345 1717 policy_none.go:50] "Start" Apr 17 23:25:38.928373 kubelet[1717]: I0417 23:25:38.928372 1717 memory_manager.go:187] "Starting memorymanager" policy="None" Apr 17 23:25:38.928424 kubelet[1717]: I0417 23:25:38.928383 1717 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Apr 17 23:25:38.929742 kubelet[1717]: I0417 23:25:38.929698 1717 policy_none.go:44] "Start" Apr 17 23:25:38.934668 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Apr 17 23:25:38.940293 kubelet[1717]: I0417 23:25:38.940263 1717 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Apr 17 23:25:38.943881 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Apr 17 23:25:38.946427 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Apr 17 23:25:38.953834 kubelet[1717]: E0417 23:25:38.953780 1717 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Apr 17 23:25:38.953924 kubelet[1717]: I0417 23:25:38.953907 1717 eviction_manager.go:194] "Eviction manager: starting control loop" Apr 17 23:25:38.953958 kubelet[1717]: I0417 23:25:38.953929 1717 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Apr 17 23:25:38.954713 kubelet[1717]: I0417 23:25:38.954606 1717 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Apr 17 23:25:38.955552 kubelet[1717]: E0417 23:25:38.955513 1717 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Apr 17 23:25:38.955640 kubelet[1717]: E0417 23:25:38.955560 1717 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.9\" not found" Apr 17 23:25:38.972932 kubelet[1717]: I0417 23:25:38.972900 1717 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Apr 17 23:25:38.972932 kubelet[1717]: I0417 23:25:38.972935 1717 status_manager.go:249] "Starting to sync pod status with apiserver" Apr 17 23:25:38.973102 kubelet[1717]: I0417 23:25:38.972963 1717 kubelet.go:2501] "Starting kubelet main sync loop" Apr 17 23:25:38.973102 kubelet[1717]: E0417 23:25:38.973006 1717 kubelet.go:2525] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Apr 17 23:25:39.056616 kubelet[1717]: I0417 23:25:39.056515 1717 kubelet_node_status.go:74] "Attempting to register node" node="10.0.0.9" Apr 17 23:25:39.064835 kubelet[1717]: I0417 23:25:39.064740 1717 kubelet_node_status.go:77] "Successfully registered node" node="10.0.0.9" Apr 17 23:25:39.181372 kubelet[1717]: I0417 23:25:39.181250 1717 kuberuntime_manager.go:2062] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Apr 17 23:25:39.181719 containerd[1446]: time="2026-04-17T23:25:39.181677449Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Apr 17 23:25:39.181954 kubelet[1717]: I0417 23:25:39.181818 1717 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Apr 17 23:25:39.193447 sudo[1579]: pam_unix(sudo:session): session closed for user root Apr 17 23:25:39.195490 sshd[1576]: pam_unix(sshd:session): session closed for user core Apr 17 23:25:39.198327 systemd[1]: sshd@4-10.0.0.9:22-10.0.0.1:55140.service: Deactivated successfully. Apr 17 23:25:39.199642 systemd[1]: session-5.scope: Deactivated successfully. Apr 17 23:25:39.200140 systemd-logind[1430]: Session 5 logged out. Waiting for processes to exit. Apr 17 23:25:39.200932 systemd-logind[1430]: Removed session 5. Apr 17 23:25:39.830298 kubelet[1717]: I0417 23:25:39.829928 1717 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Apr 17 23:25:39.831109 kubelet[1717]: I0417 23:25:39.831021 1717 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Apr 17 23:25:39.831227 kubelet[1717]: I0417 23:25:39.831117 1717 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Apr 17 23:25:39.831227 kubelet[1717]: I0417 23:25:39.831135 1717 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Apr 17 23:25:39.897297 kubelet[1717]: I0417 23:25:39.897208 1717 apiserver.go:52] "Watching apiserver" Apr 17 23:25:39.897435 kubelet[1717]: E0417 23:25:39.897246 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:39.912619 systemd[1]: Created slice kubepods-burstable-podc458122f_60b9_46d3_a590_eb9480a02649.slice - libcontainer container kubepods-burstable-podc458122f_60b9_46d3_a590_eb9480a02649.slice. Apr 17 23:25:39.916694 kubelet[1717]: I0417 23:25:39.916622 1717 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Apr 17 23:25:39.923639 kubelet[1717]: I0417 23:25:39.922806 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/c458122f-60b9-46d3-a590-eb9480a02649-xtables-lock\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.923639 kubelet[1717]: I0417 23:25:39.923593 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-bjffj\" (UniqueName: \"kubernetes.io/projected/c458122f-60b9-46d3-a590-eb9480a02649-kube-api-access-bjffj\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.923639 kubelet[1717]: I0417 23:25:39.923637 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/d42f63ae-88e9-4779-be94-e2cf08ff8bd8-kube-proxy\") pod \"kube-proxy-f7w6v\" (UID: \"d42f63ae-88e9-4779-be94-e2cf08ff8bd8\") " pod="kube-system/kube-proxy-f7w6v" Apr 17 23:25:39.923639 kubelet[1717]: I0417 23:25:39.923664 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d42f63ae-88e9-4779-be94-e2cf08ff8bd8-xtables-lock\") pod \"kube-proxy-f7w6v\" (UID: \"d42f63ae-88e9-4779-be94-e2cf08ff8bd8\") " pod="kube-system/kube-proxy-f7w6v" Apr 17 23:25:39.923838 kubelet[1717]: I0417 23:25:39.923691 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/d42f63ae-88e9-4779-be94-e2cf08ff8bd8-lib-modules\") pod \"kube-proxy-f7w6v\" (UID: \"d42f63ae-88e9-4779-be94-e2cf08ff8bd8\") " pod="kube-system/kube-proxy-f7w6v" Apr 17 23:25:39.923838 kubelet[1717]: I0417 23:25:39.923718 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-6vz6f\" (UniqueName: \"kubernetes.io/projected/d42f63ae-88e9-4779-be94-e2cf08ff8bd8-kube-api-access-6vz6f\") pod \"kube-proxy-f7w6v\" (UID: \"d42f63ae-88e9-4779-be94-e2cf08ff8bd8\") " pod="kube-system/kube-proxy-f7w6v" Apr 17 23:25:39.923838 kubelet[1717]: I0417 23:25:39.923738 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/c458122f-60b9-46d3-a590-eb9480a02649-run\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.923838 kubelet[1717]: I0417 23:25:39.923763 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/c458122f-60b9-46d3-a590-eb9480a02649-cni-plugin\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.923838 kubelet[1717]: I0417 23:25:39.923784 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/c458122f-60b9-46d3-a590-eb9480a02649-cni\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.925460 kubelet[1717]: I0417 23:25:39.923947 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/c458122f-60b9-46d3-a590-eb9480a02649-flannel-cfg\") pod \"kube-flannel-ds-c7bbf\" (UID: \"c458122f-60b9-46d3-a590-eb9480a02649\") " pod="kube-flannel/kube-flannel-ds-c7bbf" Apr 17 23:25:39.940151 systemd[1]: Created slice kubepods-besteffort-podd42f63ae_88e9_4779_be94_e2cf08ff8bd8.slice - libcontainer container kubepods-besteffort-podd42f63ae_88e9_4779_be94_e2cf08ff8bd8.slice. Apr 17 23:25:40.243862 kubelet[1717]: E0417 23:25:40.243467 1717 dns.go:154] "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" Apr 17 23:25:40.247678 containerd[1446]: time="2026-04-17T23:25:40.247592867Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-c7bbf,Uid:c458122f-60b9-46d3-a590-eb9480a02649,Namespace:kube-flannel,Attempt:0,}" Apr 17 23:25:40.256065 kubelet[1717]: E0417 23:25:40.255982 1717 dns.go:154] "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" Apr 17 23:25:40.260439 containerd[1446]: time="2026-04-17T23:25:40.259344143Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-f7w6v,Uid:d42f63ae-88e9-4779-be94-e2cf08ff8bd8,Namespace:kube-system,Attempt:0,}" Apr 17 23:25:40.881486 kernel: hrtimer: interrupt took 10787985 ns Apr 17 23:25:40.907122 kubelet[1717]: E0417 23:25:40.906964 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:41.112019 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount337981028.mount: Deactivated successfully. Apr 17 23:25:41.122056 containerd[1446]: time="2026-04-17T23:25:41.121985333Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 17 23:25:41.123284 containerd[1446]: time="2026-04-17T23:25:41.123211398Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 17 23:25:41.123874 containerd[1446]: time="2026-04-17T23:25:41.123827022Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Apr 17 23:25:41.125023 containerd[1446]: time="2026-04-17T23:25:41.124936282Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=311988" Apr 17 23:25:41.125874 containerd[1446]: time="2026-04-17T23:25:41.125850744Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 17 23:25:41.128653 containerd[1446]: time="2026-04-17T23:25:41.128601803Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 17 23:25:41.130078 containerd[1446]: time="2026-04-17T23:25:41.130018354Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 882.291334ms" Apr 17 23:25:41.133029 containerd[1446]: time="2026-04-17T23:25:41.132904492Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 872.937799ms" Apr 17 23:25:41.237055 containerd[1446]: time="2026-04-17T23:25:41.236726185Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 17 23:25:41.237055 containerd[1446]: time="2026-04-17T23:25:41.236828471Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 17 23:25:41.237055 containerd[1446]: time="2026-04-17T23:25:41.236845311Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:41.237055 containerd[1446]: time="2026-04-17T23:25:41.236932301Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:41.238223 containerd[1446]: time="2026-04-17T23:25:41.237505902Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 17 23:25:41.238223 containerd[1446]: time="2026-04-17T23:25:41.237582646Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 17 23:25:41.238223 containerd[1446]: time="2026-04-17T23:25:41.237592921Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:41.238223 containerd[1446]: time="2026-04-17T23:25:41.237639321Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:41.291415 systemd[1]: Started cri-containerd-f1bb875f2ec99b5b7d834b0b8872a000f2698803a521e0037eb313d5a84e9768.scope - libcontainer container f1bb875f2ec99b5b7d834b0b8872a000f2698803a521e0037eb313d5a84e9768. Apr 17 23:25:41.294596 systemd[1]: Started cri-containerd-f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83.scope - libcontainer container f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83. Apr 17 23:25:41.312983 containerd[1446]: time="2026-04-17T23:25:41.312918549Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-f7w6v,Uid:d42f63ae-88e9-4779-be94-e2cf08ff8bd8,Namespace:kube-system,Attempt:0,} returns sandbox id \"f1bb875f2ec99b5b7d834b0b8872a000f2698803a521e0037eb313d5a84e9768\"" Apr 17 23:25:41.314884 kubelet[1717]: E0417 23:25:41.314330 1717 dns.go:154] "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" Apr 17 23:25:41.317814 containerd[1446]: time="2026-04-17T23:25:41.317495827Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.4\"" Apr 17 23:25:41.334931 containerd[1446]: time="2026-04-17T23:25:41.334843474Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-c7bbf,Uid:c458122f-60b9-46d3-a590-eb9480a02649,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\"" Apr 17 23:25:41.335757 kubelet[1717]: E0417 23:25:41.335735 1717 dns.go:154] "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" Apr 17 23:25:41.907977 kubelet[1717]: E0417 23:25:41.907919 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:42.294379 containerd[1446]: time="2026-04-17T23:25:42.293987550Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.35.4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:42.294772 containerd[1446]: time="2026-04-17T23:25:42.294730036Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.35.4: active requests=0, bytes read=25699819" Apr 17 23:25:42.296048 containerd[1446]: time="2026-04-17T23:25:42.296005088Z" level=info msg="ImageCreate event name:\"sha256:f21f27cddb23d0d7131dc7c59666b3b0e0b5ca4c3f003225f90307ab6211b6e1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:42.298073 containerd[1446]: time="2026-04-17T23:25:42.297981214Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:c5daa23c72474e5e4062c320177d3b485fd42e7010f052bc80d657c4c00a0672\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:42.298684 containerd[1446]: time="2026-04-17T23:25:42.298641662Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.35.4\" with image id \"sha256:f21f27cddb23d0d7131dc7c59666b3b0e0b5ca4c3f003225f90307ab6211b6e1\", repo tag \"registry.k8s.io/kube-proxy:v1.35.4\", repo digest \"registry.k8s.io/kube-proxy@sha256:c5daa23c72474e5e4062c320177d3b485fd42e7010f052bc80d657c4c00a0672\", size \"25698944\" in 980.721148ms" Apr 17 23:25:42.298684 containerd[1446]: time="2026-04-17T23:25:42.298675064Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.4\" returns image reference \"sha256:f21f27cddb23d0d7131dc7c59666b3b0e0b5ca4c3f003225f90307ab6211b6e1\"" Apr 17 23:25:42.299852 containerd[1446]: time="2026-04-17T23:25:42.299798667Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Apr 17 23:25:42.303211 containerd[1446]: time="2026-04-17T23:25:42.303133416Z" level=info msg="CreateContainer within sandbox \"f1bb875f2ec99b5b7d834b0b8872a000f2698803a521e0037eb313d5a84e9768\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Apr 17 23:25:42.320337 containerd[1446]: time="2026-04-17T23:25:42.320298012Z" level=info msg="CreateContainer within sandbox \"f1bb875f2ec99b5b7d834b0b8872a000f2698803a521e0037eb313d5a84e9768\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"d3bb77ea518ac408eada755310193a5312a343352e9c4a1fcd8210c99a74bae6\"" Apr 17 23:25:42.320939 containerd[1446]: time="2026-04-17T23:25:42.320821255Z" level=info msg="StartContainer for \"d3bb77ea518ac408eada755310193a5312a343352e9c4a1fcd8210c99a74bae6\"" Apr 17 23:25:42.354446 systemd[1]: Started cri-containerd-d3bb77ea518ac408eada755310193a5312a343352e9c4a1fcd8210c99a74bae6.scope - libcontainer container d3bb77ea518ac408eada755310193a5312a343352e9c4a1fcd8210c99a74bae6. Apr 17 23:25:42.380249 containerd[1446]: time="2026-04-17T23:25:42.379296629Z" level=info msg="StartContainer for \"d3bb77ea518ac408eada755310193a5312a343352e9c4a1fcd8210c99a74bae6\" returns successfully" Apr 17 23:25:42.908631 kubelet[1717]: E0417 23:25:42.908583 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:42.988103 kubelet[1717]: E0417 23:25:42.988046 1717 dns.go:154] "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" Apr 17 23:25:43.715443 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1546114349.mount: Deactivated successfully. Apr 17 23:25:43.755509 containerd[1446]: time="2026-04-17T23:25:43.755425039Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:43.756541 containerd[1446]: time="2026-04-17T23:25:43.756497388Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Apr 17 23:25:43.758081 containerd[1446]: time="2026-04-17T23:25:43.758023677Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:43.760812 containerd[1446]: time="2026-04-17T23:25:43.760772246Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:43.761621 containerd[1446]: time="2026-04-17T23:25:43.761587063Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"4856838\" in 1.461701216s" Apr 17 23:25:43.761681 containerd[1446]: time="2026-04-17T23:25:43.761628762Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Apr 17 23:25:43.767139 containerd[1446]: time="2026-04-17T23:25:43.766988057Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Apr 17 23:25:43.780815 containerd[1446]: time="2026-04-17T23:25:43.780727228Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46\"" Apr 17 23:25:43.781468 containerd[1446]: time="2026-04-17T23:25:43.781417376Z" level=info msg="StartContainer for \"1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46\"" Apr 17 23:25:43.813634 systemd[1]: Started cri-containerd-1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46.scope - libcontainer container 1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46. Apr 17 23:25:43.838503 containerd[1446]: time="2026-04-17T23:25:43.838362673Z" level=info msg="StartContainer for \"1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46\" returns successfully" Apr 17 23:25:43.838911 systemd[1]: cri-containerd-1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46.scope: Deactivated successfully. Apr 17 23:25:43.908946 kubelet[1717]: E0417 23:25:43.908819 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:43.940477 containerd[1446]: time="2026-04-17T23:25:43.940390213Z" level=info msg="shim disconnected" id=1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46 namespace=k8s.io Apr 17 23:25:43.940477 containerd[1446]: time="2026-04-17T23:25:43.940463365Z" level=warning msg="cleaning up after shim disconnected" id=1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46 namespace=k8s.io Apr 17 23:25:43.940477 containerd[1446]: time="2026-04-17T23:25:43.940471197Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 17 23:25:43.993247 kubelet[1717]: E0417 23:25:43.992863 1717 dns.go:154] "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" Apr 17 23:25:43.993247 kubelet[1717]: E0417 23:25:43.992888 1717 dns.go:154] "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" Apr 17 23:25:43.994840 containerd[1446]: time="2026-04-17T23:25:43.994787244Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Apr 17 23:25:44.021899 kubelet[1717]: I0417 23:25:44.021685 1717 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-system/kube-proxy-f7w6v" podStartSLOduration=4.038758788 podStartE2EDuration="5.021674546s" podCreationTimestamp="2026-04-17 23:25:39 +0000 UTC" firstStartedPulling="2026-04-17 23:25:41.316616074 +0000 UTC m=+2.628031867" lastFinishedPulling="2026-04-17 23:25:42.299531845 +0000 UTC m=+3.610947625" observedRunningTime="2026-04-17 23:25:43.005675754 +0000 UTC m=+4.317091547" watchObservedRunningTime="2026-04-17 23:25:44.021674546 +0000 UTC m=+5.333090330" Apr 17 23:25:44.643062 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-1d7b04e6df9c73491b52e3c21ca87a6e6e5209ee510469bab91f53a6faf33b46-rootfs.mount: Deactivated successfully. Apr 17 23:25:44.909744 kubelet[1717]: E0417 23:25:44.909550 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:45.886545 containerd[1446]: time="2026-04-17T23:25:45.886459044Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:45.889686 containerd[1446]: time="2026-04-17T23:25:45.889594245Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Apr 17 23:25:45.891332 containerd[1446]: time="2026-04-17T23:25:45.891273615Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:45.895598 containerd[1446]: time="2026-04-17T23:25:45.895519672Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:45.897075 containerd[1446]: time="2026-04-17T23:25:45.897032461Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32996046\" in 1.902196827s" Apr 17 23:25:45.897075 containerd[1446]: time="2026-04-17T23:25:45.897070948Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Apr 17 23:25:45.901702 containerd[1446]: time="2026-04-17T23:25:45.901610772Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Apr 17 23:25:45.910197 kubelet[1717]: E0417 23:25:45.910157 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:45.915273 containerd[1446]: time="2026-04-17T23:25:45.915218077Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb\"" Apr 17 23:25:45.916150 containerd[1446]: time="2026-04-17T23:25:45.916114282Z" level=info msg="StartContainer for \"e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb\"" Apr 17 23:25:45.947540 systemd[1]: Started cri-containerd-e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb.scope - libcontainer container e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb. Apr 17 23:25:45.964790 systemd[1]: cri-containerd-e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb.scope: Deactivated successfully. Apr 17 23:25:45.967158 containerd[1446]: time="2026-04-17T23:25:45.967066585Z" level=info msg="StartContainer for \"e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb\" returns successfully" Apr 17 23:25:45.982138 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb-rootfs.mount: Deactivated successfully. Apr 17 23:25:45.999903 kubelet[1717]: E0417 23:25:45.999716 1717 dns.go:154] "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" Apr 17 23:25:46.021022 kubelet[1717]: I0417 23:25:46.020971 1717 kubelet_node_status.go:427] "Fast updating node status as it just became ready" Apr 17 23:25:46.052315 containerd[1446]: time="2026-04-17T23:25:46.052116434Z" level=info msg="shim disconnected" id=e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb namespace=k8s.io Apr 17 23:25:46.052547 containerd[1446]: time="2026-04-17T23:25:46.052392073Z" level=warning msg="cleaning up after shim disconnected" id=e51f06063b83a27f41a0f18d3ae61016a317aca0af8e89c9608d9fd5582f3acb namespace=k8s.io Apr 17 23:25:46.052547 containerd[1446]: time="2026-04-17T23:25:46.052409303Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 17 23:25:46.911518 kubelet[1717]: E0417 23:25:46.911404 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:47.002985 kubelet[1717]: E0417 23:25:47.002880 1717 dns.go:154] "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" Apr 17 23:25:47.009271 containerd[1446]: time="2026-04-17T23:25:47.009098223Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Apr 17 23:25:47.032006 containerd[1446]: time="2026-04-17T23:25:47.031881477Z" level=info msg="CreateContainer within sandbox \"f31352f9ebabee282b2be6c8b5eef2f02139da9dd2aa1d6d2a3ebe3457ffbe83\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"e966d05453167e7148feba9b87bdaedded33e3afd90e5071ab7175caf7eedc4c\"" Apr 17 23:25:47.032681 containerd[1446]: time="2026-04-17T23:25:47.032649163Z" level=info msg="StartContainer for \"e966d05453167e7148feba9b87bdaedded33e3afd90e5071ab7175caf7eedc4c\"" Apr 17 23:25:47.059378 systemd[1]: Started cri-containerd-e966d05453167e7148feba9b87bdaedded33e3afd90e5071ab7175caf7eedc4c.scope - libcontainer container e966d05453167e7148feba9b87bdaedded33e3afd90e5071ab7175caf7eedc4c. Apr 17 23:25:47.084033 containerd[1446]: time="2026-04-17T23:25:47.083943316Z" level=info msg="StartContainer for \"e966d05453167e7148feba9b87bdaedded33e3afd90e5071ab7175caf7eedc4c\" returns successfully" Apr 17 23:25:47.913398 kubelet[1717]: E0417 23:25:47.913099 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:48.006893 kubelet[1717]: E0417 23:25:48.006854 1717 dns.go:154] "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" Apr 17 23:25:48.150505 systemd-networkd[1378]: flannel.1: Link UP Apr 17 23:25:48.150512 systemd-networkd[1378]: flannel.1: Gained carrier Apr 17 23:25:48.915008 kubelet[1717]: E0417 23:25:48.914895 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:49.008613 kubelet[1717]: E0417 23:25:49.008507 1717 dns.go:154] "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" Apr 17 23:25:49.915464 kubelet[1717]: E0417 23:25:49.915303 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:50.020206 kubelet[1717]: I0417 23:25:50.019967 1717 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-c7bbf" podStartSLOduration=5.352855679 podStartE2EDuration="11.019953016s" podCreationTimestamp="2026-04-17 23:25:39 +0000 UTC" firstStartedPulling="2026-04-17 23:25:41.336432216 +0000 UTC m=+2.647848002" lastFinishedPulling="2026-04-17 23:25:47.003529548 +0000 UTC m=+8.314945339" observedRunningTime="2026-04-17 23:25:48.024838064 +0000 UTC m=+9.336253855" watchObservedRunningTime="2026-04-17 23:25:50.019953016 +0000 UTC m=+11.331368794" Apr 17 23:25:50.035300 systemd[1]: Created slice kubepods-besteffort-podada4dac2_176a_48ac_8a70_09e11b4f0c37.slice - libcontainer container kubepods-besteffort-podada4dac2_176a_48ac_8a70_09e11b4f0c37.slice. Apr 17 23:25:50.112936 kubelet[1717]: I0417 23:25:50.112818 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-djvsd\" (UniqueName: \"kubernetes.io/projected/ada4dac2-176a-48ac-8a70-09e11b4f0c37-kube-api-access-djvsd\") pod \"nginx-deployment-6cc69d4fc7-r9lh7\" (UID: \"ada4dac2-176a-48ac-8a70-09e11b4f0c37\") " pod="default/nginx-deployment-6cc69d4fc7-r9lh7" Apr 17 23:25:50.115502 systemd-networkd[1378]: flannel.1: Gained IPv6LL Apr 17 23:25:50.344582 containerd[1446]: time="2026-04-17T23:25:50.344290460Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-r9lh7,Uid:ada4dac2-176a-48ac-8a70-09e11b4f0c37,Namespace:default,Attempt:0,}" Apr 17 23:25:50.366206 systemd-networkd[1378]: cni0: Link UP Apr 17 23:25:50.366212 systemd-networkd[1378]: cni0: Gained carrier Apr 17 23:25:50.367640 systemd-networkd[1378]: cni0: Lost carrier Apr 17 23:25:50.377456 systemd-networkd[1378]: veth3386d1a5: Link UP Apr 17 23:25:50.382283 kernel: cni0: port 1(veth3386d1a5) entered blocking state Apr 17 23:25:50.382423 kernel: cni0: port 1(veth3386d1a5) entered disabled state Apr 17 23:25:50.382438 kernel: veth3386d1a5: entered allmulticast mode Apr 17 23:25:50.383315 kernel: veth3386d1a5: entered promiscuous mode Apr 17 23:25:50.384613 kernel: cni0: port 1(veth3386d1a5) entered blocking state Apr 17 23:25:50.384642 kernel: cni0: port 1(veth3386d1a5) entered forwarding state Apr 17 23:25:50.386193 kernel: cni0: port 1(veth3386d1a5) entered disabled state Apr 17 23:25:50.393416 kernel: cni0: port 1(veth3386d1a5) entered blocking state Apr 17 23:25:50.393530 kernel: cni0: port 1(veth3386d1a5) entered forwarding state Apr 17 23:25:50.393742 systemd-networkd[1378]: veth3386d1a5: Gained carrier Apr 17 23:25:50.394204 systemd-networkd[1378]: cni0: Gained carrier Apr 17 23:25:50.395848 containerd[1446]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a950), "name":"cbr0", "type":"bridge"} Apr 17 23:25:50.395848 containerd[1446]: delegateAdd: netconf sent to delegate plugin: Apr 17 23:25:50.416319 containerd[1446]: {"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="2026-04-17T23:25:50.416122177Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 17 23:25:50.417524 containerd[1446]: time="2026-04-17T23:25:50.417397936Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 17 23:25:50.417524 containerd[1446]: time="2026-04-17T23:25:50.417435669Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:50.417772 containerd[1446]: time="2026-04-17T23:25:50.417545478Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:50.441432 systemd[1]: Started cri-containerd-15d1d3056a3a0eebb018775d91920b0cebe646f12871d013207afe16292cebde.scope - libcontainer container 15d1d3056a3a0eebb018775d91920b0cebe646f12871d013207afe16292cebde. Apr 17 23:25:50.452238 systemd-resolved[1381]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 17 23:25:50.476338 containerd[1446]: time="2026-04-17T23:25:50.476285148Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-r9lh7,Uid:ada4dac2-176a-48ac-8a70-09e11b4f0c37,Namespace:default,Attempt:0,} returns sandbox id \"15d1d3056a3a0eebb018775d91920b0cebe646f12871d013207afe16292cebde\"" Apr 17 23:25:50.477854 containerd[1446]: time="2026-04-17T23:25:50.477790248Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 17 23:25:50.915908 kubelet[1717]: E0417 23:25:50.915795 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:51.843856 systemd-networkd[1378]: cni0: Gained IPv6LL Apr 17 23:25:51.917245 kubelet[1717]: E0417 23:25:51.917109 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:52.227371 systemd-networkd[1378]: veth3386d1a5: Gained IPv6LL Apr 17 23:25:52.917509 kubelet[1717]: E0417 23:25:52.917454 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:53.085923 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount173810601.mount: Deactivated successfully. Apr 17 23:25:53.664904 containerd[1446]: time="2026-04-17T23:25:53.664821169Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:53.666676 containerd[1446]: time="2026-04-17T23:25:53.666467936Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=63909824" Apr 17 23:25:53.668804 containerd[1446]: time="2026-04-17T23:25:53.668746454Z" level=info msg="ImageCreate event name:\"sha256:fda7399e8104578dd71a8491d53621a60c1c5ed6b7f3befb583d4f164244255e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:53.671271 containerd[1446]: time="2026-04-17T23:25:53.671227951Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:53.671894 containerd[1446]: time="2026-04-17T23:25:53.671857610Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fda7399e8104578dd71a8491d53621a60c1c5ed6b7f3befb583d4f164244255e\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\", size \"63909702\" in 3.194005177s" Apr 17 23:25:53.671894 containerd[1446]: time="2026-04-17T23:25:53.671893159Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fda7399e8104578dd71a8491d53621a60c1c5ed6b7f3befb583d4f164244255e\"" Apr 17 23:25:53.677575 containerd[1446]: time="2026-04-17T23:25:53.677479933Z" level=info msg="CreateContainer within sandbox \"15d1d3056a3a0eebb018775d91920b0cebe646f12871d013207afe16292cebde\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Apr 17 23:25:53.690002 containerd[1446]: time="2026-04-17T23:25:53.689923361Z" level=info msg="CreateContainer within sandbox \"15d1d3056a3a0eebb018775d91920b0cebe646f12871d013207afe16292cebde\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"609b5b4257996511e31e82390199866a51ed5cb3613efedc5096a88d2b006399\"" Apr 17 23:25:53.691006 containerd[1446]: time="2026-04-17T23:25:53.690916122Z" level=info msg="StartContainer for \"609b5b4257996511e31e82390199866a51ed5cb3613efedc5096a88d2b006399\"" Apr 17 23:25:53.726388 systemd[1]: Started cri-containerd-609b5b4257996511e31e82390199866a51ed5cb3613efedc5096a88d2b006399.scope - libcontainer container 609b5b4257996511e31e82390199866a51ed5cb3613efedc5096a88d2b006399. Apr 17 23:25:53.747212 containerd[1446]: time="2026-04-17T23:25:53.747149043Z" level=info msg="StartContainer for \"609b5b4257996511e31e82390199866a51ed5cb3613efedc5096a88d2b006399\" returns successfully" Apr 17 23:25:53.917908 kubelet[1717]: E0417 23:25:53.917705 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:54.036578 kubelet[1717]: I0417 23:25:54.036502 1717 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nginx-deployment-6cc69d4fc7-r9lh7" podStartSLOduration=0.841045328 podStartE2EDuration="4.036486082s" podCreationTimestamp="2026-04-17 23:25:50 +0000 UTC" firstStartedPulling="2026-04-17 23:25:50.47714171 +0000 UTC m=+11.788557493" lastFinishedPulling="2026-04-17 23:25:53.672582467 +0000 UTC m=+14.983998247" observedRunningTime="2026-04-17 23:25:54.036438789 +0000 UTC m=+15.347854584" watchObservedRunningTime="2026-04-17 23:25:54.036486082 +0000 UTC m=+15.347901872" Apr 17 23:25:54.919266 kubelet[1717]: E0417 23:25:54.919094 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:55.920287 kubelet[1717]: E0417 23:25:55.920202 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:56.441700 systemd[1]: Created slice kubepods-besteffort-pod92ad591e_35d4_4361_970c_8d65a0cae12c.slice - libcontainer container kubepods-besteffort-pod92ad591e_35d4_4361_970c_8d65a0cae12c.slice. Apr 17 23:25:56.560624 kubelet[1717]: I0417 23:25:56.560480 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/92ad591e-35d4-4361-970c-8d65a0cae12c-data\") pod \"nfs-server-provisioner-0\" (UID: \"92ad591e-35d4-4361-970c-8d65a0cae12c\") " pod="default/nfs-server-provisioner-0" Apr 17 23:25:56.560624 kubelet[1717]: I0417 23:25:56.560620 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zs7hc\" (UniqueName: \"kubernetes.io/projected/92ad591e-35d4-4361-970c-8d65a0cae12c-kube-api-access-zs7hc\") pod \"nfs-server-provisioner-0\" (UID: \"92ad591e-35d4-4361-970c-8d65a0cae12c\") " pod="default/nfs-server-provisioner-0" Apr 17 23:25:56.748350 containerd[1446]: time="2026-04-17T23:25:56.748154900Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:92ad591e-35d4-4361-970c-8d65a0cae12c,Namespace:default,Attempt:0,}" Apr 17 23:25:56.769018 systemd-networkd[1378]: veth844cf5cf: Link UP Apr 17 23:25:56.772193 kernel: cni0: port 2(veth844cf5cf) entered blocking state Apr 17 23:25:56.772263 kernel: cni0: port 2(veth844cf5cf) entered disabled state Apr 17 23:25:56.772286 kernel: veth844cf5cf: entered allmulticast mode Apr 17 23:25:56.773290 kernel: veth844cf5cf: entered promiscuous mode Apr 17 23:25:56.780554 kernel: cni0: port 2(veth844cf5cf) entered blocking state Apr 17 23:25:56.780613 kernel: cni0: port 2(veth844cf5cf) entered forwarding state Apr 17 23:25:56.780618 systemd-networkd[1378]: veth844cf5cf: Gained carrier Apr 17 23:25:56.782953 containerd[1446]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a950), "name":"cbr0", "type":"bridge"} Apr 17 23:25:56.782953 containerd[1446]: delegateAdd: netconf sent to delegate plugin: Apr 17 23:25:56.803219 containerd[1446]: {"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="2026-04-17T23:25:56.803007900Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 17 23:25:56.803219 containerd[1446]: time="2026-04-17T23:25:56.803118411Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 17 23:25:56.803219 containerd[1446]: time="2026-04-17T23:25:56.803132531Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:56.803422 containerd[1446]: time="2026-04-17T23:25:56.803244940Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:25:56.822753 systemd[1]: Started cri-containerd-d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7.scope - libcontainer container d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7. Apr 17 23:25:56.832558 systemd-resolved[1381]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 17 23:25:56.855223 containerd[1446]: time="2026-04-17T23:25:56.855145223Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:92ad591e-35d4-4361-970c-8d65a0cae12c,Namespace:default,Attempt:0,} returns sandbox id \"d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7\"" Apr 17 23:25:56.856970 containerd[1446]: time="2026-04-17T23:25:56.856928507Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Apr 17 23:25:56.920778 kubelet[1717]: E0417 23:25:56.920668 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:57.672715 systemd[1]: run-containerd-runc-k8s.io-d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7-runc.YL8Hg4.mount: Deactivated successfully. Apr 17 23:25:57.921314 kubelet[1717]: E0417 23:25:57.921217 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:58.022885 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2381364561.mount: Deactivated successfully. Apr 17 23:25:58.180404 systemd-networkd[1378]: veth844cf5cf: Gained IPv6LL Apr 17 23:25:58.897472 kubelet[1717]: E0417 23:25:58.897247 1717 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:58.921606 kubelet[1717]: E0417 23:25:58.921492 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:25:59.188081 containerd[1446]: time="2026-04-17T23:25:59.187941056Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:59.188608 containerd[1446]: time="2026-04-17T23:25:59.188573524Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039034" Apr 17 23:25:59.189677 containerd[1446]: time="2026-04-17T23:25:59.189633479Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:59.192402 containerd[1446]: time="2026-04-17T23:25:59.192363867Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:25:59.193101 containerd[1446]: time="2026-04-17T23:25:59.193069473Z" 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 2.336104964s" Apr 17 23:25:59.193101 containerd[1446]: time="2026-04-17T23:25:59.193100579Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Apr 17 23:25:59.197542 containerd[1446]: time="2026-04-17T23:25:59.197512483Z" level=info msg="CreateContainer within sandbox \"d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Apr 17 23:25:59.208626 containerd[1446]: time="2026-04-17T23:25:59.208577482Z" level=info msg="CreateContainer within sandbox \"d391bf9ea64f330666294391f3660ac47566a6019a0dda21d217348089155cb7\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"a145b06b8e3c129fecf546259d4b691c1aa98f056e2f100b0efede98b7ff6ea8\"" Apr 17 23:25:59.209183 containerd[1446]: time="2026-04-17T23:25:59.209135770Z" level=info msg="StartContainer for \"a145b06b8e3c129fecf546259d4b691c1aa98f056e2f100b0efede98b7ff6ea8\"" Apr 17 23:25:59.235315 systemd[1]: Started cri-containerd-a145b06b8e3c129fecf546259d4b691c1aa98f056e2f100b0efede98b7ff6ea8.scope - libcontainer container a145b06b8e3c129fecf546259d4b691c1aa98f056e2f100b0efede98b7ff6ea8. Apr 17 23:25:59.253538 containerd[1446]: time="2026-04-17T23:25:59.253479455Z" level=info msg="StartContainer for \"a145b06b8e3c129fecf546259d4b691c1aa98f056e2f100b0efede98b7ff6ea8\" returns successfully" Apr 17 23:25:59.922719 kubelet[1717]: E0417 23:25:59.922600 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:00.053729 kubelet[1717]: I0417 23:26:00.053617 1717 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.71609762 podStartE2EDuration="4.053605195s" podCreationTimestamp="2026-04-17 23:25:56 +0000 UTC" firstStartedPulling="2026-04-17 23:25:56.856494262 +0000 UTC m=+18.167910042" lastFinishedPulling="2026-04-17 23:25:59.194001836 +0000 UTC m=+20.505417617" observedRunningTime="2026-04-17 23:26:00.053561861 +0000 UTC m=+21.364977646" watchObservedRunningTime="2026-04-17 23:26:00.053605195 +0000 UTC m=+21.365020993" Apr 17 23:26:00.923123 kubelet[1717]: E0417 23:26:00.922982 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:01.923807 kubelet[1717]: E0417 23:26:01.923715 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:02.925406 kubelet[1717]: E0417 23:26:02.925004 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:03.926060 kubelet[1717]: E0417 23:26:03.925893 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:04.491300 systemd[1]: Created slice kubepods-besteffort-pod0fcf8106_f8ba_45c6_ba3f_251a018f3c0e.slice - libcontainer container kubepods-besteffort-pod0fcf8106_f8ba_45c6_ba3f_251a018f3c0e.slice. Apr 17 23:26:04.517826 kubelet[1717]: I0417 23:26:04.517745 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-5be47194-c356-4711-ad4e-1a0182bed2da\" (UniqueName: \"kubernetes.io/nfs/0fcf8106-f8ba-45c6-ba3f-251a018f3c0e-pvc-5be47194-c356-4711-ad4e-1a0182bed2da\") pod \"test-pod-1\" (UID: \"0fcf8106-f8ba-45c6-ba3f-251a018f3c0e\") " pod="default/test-pod-1" Apr 17 23:26:04.517826 kubelet[1717]: I0417 23:26:04.517829 1717 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gcgqf\" (UniqueName: \"kubernetes.io/projected/0fcf8106-f8ba-45c6-ba3f-251a018f3c0e-kube-api-access-gcgqf\") pod \"test-pod-1\" (UID: \"0fcf8106-f8ba-45c6-ba3f-251a018f3c0e\") " pod="default/test-pod-1" Apr 17 23:26:04.641197 kernel: FS-Cache: Loaded Apr 17 23:26:04.696478 kernel: RPC: Registered named UNIX socket transport module. Apr 17 23:26:04.696616 kernel: RPC: Registered udp transport module. Apr 17 23:26:04.696636 kernel: RPC: Registered tcp transport module. Apr 17 23:26:04.697246 kernel: RPC: Registered tcp-with-tls transport module. Apr 17 23:26:04.699180 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 17 23:26:04.900418 kernel: NFS: Registering the id_resolver key type Apr 17 23:26:04.900518 kernel: Key type id_resolver registered Apr 17 23:26:04.900545 kernel: Key type id_legacy registered Apr 17 23:26:04.925431 nfsidmap[2723]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 17 23:26:04.926636 kubelet[1717]: E0417 23:26:04.926470 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:04.929196 nfsidmap[2726]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 17 23:26:05.097391 containerd[1446]: time="2026-04-17T23:26:05.097336543Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0fcf8106-f8ba-45c6-ba3f-251a018f3c0e,Namespace:default,Attempt:0,}" Apr 17 23:26:05.115864 systemd-networkd[1378]: vethc0c44f8b: Link UP Apr 17 23:26:05.117701 kernel: cni0: port 3(vethc0c44f8b) entered blocking state Apr 17 23:26:05.117740 kernel: cni0: port 3(vethc0c44f8b) entered disabled state Apr 17 23:26:05.118615 kernel: vethc0c44f8b: entered allmulticast mode Apr 17 23:26:05.119518 kernel: vethc0c44f8b: entered promiscuous mode Apr 17 23:26:05.127298 kernel: cni0: port 3(vethc0c44f8b) entered blocking state Apr 17 23:26:05.127335 kernel: cni0: port 3(vethc0c44f8b) entered forwarding state Apr 17 23:26:05.127376 systemd-networkd[1378]: vethc0c44f8b: Gained carrier Apr 17 23:26:05.129102 containerd[1446]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0001847f0), "name":"cbr0", "type":"bridge"} Apr 17 23:26:05.129102 containerd[1446]: delegateAdd: netconf sent to delegate plugin: Apr 17 23:26:05.158147 containerd[1446]: {"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="2026-04-17T23:26:05.157997015Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 17 23:26:05.158881 containerd[1446]: time="2026-04-17T23:26:05.158818676Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 17 23:26:05.158881 containerd[1446]: time="2026-04-17T23:26:05.158839338Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:26:05.159054 containerd[1446]: time="2026-04-17T23:26:05.158903304Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 17 23:26:05.175911 systemd[1]: Started cri-containerd-4d33ac6ff4158eea2eb4ae4a2e102ee3f913002915877c6a9ba4fb8439c77da8.scope - libcontainer container 4d33ac6ff4158eea2eb4ae4a2e102ee3f913002915877c6a9ba4fb8439c77da8. Apr 17 23:26:05.187459 systemd-resolved[1381]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 17 23:26:05.210366 containerd[1446]: time="2026-04-17T23:26:05.210308741Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0fcf8106-f8ba-45c6-ba3f-251a018f3c0e,Namespace:default,Attempt:0,} returns sandbox id \"4d33ac6ff4158eea2eb4ae4a2e102ee3f913002915877c6a9ba4fb8439c77da8\"" Apr 17 23:26:05.211719 containerd[1446]: time="2026-04-17T23:26:05.211679559Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 17 23:26:05.628554 containerd[1446]: time="2026-04-17T23:26:05.628408134Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 17 23:26:05.629463 containerd[1446]: time="2026-04-17T23:26:05.629409054Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Apr 17 23:26:05.633958 containerd[1446]: time="2026-04-17T23:26:05.633924028Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fda7399e8104578dd71a8491d53621a60c1c5ed6b7f3befb583d4f164244255e\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\", size \"63909702\" in 422.20389ms" Apr 17 23:26:05.633958 containerd[1446]: time="2026-04-17T23:26:05.633956031Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fda7399e8104578dd71a8491d53621a60c1c5ed6b7f3befb583d4f164244255e\"" Apr 17 23:26:05.639760 containerd[1446]: time="2026-04-17T23:26:05.639706973Z" level=info msg="CreateContainer within sandbox \"4d33ac6ff4158eea2eb4ae4a2e102ee3f913002915877c6a9ba4fb8439c77da8\" for container &ContainerMetadata{Name:test,Attempt:0,}" Apr 17 23:26:05.663156 containerd[1446]: time="2026-04-17T23:26:05.663104881Z" level=info msg="CreateContainer within sandbox \"4d33ac6ff4158eea2eb4ae4a2e102ee3f913002915877c6a9ba4fb8439c77da8\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c\"" Apr 17 23:26:05.663987 containerd[1446]: time="2026-04-17T23:26:05.663770559Z" level=info msg="StartContainer for \"f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c\"" Apr 17 23:26:05.693679 systemd[1]: Started cri-containerd-f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c.scope - libcontainer container f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c. Apr 17 23:26:05.716633 containerd[1446]: time="2026-04-17T23:26:05.716563104Z" level=info msg="StartContainer for \"f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c\" returns successfully" Apr 17 23:26:05.927235 kubelet[1717]: E0417 23:26:05.927024 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:06.071423 kubelet[1717]: I0417 23:26:06.071330 1717 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=9.647659361 podStartE2EDuration="10.071150918s" podCreationTimestamp="2026-04-17 23:25:56 +0000 UTC" firstStartedPulling="2026-04-17 23:26:05.211368449 +0000 UTC m=+26.522784229" lastFinishedPulling="2026-04-17 23:26:05.634860006 +0000 UTC m=+26.946275786" observedRunningTime="2026-04-17 23:26:06.071101718 +0000 UTC m=+27.382517519" watchObservedRunningTime="2026-04-17 23:26:06.071150918 +0000 UTC m=+27.382566698" Apr 17 23:26:06.499513 systemd-networkd[1378]: vethc0c44f8b: Gained IPv6LL Apr 17 23:26:06.631580 systemd[1]: run-containerd-runc-k8s.io-f633a6fedd4910ee1332f1a6fb2b6ed9df72c5551be360600f7b5c766fcf345c-runc.tlm6EF.mount: Deactivated successfully. Apr 17 23:26:06.928616 kubelet[1717]: E0417 23:26:06.928408 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:07.929480 kubelet[1717]: E0417 23:26:07.929359 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 17 23:26:08.929791 kubelet[1717]: E0417 23:26:08.929737 1717 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"