Apr 24 00:22:00.594844 kernel: Linux version 6.12.81-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Thu Apr 23 22:08:58 -00 2026 Apr 24 00:22:00.595049 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=35bf60e399c7fbdab9d27e362bd719e7cadd795a3fa26a4f30de01ccc70fba7e Apr 24 00:22:00.595062 kernel: BIOS-provided physical RAM map: Apr 24 00:22:00.595070 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000002ffff] usable Apr 24 00:22:00.595076 kernel: BIOS-e820: [mem 0x0000000000030000-0x000000000004ffff] reserved Apr 24 00:22:00.595084 kernel: BIOS-e820: [mem 0x0000000000050000-0x000000000009efff] usable Apr 24 00:22:00.595096 kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved Apr 24 00:22:00.595104 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009b8ecfff] usable Apr 24 00:22:00.595159 kernel: BIOS-e820: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Apr 24 00:22:00.595164 kernel: BIOS-e820: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Apr 24 00:22:00.595169 kernel: BIOS-e820: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Apr 24 00:22:00.595174 kernel: BIOS-e820: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Apr 24 00:22:00.595178 kernel: BIOS-e820: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Apr 24 00:22:00.595183 kernel: BIOS-e820: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Apr 24 00:22:00.595190 kernel: BIOS-e820: [mem 0x000000009bfb7000-0x000000009bffffff] usable Apr 24 00:22:00.595195 kernel: BIOS-e820: [mem 0x000000009c000000-0x000000009cffffff] reserved Apr 24 00:22:00.595242 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Apr 24 00:22:00.595247 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Apr 24 00:22:00.595340 kernel: NX (Execute Disable) protection: active Apr 24 00:22:00.595346 kernel: APIC: Static calls initialized Apr 24 00:22:00.595354 kernel: e820: update [mem 0x9a143018-0x9a14cc57] usable ==> usable Apr 24 00:22:00.595359 kernel: e820: update [mem 0x9a106018-0x9a142e57] usable ==> usable Apr 24 00:22:00.595364 kernel: extended physical RAM map: Apr 24 00:22:00.595369 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000002ffff] usable Apr 24 00:22:00.595374 kernel: reserve setup_data: [mem 0x0000000000030000-0x000000000004ffff] reserved Apr 24 00:22:00.595379 kernel: reserve setup_data: [mem 0x0000000000050000-0x000000000009efff] usable Apr 24 00:22:00.595384 kernel: reserve setup_data: [mem 0x000000000009f000-0x000000000009ffff] reserved Apr 24 00:22:00.595389 kernel: reserve setup_data: [mem 0x0000000000100000-0x000000009a106017] usable Apr 24 00:22:00.595393 kernel: reserve setup_data: [mem 0x000000009a106018-0x000000009a142e57] usable Apr 24 00:22:00.595398 kernel: reserve setup_data: [mem 0x000000009a142e58-0x000000009a143017] usable Apr 24 00:22:00.595403 kernel: reserve setup_data: [mem 0x000000009a143018-0x000000009a14cc57] usable Apr 24 00:22:00.595409 kernel: reserve setup_data: [mem 0x000000009a14cc58-0x000000009b8ecfff] usable Apr 24 00:22:00.595414 kernel: reserve setup_data: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Apr 24 00:22:00.595419 kernel: reserve setup_data: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Apr 24 00:22:00.595424 kernel: reserve setup_data: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Apr 24 00:22:00.595429 kernel: reserve setup_data: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Apr 24 00:22:00.595434 kernel: reserve setup_data: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Apr 24 00:22:00.595438 kernel: reserve setup_data: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Apr 24 00:22:00.595443 kernel: reserve setup_data: [mem 0x000000009bfb7000-0x000000009bffffff] usable Apr 24 00:22:00.595448 kernel: reserve setup_data: [mem 0x000000009c000000-0x000000009cffffff] reserved Apr 24 00:22:00.595457 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Apr 24 00:22:00.595462 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Apr 24 00:22:00.595467 kernel: efi: EFI v2.7 by EDK II Apr 24 00:22:00.595473 kernel: efi: SMBIOS=0x9b9d5000 ACPI=0x9bb7e000 ACPI 2.0=0x9bb7e014 MEMATTR=0x9a1b4018 RNG=0x9bb73018 Apr 24 00:22:00.595478 kernel: random: crng init done Apr 24 00:22:00.595483 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Apr 24 00:22:00.595490 kernel: secureboot: Secure boot enabled Apr 24 00:22:00.595495 kernel: SMBIOS 2.8 present. Apr 24 00:22:00.595500 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Apr 24 00:22:00.595505 kernel: DMI: Memory slots populated: 1/1 Apr 24 00:22:00.595510 kernel: Hypervisor detected: KVM Apr 24 00:22:00.595515 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x10000000000 Apr 24 00:22:00.595520 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Apr 24 00:22:00.595525 kernel: kvm-clock: using sched offset of 28386126932 cycles Apr 24 00:22:00.595531 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Apr 24 00:22:00.595580 kernel: tsc: Detected 2793.438 MHz processor Apr 24 00:22:00.595588 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Apr 24 00:22:00.595596 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Apr 24 00:22:00.595646 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x10000000000 Apr 24 00:22:00.595655 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Apr 24 00:22:00.595663 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Apr 24 00:22:00.595673 kernel: Using GB pages for direct mapping Apr 24 00:22:00.595737 kernel: ACPI: Early table checksum verification disabled Apr 24 00:22:00.595794 kernel: ACPI: RSDP 0x000000009BB7E014 000024 (v02 BOCHS ) Apr 24 00:22:00.595802 kernel: ACPI: XSDT 0x000000009BB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Apr 24 00:22:00.595807 kernel: ACPI: FACP 0x000000009BB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595816 kernel: ACPI: DSDT 0x000000009BB7A000 002237 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595821 kernel: ACPI: FACS 0x000000009BBDD000 000040 Apr 24 00:22:00.595827 kernel: ACPI: APIC 0x000000009BB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595832 kernel: ACPI: HPET 0x000000009BB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595838 kernel: ACPI: MCFG 0x000000009BB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595843 kernel: ACPI: WAET 0x000000009BB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 24 00:22:00.595849 kernel: ACPI: BGRT 0x000000009BB74000 000038 (v01 INTEL EDK2 00000002 01000013) Apr 24 00:22:00.595854 kernel: ACPI: Reserving FACP table memory at [mem 0x9bb79000-0x9bb790f3] Apr 24 00:22:00.595859 kernel: ACPI: Reserving DSDT table memory at [mem 0x9bb7a000-0x9bb7c236] Apr 24 00:22:00.595866 kernel: ACPI: Reserving FACS table memory at [mem 0x9bbdd000-0x9bbdd03f] Apr 24 00:22:00.595872 kernel: ACPI: Reserving APIC table memory at [mem 0x9bb78000-0x9bb7808f] Apr 24 00:22:00.595877 kernel: ACPI: Reserving HPET table memory at [mem 0x9bb77000-0x9bb77037] Apr 24 00:22:00.595882 kernel: ACPI: Reserving MCFG table memory at [mem 0x9bb76000-0x9bb7603b] Apr 24 00:22:00.595887 kernel: ACPI: Reserving WAET table memory at [mem 0x9bb75000-0x9bb75027] Apr 24 00:22:00.595893 kernel: ACPI: Reserving BGRT table memory at [mem 0x9bb74000-0x9bb74037] Apr 24 00:22:00.595898 kernel: No NUMA configuration found Apr 24 00:22:00.595904 kernel: Faking a node at [mem 0x0000000000000000-0x000000009bffffff] Apr 24 00:22:00.595909 kernel: NODE_DATA(0) allocated [mem 0x9bf57dc0-0x9bf5efff] Apr 24 00:22:00.595916 kernel: Zone ranges: Apr 24 00:22:00.595921 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Apr 24 00:22:00.595927 kernel: DMA32 [mem 0x0000000001000000-0x000000009bffffff] Apr 24 00:22:00.595932 kernel: Normal empty Apr 24 00:22:00.595937 kernel: Device empty Apr 24 00:22:00.595942 kernel: Movable zone start for each node Apr 24 00:22:00.595947 kernel: Early memory node ranges Apr 24 00:22:00.595953 kernel: node 0: [mem 0x0000000000001000-0x000000000002ffff] Apr 24 00:22:00.595958 kernel: node 0: [mem 0x0000000000050000-0x000000000009efff] Apr 24 00:22:00.595963 kernel: node 0: [mem 0x0000000000100000-0x000000009b8ecfff] Apr 24 00:22:00.595971 kernel: node 0: [mem 0x000000009bbff000-0x000000009bfb0fff] Apr 24 00:22:00.595980 kernel: node 0: [mem 0x000000009bfb7000-0x000000009bffffff] Apr 24 00:22:00.595988 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009bffffff] Apr 24 00:22:00.595997 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Apr 24 00:22:00.596005 kernel: On node 0, zone DMA: 32 pages in unavailable ranges Apr 24 00:22:00.596013 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Apr 24 00:22:00.596022 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Apr 24 00:22:00.596031 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Apr 24 00:22:00.596039 kernel: On node 0, zone DMA32: 16384 pages in unavailable ranges Apr 24 00:22:00.596051 kernel: ACPI: PM-Timer IO Port: 0x608 Apr 24 00:22:00.596061 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Apr 24 00:22:00.596069 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Apr 24 00:22:00.596074 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Apr 24 00:22:00.596080 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Apr 24 00:22:00.596085 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Apr 24 00:22:00.596136 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Apr 24 00:22:00.596142 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Apr 24 00:22:00.596148 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Apr 24 00:22:00.596155 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Apr 24 00:22:00.596161 kernel: TSC deadline timer available Apr 24 00:22:00.596166 kernel: CPU topo: Max. logical packages: 1 Apr 24 00:22:00.596171 kernel: CPU topo: Max. logical dies: 1 Apr 24 00:22:00.596176 kernel: CPU topo: Max. dies per package: 1 Apr 24 00:22:00.596182 kernel: CPU topo: Max. threads per core: 1 Apr 24 00:22:00.596193 kernel: CPU topo: Num. cores per package: 4 Apr 24 00:22:00.596200 kernel: CPU topo: Num. threads per package: 4 Apr 24 00:22:00.596205 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Apr 24 00:22:00.596211 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Apr 24 00:22:00.596417 kernel: kvm-guest: KVM setup pv remote TLB flush Apr 24 00:22:00.596431 kernel: kvm-guest: setup PV sched yield Apr 24 00:22:00.596445 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Apr 24 00:22:00.596454 kernel: Booting paravirtualized kernel on KVM Apr 24 00:22:00.596465 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Apr 24 00:22:00.596475 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Apr 24 00:22:00.596484 kernel: percpu: Embedded 60 pages/cpu s207448 r8192 d30120 u524288 Apr 24 00:22:00.596497 kernel: pcpu-alloc: s207448 r8192 d30120 u524288 alloc=1*2097152 Apr 24 00:22:00.596506 kernel: pcpu-alloc: [0] 0 1 2 3 Apr 24 00:22:00.596515 kernel: kvm-guest: PV spinlocks enabled Apr 24 00:22:00.596525 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Apr 24 00:22:00.596536 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=35bf60e399c7fbdab9d27e362bd719e7cadd795a3fa26a4f30de01ccc70fba7e Apr 24 00:22:00.596547 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 24 00:22:00.596557 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 24 00:22:00.596568 kernel: Fallback order for Node 0: 0 Apr 24 00:22:00.596576 kernel: Built 1 zonelists, mobility grouping on. Total pages: 638054 Apr 24 00:22:00.596581 kernel: Policy zone: DMA32 Apr 24 00:22:00.596587 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 24 00:22:00.596593 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 24 00:22:00.596599 kernel: ftrace: allocating 40126 entries in 157 pages Apr 24 00:22:00.596605 kernel: ftrace: allocated 157 pages with 5 groups Apr 24 00:22:00.596611 kernel: Dynamic Preempt: voluntary Apr 24 00:22:00.596617 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 24 00:22:00.596623 kernel: rcu: RCU event tracing is enabled. Apr 24 00:22:00.596631 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 24 00:22:00.596637 kernel: Trampoline variant of Tasks RCU enabled. Apr 24 00:22:00.596643 kernel: Rude variant of Tasks RCU enabled. Apr 24 00:22:00.596648 kernel: Tracing variant of Tasks RCU enabled. Apr 24 00:22:00.596654 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 24 00:22:00.596660 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 24 00:22:00.596666 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 24 00:22:00.596672 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 24 00:22:00.596678 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 24 00:22:00.596741 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Apr 24 00:22:00.596747 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 24 00:22:00.596753 kernel: Console: colour dummy device 80x25 Apr 24 00:22:00.596759 kernel: printk: legacy console [ttyS0] enabled Apr 24 00:22:00.596765 kernel: ACPI: Core revision 20240827 Apr 24 00:22:00.596771 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Apr 24 00:22:00.596777 kernel: APIC: Switch to symmetric I/O mode setup Apr 24 00:22:00.596783 kernel: x2apic enabled Apr 24 00:22:00.596789 kernel: APIC: Switched APIC routing to: physical x2apic Apr 24 00:22:00.596797 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Apr 24 00:22:00.596803 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Apr 24 00:22:00.596809 kernel: kvm-guest: setup PV IPIs Apr 24 00:22:00.596814 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Apr 24 00:22:00.596820 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 24 00:22:00.596827 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Apr 24 00:22:00.596833 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Apr 24 00:22:00.596838 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Apr 24 00:22:00.596844 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Apr 24 00:22:00.596852 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Apr 24 00:22:00.596858 kernel: Spectre V2 : Mitigation: Retpolines Apr 24 00:22:00.596864 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Apr 24 00:22:00.596913 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Apr 24 00:22:00.596919 kernel: RETBleed: Vulnerable Apr 24 00:22:00.596925 kernel: Speculative Store Bypass: Vulnerable Apr 24 00:22:00.596931 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Apr 24 00:22:00.596937 kernel: GDS: Unknown: Dependent on hypervisor status Apr 24 00:22:00.596945 kernel: active return thunk: its_return_thunk Apr 24 00:22:00.596950 kernel: ITS: Mitigation: Aligned branch/return thunks Apr 24 00:22:00.596956 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Apr 24 00:22:00.596962 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Apr 24 00:22:00.596968 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Apr 24 00:22:00.596976 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Apr 24 00:22:00.596986 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Apr 24 00:22:00.596996 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Apr 24 00:22:00.597004 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Apr 24 00:22:00.597015 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Apr 24 00:22:00.597025 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Apr 24 00:22:00.597035 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Apr 24 00:22:00.597043 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Apr 24 00:22:00.597053 kernel: Freeing SMP alternatives memory: 32K Apr 24 00:22:00.597063 kernel: pid_max: default: 32768 minimum: 301 Apr 24 00:22:00.597080 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Apr 24 00:22:00.597086 kernel: landlock: Up and running. Apr 24 00:22:00.597091 kernel: SELinux: Initializing. Apr 24 00:22:00.597100 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 24 00:22:00.597105 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 24 00:22:00.597111 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Apr 24 00:22:00.597164 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Apr 24 00:22:00.597171 kernel: signal: max sigframe size: 3632 Apr 24 00:22:00.597176 kernel: rcu: Hierarchical SRCU implementation. Apr 24 00:22:00.597182 kernel: rcu: Max phase no-delay instances is 400. Apr 24 00:22:00.597189 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Apr 24 00:22:00.597194 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Apr 24 00:22:00.597202 kernel: smp: Bringing up secondary CPUs ... Apr 24 00:22:00.597208 kernel: smpboot: x86: Booting SMP configuration: Apr 24 00:22:00.597214 kernel: .... node #0, CPUs: #1 #2 #3 Apr 24 00:22:00.597220 kernel: smp: Brought up 1 node, 4 CPUs Apr 24 00:22:00.597226 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Apr 24 00:22:00.597233 kernel: Memory: 2357264K/2552216K available (14336K kernel code, 2453K rwdata, 26076K rodata, 46224K init, 2524K bss, 189064K reserved, 0K cma-reserved) Apr 24 00:22:00.597239 kernel: devtmpfs: initialized Apr 24 00:22:00.597245 kernel: x86/mm: Memory block size: 128MB Apr 24 00:22:00.597251 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bb7f000-0x9bbfefff] (524288 bytes) Apr 24 00:22:00.597348 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bfb5000-0x9bfb6fff] (8192 bytes) Apr 24 00:22:00.597355 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 24 00:22:00.597361 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 24 00:22:00.597367 kernel: pinctrl core: initialized pinctrl subsystem Apr 24 00:22:00.597372 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 24 00:22:00.597378 kernel: audit: initializing netlink subsys (disabled) Apr 24 00:22:00.597384 kernel: audit: type=2000 audit(1776990110.291:1): state=initialized audit_enabled=0 res=1 Apr 24 00:22:00.597390 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 24 00:22:00.597395 kernel: thermal_sys: Registered thermal governor 'user_space' Apr 24 00:22:00.597403 kernel: cpuidle: using governor menu Apr 24 00:22:00.597409 kernel: efi: Freeing EFI boot services memory: 42796K Apr 24 00:22:00.597415 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 24 00:22:00.597421 kernel: dca service started, version 1.12.1 Apr 24 00:22:00.597427 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Apr 24 00:22:00.597433 kernel: PCI: Using configuration type 1 for base access Apr 24 00:22:00.597438 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Apr 24 00:22:00.597444 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 24 00:22:00.597492 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Apr 24 00:22:00.597500 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 24 00:22:00.597506 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Apr 24 00:22:00.597512 kernel: ACPI: Added _OSI(Module Device) Apr 24 00:22:00.597518 kernel: ACPI: Added _OSI(Processor Device) Apr 24 00:22:00.597523 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 24 00:22:00.597529 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 24 00:22:00.597535 kernel: ACPI: Interpreter enabled Apr 24 00:22:00.597541 kernel: ACPI: PM: (supports S0 S5) Apr 24 00:22:00.597546 kernel: ACPI: Using IOAPIC for interrupt routing Apr 24 00:22:00.597554 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Apr 24 00:22:00.597560 kernel: PCI: Using E820 reservations for host bridge windows Apr 24 00:22:00.597566 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Apr 24 00:22:00.597571 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 24 00:22:00.598771 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 24 00:22:00.598880 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Apr 24 00:22:00.598961 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Apr 24 00:22:00.598978 kernel: PCI host bridge to bus 0000:00 Apr 24 00:22:00.599402 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Apr 24 00:22:00.599499 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Apr 24 00:22:00.599573 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Apr 24 00:22:00.599646 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Apr 24 00:22:00.599716 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Apr 24 00:22:00.599791 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Apr 24 00:22:00.599847 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 24 00:22:00.600597 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Apr 24 00:22:00.600875 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Apr 24 00:22:00.600958 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Apr 24 00:22:00.601086 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Apr 24 00:22:00.601448 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Apr 24 00:22:00.601560 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Apr 24 00:22:00.601763 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Apr 24 00:22:00.601848 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Apr 24 00:22:00.601918 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Apr 24 00:22:00.601989 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Apr 24 00:22:00.602367 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Apr 24 00:22:00.602444 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Apr 24 00:22:00.602506 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Apr 24 00:22:00.602562 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Apr 24 00:22:00.602900 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Apr 24 00:22:00.602962 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Apr 24 00:22:00.603017 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Apr 24 00:22:00.603073 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Apr 24 00:22:00.603130 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Apr 24 00:22:00.603244 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Apr 24 00:22:00.603417 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Apr 24 00:22:00.603531 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Apr 24 00:22:00.603591 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Apr 24 00:22:00.603647 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Apr 24 00:22:00.603804 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Apr 24 00:22:00.603863 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Apr 24 00:22:00.603875 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Apr 24 00:22:00.603881 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Apr 24 00:22:00.603887 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Apr 24 00:22:00.603893 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Apr 24 00:22:00.603899 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Apr 24 00:22:00.603905 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Apr 24 00:22:00.603911 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Apr 24 00:22:00.603917 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Apr 24 00:22:00.603925 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Apr 24 00:22:00.603931 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Apr 24 00:22:00.603937 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Apr 24 00:22:00.603943 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Apr 24 00:22:00.603949 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Apr 24 00:22:00.603955 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Apr 24 00:22:00.603961 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Apr 24 00:22:00.603967 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Apr 24 00:22:00.603973 kernel: iommu: Default domain type: Translated Apr 24 00:22:00.603980 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Apr 24 00:22:00.603986 kernel: efivars: Registered efivars operations Apr 24 00:22:00.603992 kernel: PCI: Using ACPI for IRQ routing Apr 24 00:22:00.603998 kernel: PCI: pci_cache_line_size set to 64 bytes Apr 24 00:22:00.604004 kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Apr 24 00:22:00.604010 kernel: e820: reserve RAM buffer [mem 0x9a106018-0x9bffffff] Apr 24 00:22:00.604016 kernel: e820: reserve RAM buffer [mem 0x9a143018-0x9bffffff] Apr 24 00:22:00.604021 kernel: e820: reserve RAM buffer [mem 0x9b8ed000-0x9bffffff] Apr 24 00:22:00.604027 kernel: e820: reserve RAM buffer [mem 0x9bfb1000-0x9bffffff] Apr 24 00:22:00.604082 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Apr 24 00:22:00.604140 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Apr 24 00:22:00.604195 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Apr 24 00:22:00.604202 kernel: vgaarb: loaded Apr 24 00:22:00.604208 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Apr 24 00:22:00.604214 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Apr 24 00:22:00.604220 kernel: clocksource: Switched to clocksource kvm-clock Apr 24 00:22:00.604226 kernel: VFS: Disk quotas dquot_6.6.0 Apr 24 00:22:00.604232 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 24 00:22:00.604240 kernel: pnp: PnP ACPI init Apr 24 00:22:00.604516 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Apr 24 00:22:00.604528 kernel: pnp: PnP ACPI: found 6 devices Apr 24 00:22:00.604534 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Apr 24 00:22:00.604540 kernel: NET: Registered PF_INET protocol family Apr 24 00:22:00.604547 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 24 00:22:00.604553 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 24 00:22:00.604559 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 24 00:22:00.604568 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 24 00:22:00.604574 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 24 00:22:00.604580 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 24 00:22:00.604586 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 24 00:22:00.604592 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 24 00:22:00.604598 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 24 00:22:00.604604 kernel: NET: Registered PF_XDP protocol family Apr 24 00:22:00.604666 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Apr 24 00:22:00.604727 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Apr 24 00:22:00.604784 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Apr 24 00:22:00.604836 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Apr 24 00:22:00.604887 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Apr 24 00:22:00.604995 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Apr 24 00:22:00.605048 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Apr 24 00:22:00.605098 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Apr 24 00:22:00.605106 kernel: PCI: CLS 0 bytes, default 64 Apr 24 00:22:00.605112 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Apr 24 00:22:00.605120 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Apr 24 00:22:00.605126 kernel: Initialise system trusted keyrings Apr 24 00:22:00.605132 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 24 00:22:00.605138 kernel: Key type asymmetric registered Apr 24 00:22:00.605144 kernel: Asymmetric key parser 'x509' registered Apr 24 00:22:00.605150 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 24 00:22:00.605156 kernel: io scheduler mq-deadline registered Apr 24 00:22:00.605173 kernel: io scheduler kyber registered Apr 24 00:22:00.605182 kernel: io scheduler bfq registered Apr 24 00:22:00.605188 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Apr 24 00:22:00.605194 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Apr 24 00:22:00.605200 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Apr 24 00:22:00.605206 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Apr 24 00:22:00.605212 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 24 00:22:00.605218 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Apr 24 00:22:00.605225 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Apr 24 00:22:00.605231 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Apr 24 00:22:00.605238 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Apr 24 00:22:00.605245 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Apr 24 00:22:00.605596 kernel: rtc_cmos 00:04: RTC can wake from S4 Apr 24 00:22:00.605657 kernel: rtc_cmos 00:04: registered as rtc0 Apr 24 00:22:00.605710 kernel: rtc_cmos 00:04: setting system clock to 2026-04-24T00:21:59 UTC (1776990119) Apr 24 00:22:00.605762 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Apr 24 00:22:00.605769 kernel: intel_pstate: CPU model not supported Apr 24 00:22:00.605775 kernel: efifb: probing for efifb Apr 24 00:22:00.605785 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Apr 24 00:22:00.605791 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Apr 24 00:22:00.605797 kernel: efifb: scrolling: redraw Apr 24 00:22:00.605803 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Apr 24 00:22:00.605810 kernel: Console: switching to colour frame buffer device 160x50 Apr 24 00:22:00.605818 kernel: fb0: EFI VGA frame buffer device Apr 24 00:22:00.605825 kernel: pstore: Using crash dump compression: deflate Apr 24 00:22:00.605831 kernel: pstore: Registered efi_pstore as persistent store backend Apr 24 00:22:00.605837 kernel: NET: Registered PF_INET6 protocol family Apr 24 00:22:00.605843 kernel: Segment Routing with IPv6 Apr 24 00:22:00.605850 kernel: In-situ OAM (IOAM) with IPv6 Apr 24 00:22:00.605856 kernel: NET: Registered PF_PACKET protocol family Apr 24 00:22:00.605862 kernel: Key type dns_resolver registered Apr 24 00:22:00.605868 kernel: IPI shorthand broadcast: enabled Apr 24 00:22:00.605874 kernel: sched_clock: Marking stable (8875185283, 2530630313)->(12177691059, -771875463) Apr 24 00:22:00.605882 kernel: registered taskstats version 1 Apr 24 00:22:00.605888 kernel: Loading compiled-in X.509 certificates Apr 24 00:22:00.605894 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.81-flatcar: 09f9b319c99eb3f54e68ef799fdb2bce5b238ec0' Apr 24 00:22:00.605900 kernel: Demotion targets for Node 0: null Apr 24 00:22:00.605906 kernel: Key type .fscrypt registered Apr 24 00:22:00.605913 kernel: Key type fscrypt-provisioning registered Apr 24 00:22:00.605919 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 24 00:22:00.605925 kernel: ima: Allocated hash algorithm: sha1 Apr 24 00:22:00.605931 kernel: ima: No architecture policies found Apr 24 00:22:00.605939 kernel: clk: Disabling unused clocks Apr 24 00:22:00.605945 kernel: Warning: unable to open an initial console. Apr 24 00:22:00.605951 kernel: Freeing unused kernel image (initmem) memory: 46224K Apr 24 00:22:00.605957 kernel: Write protecting the kernel read-only data: 40960k Apr 24 00:22:00.605963 kernel: Freeing unused kernel image (rodata/data gap) memory: 548K Apr 24 00:22:00.605969 kernel: Run /init as init process Apr 24 00:22:00.605975 kernel: with arguments: Apr 24 00:22:00.605982 kernel: /init Apr 24 00:22:00.605988 kernel: with environment: Apr 24 00:22:00.605996 kernel: HOME=/ Apr 24 00:22:00.606002 kernel: TERM=linux Apr 24 00:22:00.606055 systemd[1]: Successfully made /usr/ read-only. Apr 24 00:22:00.606066 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Apr 24 00:22:00.606073 systemd[1]: Detected virtualization kvm. Apr 24 00:22:00.606079 systemd[1]: Detected architecture x86-64. Apr 24 00:22:00.606085 systemd[1]: Running in initrd. Apr 24 00:22:00.606093 systemd[1]: No hostname configured, using default hostname. Apr 24 00:22:00.606100 systemd[1]: Hostname set to . Apr 24 00:22:00.606106 systemd[1]: Initializing machine ID from VM UUID. Apr 24 00:22:00.606113 systemd[1]: Queued start job for default target initrd.target. Apr 24 00:22:00.606119 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 00:22:00.606126 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 00:22:00.606133 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 24 00:22:00.606140 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 24 00:22:00.606148 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 24 00:22:00.606155 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 24 00:22:00.606162 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 24 00:22:00.606169 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 24 00:22:00.606176 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 00:22:00.606182 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 24 00:22:00.606188 systemd[1]: Reached target paths.target - Path Units. Apr 24 00:22:00.606196 systemd[1]: Reached target slices.target - Slice Units. Apr 24 00:22:00.606203 systemd[1]: Reached target swap.target - Swaps. Apr 24 00:22:00.606209 systemd[1]: Reached target timers.target - Timer Units. Apr 24 00:22:00.606216 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 24 00:22:00.606222 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 24 00:22:00.606228 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 24 00:22:00.606235 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Apr 24 00:22:00.606241 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 24 00:22:00.606249 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 24 00:22:00.606354 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 00:22:00.606361 systemd[1]: Reached target sockets.target - Socket Units. Apr 24 00:22:00.606368 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 24 00:22:00.606375 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 24 00:22:00.606381 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 24 00:22:00.606388 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Apr 24 00:22:00.606394 systemd[1]: Starting systemd-fsck-usr.service... Apr 24 00:22:00.606401 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 24 00:22:00.606409 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 24 00:22:00.606416 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:00.606422 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 24 00:22:00.606544 systemd-journald[203]: Collecting audit messages is disabled. Apr 24 00:22:00.606567 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 00:22:00.606575 systemd-journald[203]: Journal started Apr 24 00:22:00.606636 systemd-journald[203]: Runtime Journal (/run/log/journal/842c5c7892d04d54aa1939b31fae8943) is 5.9M, max 47.9M, 41.9M free. Apr 24 00:22:00.613389 systemd[1]: Started systemd-journald.service - Journal Service. Apr 24 00:22:00.618732 systemd[1]: Finished systemd-fsck-usr.service. Apr 24 00:22:00.622444 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 24 00:22:00.624520 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 24 00:22:00.648396 systemd-modules-load[204]: Inserted module 'overlay' Apr 24 00:22:00.672706 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:00.682803 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 24 00:22:00.743491 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 24 00:22:00.747733 systemd-modules-load[204]: Inserted module 'br_netfilter' Apr 24 00:22:00.756439 kernel: Bridge firewalling registered Apr 24 00:22:00.748637 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 24 00:22:00.755125 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 24 00:22:00.761216 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 24 00:22:00.763905 systemd-tmpfiles[213]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Apr 24 00:22:00.767325 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 00:22:00.788577 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 00:22:00.806076 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 24 00:22:00.806957 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 24 00:22:00.824408 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 24 00:22:00.842699 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 24 00:22:00.850506 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 00:22:00.861547 dracut-cmdline[239]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=35bf60e399c7fbdab9d27e362bd719e7cadd795a3fa26a4f30de01ccc70fba7e Apr 24 00:22:00.906159 systemd-resolved[244]: Positive Trust Anchors: Apr 24 00:22:00.906454 systemd-resolved[244]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 24 00:22:00.906479 systemd-resolved[244]: 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 24 00:22:00.914178 systemd-resolved[244]: Defaulting to hostname 'linux'. Apr 24 00:22:00.918564 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 24 00:22:00.941156 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 24 00:22:01.018474 kernel: SCSI subsystem initialized Apr 24 00:22:01.028373 kernel: Loading iSCSI transport class v2.0-870. Apr 24 00:22:01.057385 kernel: iscsi: registered transport (tcp) Apr 24 00:22:01.081617 kernel: iscsi: registered transport (qla4xxx) Apr 24 00:22:01.081648 kernel: QLogic iSCSI HBA Driver Apr 24 00:22:01.111048 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 24 00:22:01.136597 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 24 00:22:01.142774 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 24 00:22:01.207510 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 24 00:22:01.212769 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 24 00:22:01.280695 kernel: raid6: avx512x4 gen() 40492 MB/s Apr 24 00:22:01.299398 kernel: raid6: avx512x2 gen() 42055 MB/s Apr 24 00:22:01.318692 kernel: raid6: avx512x1 gen() 38349 MB/s Apr 24 00:22:01.336398 kernel: raid6: avx2x4 gen() 34940 MB/s Apr 24 00:22:01.354448 kernel: raid6: avx2x2 gen() 35298 MB/s Apr 24 00:22:01.375029 kernel: raid6: avx2x1 gen() 26676 MB/s Apr 24 00:22:01.375074 kernel: raid6: using algorithm avx512x2 gen() 42055 MB/s Apr 24 00:22:01.395842 kernel: raid6: .... xor() 29039 MB/s, rmw enabled Apr 24 00:22:01.395881 kernel: raid6: using avx512x2 recovery algorithm Apr 24 00:22:01.422494 kernel: xor: automatically using best checksumming function avx Apr 24 00:22:01.604448 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 24 00:22:01.615585 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 24 00:22:01.626585 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 00:22:01.661807 systemd-udevd[454]: Using default interface naming scheme 'v255'. Apr 24 00:22:01.667931 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 00:22:01.669090 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 24 00:22:01.708100 dracut-pre-trigger[456]: rd.md=0: removing MD RAID activation Apr 24 00:22:01.751049 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 24 00:22:01.756784 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 24 00:22:01.825916 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 00:22:01.831536 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 24 00:22:01.883623 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Apr 24 00:22:01.895690 kernel: cryptd: max_cpu_qlen set to 1000 Apr 24 00:22:01.912650 kernel: libata version 3.00 loaded. Apr 24 00:22:01.921410 kernel: ahci 0000:00:1f.2: version 3.0 Apr 24 00:22:01.924472 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Apr 24 00:22:01.928348 kernel: AES CTR mode by8 optimization enabled Apr 24 00:22:01.935408 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Apr 24 00:22:01.935585 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Apr 24 00:22:01.935666 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Apr 24 00:22:01.937122 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 24 00:22:01.955587 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Apr 24 00:22:01.955778 kernel: scsi host0: ahci Apr 24 00:22:01.955903 kernel: scsi host1: ahci Apr 24 00:22:01.955975 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 24 00:22:01.955984 kernel: GPT:9289727 != 19775487 Apr 24 00:22:01.955991 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 24 00:22:01.955999 kernel: scsi host2: ahci Apr 24 00:22:01.937346 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:01.967998 kernel: GPT:9289727 != 19775487 Apr 24 00:22:01.968015 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 24 00:22:01.968022 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 24 00:22:01.968030 kernel: scsi host3: ahci Apr 24 00:22:01.986403 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Apr 24 00:22:01.986467 kernel: scsi host4: ahci Apr 24 00:22:01.975920 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:02.035227 kernel: scsi host5: ahci Apr 24 00:22:02.035533 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 1 Apr 24 00:22:02.035545 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 1 Apr 24 00:22:02.035553 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 1 Apr 24 00:22:02.035566 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 1 Apr 24 00:22:02.035576 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 1 Apr 24 00:22:02.035587 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 1 Apr 24 00:22:01.997222 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:02.031632 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Apr 24 00:22:02.051466 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 24 00:22:02.075045 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 24 00:22:02.089092 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 24 00:22:02.094224 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 24 00:22:02.106220 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 24 00:22:02.113904 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 24 00:22:02.122197 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 24 00:22:02.122339 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:02.146652 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:02.156091 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:02.160703 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Apr 24 00:22:02.172390 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 24 00:22:02.172422 disk-uuid[640]: Primary Header is updated. Apr 24 00:22:02.172422 disk-uuid[640]: Secondary Entries is updated. Apr 24 00:22:02.172422 disk-uuid[640]: Secondary Header is updated. Apr 24 00:22:02.214737 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:02.320789 kernel: ata2: SATA link down (SStatus 0 SControl 300) Apr 24 00:22:02.321091 kernel: ata1: SATA link down (SStatus 0 SControl 300) Apr 24 00:22:02.325431 kernel: ata6: SATA link down (SStatus 0 SControl 300) Apr 24 00:22:02.329423 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Apr 24 00:22:02.329469 kernel: ata3.00: LPM support broken, forcing max_power Apr 24 00:22:02.334495 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Apr 24 00:22:02.334530 kernel: ata3.00: applying bridge limits Apr 24 00:22:02.337436 kernel: ata4: SATA link down (SStatus 0 SControl 300) Apr 24 00:22:02.344459 kernel: ata5: SATA link down (SStatus 0 SControl 300) Apr 24 00:22:02.344484 kernel: ata3.00: LPM support broken, forcing max_power Apr 24 00:22:02.348133 kernel: ata3.00: configured for UDMA/100 Apr 24 00:22:02.354481 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Apr 24 00:22:02.417903 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Apr 24 00:22:02.418129 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 24 00:22:02.436400 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Apr 24 00:22:02.721176 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 24 00:22:02.726436 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 24 00:22:02.734764 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 00:22:02.743707 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 24 00:22:02.752624 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 24 00:22:02.796417 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 24 00:22:03.209491 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 24 00:22:03.210664 disk-uuid[641]: The operation has completed successfully. Apr 24 00:22:03.239147 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 24 00:22:03.239449 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 24 00:22:03.278471 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 24 00:22:03.305672 sh[686]: Success Apr 24 00:22:03.338538 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 24 00:22:03.338602 kernel: device-mapper: uevent: version 1.0.3 Apr 24 00:22:03.342488 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Apr 24 00:22:03.360414 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Apr 24 00:22:03.397083 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 24 00:22:03.408150 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 24 00:22:03.427136 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 24 00:22:03.445455 kernel: BTRFS: device fsid b0afcb9a-4dc6-42cc-b61f-b370046a03ca devid 1 transid 32 /dev/mapper/usr (253:0) scanned by mount (698) Apr 24 00:22:03.445683 kernel: BTRFS info (device dm-0): first mount of filesystem b0afcb9a-4dc6-42cc-b61f-b370046a03ca Apr 24 00:22:03.454447 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Apr 24 00:22:03.468487 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Apr 24 00:22:03.468524 kernel: BTRFS info (device dm-0 state E): enabling free space tree Apr 24 00:22:03.470076 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 24 00:22:03.470832 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Apr 24 00:22:03.476747 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 24 00:22:03.477658 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 24 00:22:03.511015 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 24 00:22:03.545521 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (727) Apr 24 00:22:03.554980 kernel: BTRFS info (device vda6): first mount of filesystem 198e7c3b-b6f6-48f6-8d3f-d053e5a12995 Apr 24 00:22:03.555021 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 24 00:22:03.569454 kernel: BTRFS info (device vda6): turning on async discard Apr 24 00:22:03.569528 kernel: BTRFS info (device vda6): enabling free space tree Apr 24 00:22:03.583734 kernel: BTRFS info (device vda6): last unmount of filesystem 198e7c3b-b6f6-48f6-8d3f-d053e5a12995 Apr 24 00:22:03.587053 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 24 00:22:03.596678 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 24 00:22:03.709078 ignition[785]: Ignition 2.22.0 Apr 24 00:22:03.709089 ignition[785]: Stage: fetch-offline Apr 24 00:22:03.709113 ignition[785]: no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:03.709123 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:03.709197 ignition[785]: parsed url from cmdline: "" Apr 24 00:22:03.709200 ignition[785]: no config URL provided Apr 24 00:22:03.709203 ignition[785]: reading system config file "/usr/lib/ignition/user.ign" Apr 24 00:22:03.709208 ignition[785]: no config at "/usr/lib/ignition/user.ign" Apr 24 00:22:03.730052 unknown[785]: fetched base config from "system" Apr 24 00:22:03.711897 ignition[785]: op(1): [started] loading QEMU firmware config module Apr 24 00:22:03.730058 unknown[785]: fetched user config from "qemu" Apr 24 00:22:03.711902 ignition[785]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 24 00:22:03.732096 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 24 00:22:03.726672 ignition[785]: op(1): [finished] loading QEMU firmware config module Apr 24 00:22:03.745151 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 24 00:22:03.726686 ignition[785]: QEMU firmware config was not found. Ignoring... Apr 24 00:22:03.755250 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 24 00:22:03.727158 ignition[785]: parsing config with SHA512: 05711458fad7c23f02cc9cbea5e773aa6ff730b1f8aaa6ca24ccb7b7ed3a8ac0558307d34ca8a091ce6871bce0e1ee963e4099ad2c9bd214a7b740df2ebc3aab Apr 24 00:22:03.730251 ignition[785]: fetch-offline: fetch-offline passed Apr 24 00:22:03.730453 ignition[785]: Ignition finished successfully Apr 24 00:22:03.821819 systemd-networkd[876]: lo: Link UP Apr 24 00:22:03.821857 systemd-networkd[876]: lo: Gained carrier Apr 24 00:22:03.823696 systemd-networkd[876]: Enumeration completed Apr 24 00:22:03.823951 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 24 00:22:03.825730 systemd-networkd[876]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 00:22:03.825733 systemd-networkd[876]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 24 00:22:03.827984 systemd-networkd[876]: eth0: Link UP Apr 24 00:22:03.828414 systemd-networkd[876]: eth0: Gained carrier Apr 24 00:22:03.828422 systemd-networkd[876]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 00:22:03.830441 systemd[1]: Reached target network.target - Network. Apr 24 00:22:03.834979 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 24 00:22:03.840627 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 24 00:22:03.892526 systemd-networkd[876]: eth0: DHCPv4 address 10.0.0.81/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 24 00:22:03.924411 ignition[879]: Ignition 2.22.0 Apr 24 00:22:03.924451 ignition[879]: Stage: kargs Apr 24 00:22:03.924550 ignition[879]: no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:03.924557 ignition[879]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:03.925068 ignition[879]: kargs: kargs passed Apr 24 00:22:03.925099 ignition[879]: Ignition finished successfully Apr 24 00:22:03.943650 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 24 00:22:03.944830 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 24 00:22:03.992592 ignition[888]: Ignition 2.22.0 Apr 24 00:22:03.992643 ignition[888]: Stage: disks Apr 24 00:22:03.992756 ignition[888]: no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:03.992763 ignition[888]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:03.995534 ignition[888]: disks: disks passed Apr 24 00:22:03.995570 ignition[888]: Ignition finished successfully Apr 24 00:22:04.011469 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 24 00:22:04.011758 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 24 00:22:04.024449 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 24 00:22:04.028622 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 24 00:22:04.037868 systemd[1]: Reached target sysinit.target - System Initialization. Apr 24 00:22:04.045231 systemd[1]: Reached target basic.target - Basic System. Apr 24 00:22:04.054145 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 24 00:22:04.106233 systemd-fsck[898]: ROOT: clean, 15/553520 files, 52789/553472 blocks Apr 24 00:22:04.112415 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 24 00:22:04.122798 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 24 00:22:04.298429 kernel: EXT4-fs (vda9): mounted filesystem 8c3ace63-1728-4b5e-a7b6-4ef650e41ba1 r/w with ordered data mode. Quota mode: none. Apr 24 00:22:04.298868 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 24 00:22:04.299668 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 24 00:22:04.306513 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 24 00:22:04.330115 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 24 00:22:04.342462 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (906) Apr 24 00:22:04.334006 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 24 00:22:04.363113 kernel: BTRFS info (device vda6): first mount of filesystem 198e7c3b-b6f6-48f6-8d3f-d053e5a12995 Apr 24 00:22:04.363130 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 24 00:22:04.334041 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 24 00:22:04.334060 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 24 00:22:04.390222 kernel: BTRFS info (device vda6): turning on async discard Apr 24 00:22:04.390243 kernel: BTRFS info (device vda6): enabling free space tree Apr 24 00:22:04.357558 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 24 00:22:04.367597 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 24 00:22:04.400000 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 24 00:22:04.435763 initrd-setup-root[930]: cut: /sysroot/etc/passwd: No such file or directory Apr 24 00:22:04.443046 initrd-setup-root[937]: cut: /sysroot/etc/group: No such file or directory Apr 24 00:22:04.453980 initrd-setup-root[944]: cut: /sysroot/etc/shadow: No such file or directory Apr 24 00:22:04.463758 initrd-setup-root[951]: cut: /sysroot/etc/gshadow: No such file or directory Apr 24 00:22:04.603728 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 24 00:22:04.605413 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 24 00:22:04.633853 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 24 00:22:04.644155 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 24 00:22:04.651220 kernel: BTRFS info (device vda6): last unmount of filesystem 198e7c3b-b6f6-48f6-8d3f-d053e5a12995 Apr 24 00:22:04.689870 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 24 00:22:04.701843 ignition[1019]: INFO : Ignition 2.22.0 Apr 24 00:22:04.701843 ignition[1019]: INFO : Stage: mount Apr 24 00:22:04.707442 ignition[1019]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:04.707442 ignition[1019]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:04.707442 ignition[1019]: INFO : mount: mount passed Apr 24 00:22:04.707442 ignition[1019]: INFO : Ignition finished successfully Apr 24 00:22:04.723772 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 24 00:22:04.731693 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 24 00:22:04.770945 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 24 00:22:04.803691 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1032) Apr 24 00:22:04.811594 kernel: BTRFS info (device vda6): first mount of filesystem 198e7c3b-b6f6-48f6-8d3f-d053e5a12995 Apr 24 00:22:04.811628 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Apr 24 00:22:04.823498 kernel: BTRFS info (device vda6): turning on async discard Apr 24 00:22:04.823600 kernel: BTRFS info (device vda6): enabling free space tree Apr 24 00:22:04.825854 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 24 00:22:04.881608 ignition[1049]: INFO : Ignition 2.22.0 Apr 24 00:22:04.881608 ignition[1049]: INFO : Stage: files Apr 24 00:22:04.881608 ignition[1049]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:04.881608 ignition[1049]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:04.897535 ignition[1049]: DEBUG : files: compiled without relabeling support, skipping Apr 24 00:22:04.897535 ignition[1049]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 24 00:22:04.897535 ignition[1049]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.8-x86-64.raw" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.8-x86-64.raw" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.8-x86-64.raw" Apr 24 00:22:04.913927 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.33.8-x86-64.raw: attempt #1 Apr 24 00:22:04.898732 unknown[1049]: wrote ssh authorized keys file for user: core Apr 24 00:22:05.082848 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Apr 24 00:22:05.347754 systemd-networkd[876]: eth0: Gained IPv6LL Apr 24 00:22:05.395765 ignition[1049]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.8-x86-64.raw" Apr 24 00:22:05.395765 ignition[1049]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Apr 24 00:22:05.410602 ignition[1049]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 24 00:22:05.418987 ignition[1049]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 24 00:22:05.418987 ignition[1049]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Apr 24 00:22:05.418987 ignition[1049]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Apr 24 00:22:05.450105 ignition[1049]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Apr 24 00:22:05.456698 ignition[1049]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Apr 24 00:22:05.456698 ignition[1049]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Apr 24 00:22:05.456698 ignition[1049]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 24 00:22:05.456698 ignition[1049]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 24 00:22:05.456698 ignition[1049]: INFO : files: files passed Apr 24 00:22:05.456698 ignition[1049]: INFO : Ignition finished successfully Apr 24 00:22:05.489416 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 24 00:22:05.494707 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 24 00:22:05.514722 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 24 00:22:05.519649 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 24 00:22:05.519867 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 24 00:22:05.553003 initrd-setup-root-after-ignition[1078]: grep: /sysroot/oem/oem-release: No such file or directory Apr 24 00:22:05.562085 initrd-setup-root-after-ignition[1080]: grep: Apr 24 00:22:05.565231 initrd-setup-root-after-ignition[1084]: grep: /sysroot/etc/flatcar/enabled-sysext.conf Apr 24 00:22:05.571163 initrd-setup-root-after-ignition[1080]: /sysroot/etc/flatcar/enabled-sysext.conf Apr 24 00:22:05.580764 initrd-setup-root-after-ignition[1084]: : No such file or directory Apr 24 00:22:05.572410 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 24 00:22:05.593521 initrd-setup-root-after-ignition[1080]: : No such file or directory Apr 24 00:22:05.580817 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 24 00:22:05.601540 initrd-setup-root-after-ignition[1080]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 24 00:22:05.607669 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 24 00:22:05.676678 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 24 00:22:05.676850 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 24 00:22:05.685545 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 24 00:22:05.690226 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 24 00:22:05.698431 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 24 00:22:05.707069 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 24 00:22:05.757926 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 24 00:22:05.759566 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 24 00:22:05.793214 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 24 00:22:05.798244 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 00:22:05.807027 systemd[1]: Stopped target timers.target - Timer Units. Apr 24 00:22:05.811460 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 24 00:22:05.811597 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 24 00:22:05.826802 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 24 00:22:05.831152 systemd[1]: Stopped target basic.target - Basic System. Apr 24 00:22:05.838683 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 24 00:22:05.845159 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 24 00:22:05.853071 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 24 00:22:05.869464 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Apr 24 00:22:05.873883 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 24 00:22:05.885364 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 24 00:22:05.890140 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 24 00:22:05.898576 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 24 00:22:05.905901 systemd[1]: Stopped target swap.target - Swaps. Apr 24 00:22:05.912536 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 24 00:22:05.912641 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 24 00:22:05.923047 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 24 00:22:05.930987 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 00:22:05.935008 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 24 00:22:05.935169 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 00:22:05.943752 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 24 00:22:05.943852 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 24 00:22:05.961835 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 24 00:22:05.962035 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 24 00:22:05.965771 systemd[1]: Stopped target paths.target - Path Units. Apr 24 00:22:05.977999 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 24 00:22:05.981525 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 00:22:05.981915 systemd[1]: Stopped target slices.target - Slice Units. Apr 24 00:22:05.994854 systemd[1]: Stopped target sockets.target - Socket Units. Apr 24 00:22:05.998013 systemd[1]: iscsid.socket: Deactivated successfully. Apr 24 00:22:05.998170 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 24 00:22:06.005465 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 24 00:22:06.005624 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 24 00:22:06.021398 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 24 00:22:06.021539 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 24 00:22:06.029145 systemd[1]: ignition-files.service: Deactivated successfully. Apr 24 00:22:06.029337 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 24 00:22:06.059536 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 24 00:22:06.066351 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 24 00:22:06.066533 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 00:22:06.086393 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 24 00:22:06.086540 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 24 00:22:06.086665 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 00:22:06.097648 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 24 00:22:06.097718 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 24 00:22:06.111767 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 24 00:22:06.125666 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 24 00:22:06.135559 ignition[1104]: INFO : Ignition 2.22.0 Apr 24 00:22:06.135559 ignition[1104]: INFO : Stage: umount Apr 24 00:22:06.135559 ignition[1104]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 00:22:06.135559 ignition[1104]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 24 00:22:06.135559 ignition[1104]: INFO : umount: umount passed Apr 24 00:22:06.135559 ignition[1104]: INFO : Ignition finished successfully Apr 24 00:22:06.159608 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 24 00:22:06.160618 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 24 00:22:06.160739 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 24 00:22:06.171830 systemd[1]: Stopped target network.target - Network. Apr 24 00:22:06.179533 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 24 00:22:06.179594 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 24 00:22:06.187541 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 24 00:22:06.187623 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 24 00:22:06.191018 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 24 00:22:06.191062 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 24 00:22:06.200764 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 24 00:22:06.200808 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 24 00:22:06.210785 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 24 00:22:06.216395 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 24 00:22:06.225605 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 24 00:22:06.225731 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 24 00:22:06.238128 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 24 00:22:06.238421 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 24 00:22:06.262730 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Apr 24 00:22:06.263931 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 24 00:22:06.263978 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 24 00:22:06.264179 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 24 00:22:06.264220 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 00:22:06.298647 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Apr 24 00:22:06.306412 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 24 00:22:06.306570 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 24 00:22:06.319569 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Apr 24 00:22:06.319790 systemd[1]: Stopped target network-pre.target - Preparation for Network. Apr 24 00:22:06.324726 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 24 00:22:06.324770 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 24 00:22:06.339502 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 24 00:22:06.349568 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 24 00:22:06.349621 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 24 00:22:06.349765 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 24 00:22:06.349796 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 24 00:22:06.375697 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 24 00:22:06.375738 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 24 00:22:06.378731 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 00:22:06.391866 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Apr 24 00:22:06.420081 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 24 00:22:06.433641 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 00:22:06.443732 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 24 00:22:06.443771 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 24 00:22:06.451647 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 24 00:22:06.451675 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 00:22:06.459531 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 24 00:22:06.459566 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 24 00:22:06.467429 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 24 00:22:06.467464 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 24 00:22:06.479897 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 24 00:22:06.479955 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 00:22:06.504954 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 24 00:22:06.505087 systemd[1]: systemd-network-generator.service: Deactivated successfully. Apr 24 00:22:06.505127 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Apr 24 00:22:06.528717 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 24 00:22:06.528821 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 00:22:06.537702 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 24 00:22:06.537756 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:06.556906 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 24 00:22:06.557587 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 24 00:22:06.564750 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 24 00:22:06.564806 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 24 00:22:06.576543 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 24 00:22:06.585613 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 24 00:22:06.616938 systemd[1]: Switching root. Apr 24 00:22:06.648635 systemd-journald[203]: Received SIGTERM from PID 1 (systemd). Apr 24 00:22:06.648830 systemd-journald[203]: Journal stopped Apr 24 00:22:07.958135 kernel: SELinux: policy capability network_peer_controls=1 Apr 24 00:22:07.958180 kernel: SELinux: policy capability open_perms=1 Apr 24 00:22:07.958190 kernel: SELinux: policy capability extended_socket_class=1 Apr 24 00:22:07.958198 kernel: SELinux: policy capability always_check_network=0 Apr 24 00:22:07.958206 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 24 00:22:07.958214 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 24 00:22:07.958222 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 24 00:22:07.959495 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 24 00:22:07.959509 kernel: SELinux: policy capability userspace_initial_context=0 Apr 24 00:22:07.959517 kernel: audit: type=1403 audit(1776990126.817:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 24 00:22:07.959530 systemd[1]: Successfully loaded SELinux policy in 83.015ms. Apr 24 00:22:07.959555 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.506ms. Apr 24 00:22:07.959564 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Apr 24 00:22:07.959573 systemd[1]: Detected virtualization kvm. Apr 24 00:22:07.959581 systemd[1]: Detected architecture x86-64. Apr 24 00:22:07.959632 systemd[1]: Detected first boot. Apr 24 00:22:07.959641 systemd[1]: Initializing machine ID from VM UUID. Apr 24 00:22:07.959649 zram_generator::config[1149]: No configuration found. Apr 24 00:22:07.959663 kernel: Guest personality initialized and is inactive Apr 24 00:22:07.959671 kernel: VMCI host device registered (name=vmci, major=10, minor=258) Apr 24 00:22:07.959679 kernel: Initialized host personality Apr 24 00:22:07.959687 kernel: NET: Registered PF_VSOCK protocol family Apr 24 00:22:07.959699 systemd[1]: Populated /etc with preset unit settings. Apr 24 00:22:07.959712 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Apr 24 00:22:07.959772 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 24 00:22:07.959786 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 24 00:22:07.959802 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 24 00:22:07.959815 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 24 00:22:07.959827 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 24 00:22:07.959840 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 24 00:22:07.959853 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 24 00:22:07.959867 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 24 00:22:07.959921 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 24 00:22:07.959930 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 24 00:22:07.959941 systemd[1]: Created slice user.slice - User and Session Slice. Apr 24 00:22:07.959954 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 00:22:07.959968 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 00:22:07.959983 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 24 00:22:07.959993 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 24 00:22:07.960003 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 24 00:22:07.960013 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 24 00:22:07.960060 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 24 00:22:07.960069 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 00:22:07.960078 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 24 00:22:07.960086 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 24 00:22:07.960095 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 24 00:22:07.960103 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 24 00:22:07.960111 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 24 00:22:07.960120 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 00:22:07.960163 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 24 00:22:07.960172 systemd[1]: Reached target slices.target - Slice Units. Apr 24 00:22:07.960181 systemd[1]: Reached target swap.target - Swaps. Apr 24 00:22:07.960189 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 24 00:22:07.960203 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 24 00:22:07.960211 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Apr 24 00:22:07.960220 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 24 00:22:07.960228 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 24 00:22:07.960237 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 00:22:07.960481 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 24 00:22:07.960494 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 24 00:22:07.960502 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 24 00:22:07.960510 systemd[1]: Mounting media.mount - External Media Directory... Apr 24 00:22:07.960519 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 24 00:22:07.960527 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 24 00:22:07.960535 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 24 00:22:07.960543 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 24 00:22:07.960552 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 24 00:22:07.960605 systemd[1]: Reached target machines.target - Containers. Apr 24 00:22:07.960613 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 24 00:22:07.960621 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 24 00:22:07.960630 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 24 00:22:07.960638 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 24 00:22:07.960648 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 24 00:22:07.960655 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 24 00:22:07.960664 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 24 00:22:07.960722 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 24 00:22:07.960732 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 24 00:22:07.960741 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 24 00:22:07.960750 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 24 00:22:07.960758 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 24 00:22:07.960766 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 24 00:22:07.960775 systemd[1]: Stopped systemd-fsck-usr.service. Apr 24 00:22:07.960784 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Apr 24 00:22:07.960830 kernel: ACPI: bus type drm_connector registered Apr 24 00:22:07.960839 kernel: fuse: init (API version 7.41) Apr 24 00:22:07.960847 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 24 00:22:07.960855 kernel: loop: module loaded Apr 24 00:22:07.960863 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 24 00:22:07.960893 systemd-journald[1234]: Collecting audit messages is disabled. Apr 24 00:22:07.960917 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 24 00:22:07.960975 systemd-journald[1234]: Journal started Apr 24 00:22:07.960994 systemd-journald[1234]: Runtime Journal (/run/log/journal/842c5c7892d04d54aa1939b31fae8943) is 5.9M, max 47.9M, 41.9M free. Apr 24 00:22:07.342070 systemd[1]: Queued start job for default target multi-user.target. Apr 24 00:22:07.356126 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Apr 24 00:22:07.356772 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 24 00:22:07.976499 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 24 00:22:07.987433 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Apr 24 00:22:07.997204 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 24 00:22:07.998162 systemd[1]: verity-setup.service: Deactivated successfully. Apr 24 00:22:07.998596 systemd[1]: Stopped verity-setup.service. Apr 24 00:22:08.012424 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 24 00:22:08.018395 systemd[1]: Started systemd-journald.service - Journal Service. Apr 24 00:22:08.018844 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 24 00:22:08.019119 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 24 00:22:08.022084 systemd[1]: Mounted media.mount - External Media Directory. Apr 24 00:22:08.024378 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 24 00:22:08.025028 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 24 00:22:08.027202 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 24 00:22:08.030415 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 24 00:22:08.031024 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 00:22:08.032467 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 24 00:22:08.032635 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 24 00:22:08.033066 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 24 00:22:08.033229 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 24 00:22:08.033764 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 24 00:22:08.033921 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 24 00:22:08.035178 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 24 00:22:08.035488 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 24 00:22:08.035882 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 24 00:22:08.036077 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 24 00:22:08.037502 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 24 00:22:08.037654 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 24 00:22:08.038030 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 24 00:22:08.039630 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 24 00:22:08.040163 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 24 00:22:08.046013 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 00:22:08.053850 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 24 00:22:08.055216 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 24 00:22:08.056207 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 24 00:22:08.056854 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 24 00:22:08.057003 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 24 00:22:08.059035 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Apr 24 00:22:08.066518 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 24 00:22:08.066887 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 24 00:22:08.068126 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 24 00:22:08.072529 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 24 00:22:08.074076 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 24 00:22:08.075690 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 24 00:22:08.076110 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 24 00:22:08.077500 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 24 00:22:08.079555 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 24 00:22:08.093490 systemd-journald[1234]: Time spent on flushing to /var/log/journal/842c5c7892d04d54aa1939b31fae8943 is 11.485ms for 1028 entries. Apr 24 00:22:08.093490 systemd-journald[1234]: System Journal (/var/log/journal/842c5c7892d04d54aa1939b31fae8943) is 8M, max 195.6M, 187.6M free. Apr 24 00:22:08.122605 systemd-journald[1234]: Received client request to flush runtime journal. Apr 24 00:22:08.122637 kernel: loop0: detected capacity change from 0 to 128560 Apr 24 00:22:08.128588 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 24 00:22:08.133124 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 24 00:22:08.135195 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 24 00:22:08.138992 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 24 00:22:08.140595 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 24 00:22:08.145142 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 24 00:22:08.155473 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Apr 24 00:22:08.192050 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 24 00:22:08.205040 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Apr 24 00:22:08.211090 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Apr 24 00:22:08.227058 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 24 00:22:08.234027 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 24 00:22:08.241967 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 24 00:22:08.257445 kernel: loop1: detected capacity change from 0 to 228704 Apr 24 00:22:08.284487 systemd-tmpfiles[1287]: ACLs are not supported, ignoring. Apr 24 00:22:08.284498 systemd-tmpfiles[1287]: ACLs are not supported, ignoring. Apr 24 00:22:08.289439 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 00:22:08.304402 kernel: loop2: detected capacity change from 0 to 110984 Apr 24 00:22:08.344386 kernel: loop3: detected capacity change from 0 to 128560 Apr 24 00:22:08.358474 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 24 00:22:08.365430 kernel: loop4: detected capacity change from 0 to 228704 Apr 24 00:22:08.388431 kernel: loop5: detected capacity change from 0 to 110984 Apr 24 00:22:08.406754 (sd-merge)[1293]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Apr 24 00:22:08.407602 (sd-merge)[1293]: Merged extensions into '/usr'. Apr 24 00:22:08.413474 systemd[1]: Reload requested from client PID 1267 ('systemd-sysext') (unit systemd-sysext.service)... Apr 24 00:22:08.413520 systemd[1]: Reloading... Apr 24 00:22:08.468391 zram_generator::config[1320]: No configuration found. Apr 24 00:22:08.507243 ldconfig[1262]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 24 00:22:08.630094 systemd[1]: Reloading finished in 216 ms. Apr 24 00:22:08.649534 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 24 00:22:08.655209 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 24 00:22:08.661457 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 24 00:22:08.687759 systemd[1]: Starting ensure-sysext.service... Apr 24 00:22:08.691778 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 24 00:22:08.712161 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 00:22:08.725242 systemd[1]: Reload requested from client PID 1357 ('systemctl') (unit ensure-sysext.service)... Apr 24 00:22:08.725416 systemd[1]: Reloading... Apr 24 00:22:08.730734 systemd-tmpfiles[1358]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Apr 24 00:22:08.730813 systemd-tmpfiles[1358]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Apr 24 00:22:08.730991 systemd-tmpfiles[1358]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 24 00:22:08.731145 systemd-tmpfiles[1358]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 24 00:22:08.731811 systemd-tmpfiles[1358]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 24 00:22:08.731959 systemd-tmpfiles[1358]: ACLs are not supported, ignoring. Apr 24 00:22:08.731994 systemd-tmpfiles[1358]: ACLs are not supported, ignoring. Apr 24 00:22:08.737675 systemd-tmpfiles[1358]: Detected autofs mount point /boot during canonicalization of boot. Apr 24 00:22:08.737764 systemd-tmpfiles[1358]: Skipping /boot Apr 24 00:22:08.743568 systemd-tmpfiles[1358]: Detected autofs mount point /boot during canonicalization of boot. Apr 24 00:22:08.743645 systemd-tmpfiles[1358]: Skipping /boot Apr 24 00:22:08.746650 systemd-udevd[1359]: Using default interface naming scheme 'v255'. Apr 24 00:22:08.776436 zram_generator::config[1384]: No configuration found. Apr 24 00:22:08.888470 kernel: mousedev: PS/2 mouse device common for all mice Apr 24 00:22:08.907737 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Apr 24 00:22:08.917424 kernel: ACPI: button: Power Button [PWRF] Apr 24 00:22:08.957378 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Apr 24 00:22:08.962378 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Apr 24 00:22:08.968994 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Apr 24 00:22:08.998024 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 24 00:22:09.003672 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 24 00:22:09.003794 systemd[1]: Reloading finished in 278 ms. Apr 24 00:22:09.023044 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 00:22:09.034676 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 00:22:09.172923 systemd[1]: Finished ensure-sysext.service. Apr 24 00:22:09.208619 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 24 00:22:09.215080 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 24 00:22:09.293961 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 24 00:22:09.299668 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 24 00:22:09.304662 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 24 00:22:09.311878 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 24 00:22:09.320878 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 24 00:22:09.328739 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 24 00:22:09.337108 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 24 00:22:09.340460 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 24 00:22:09.346143 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Apr 24 00:22:09.347421 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 24 00:22:09.354235 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 24 00:22:09.362437 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 24 00:22:09.366811 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 24 00:22:09.373450 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 24 00:22:09.378887 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 00:22:09.383522 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Apr 24 00:22:09.384476 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 24 00:22:09.384624 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 24 00:22:09.390073 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 24 00:22:09.390840 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 24 00:22:09.395855 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 24 00:22:09.396077 augenrules[1510]: No rules Apr 24 00:22:09.399795 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 24 00:22:09.409540 systemd[1]: audit-rules.service: Deactivated successfully. Apr 24 00:22:09.409698 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 24 00:22:09.415065 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 24 00:22:09.415388 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 24 00:22:09.440573 kernel: hrtimer: interrupt took 8522581 ns Apr 24 00:22:09.695641 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 24 00:22:10.001673 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 24 00:22:10.016128 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 24 00:22:10.026746 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 24 00:22:10.026997 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 24 00:22:10.029997 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 24 00:22:10.035441 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 24 00:22:10.035546 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 24 00:22:10.036236 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 24 00:22:10.060961 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 24 00:22:10.085126 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 00:22:10.109211 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 24 00:22:10.186855 systemd-resolved[1501]: Positive Trust Anchors: Apr 24 00:22:10.186869 systemd-resolved[1501]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 24 00:22:10.186894 systemd-resolved[1501]: 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 24 00:22:10.187387 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 24 00:22:10.191962 systemd-resolved[1501]: Defaulting to hostname 'linux'. Apr 24 00:22:10.193989 systemd[1]: Reached target time-set.target - System Time Set. Apr 24 00:22:10.199606 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 24 00:22:10.205578 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 24 00:22:10.212426 systemd-networkd[1498]: lo: Link UP Apr 24 00:22:10.212433 systemd-networkd[1498]: lo: Gained carrier Apr 24 00:22:10.213411 systemd[1]: Reached target sysinit.target - System Initialization. Apr 24 00:22:10.215201 systemd-networkd[1498]: Enumeration completed Apr 24 00:22:10.217484 systemd-networkd[1498]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 00:22:10.217488 systemd-networkd[1498]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 24 00:22:10.218966 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 24 00:22:10.219488 systemd-networkd[1498]: eth0: Link UP Apr 24 00:22:10.219629 systemd-networkd[1498]: eth0: Gained carrier Apr 24 00:22:10.219640 systemd-networkd[1498]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 00:22:10.224136 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 24 00:22:10.229491 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Apr 24 00:22:10.234726 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 24 00:22:10.239211 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 24 00:22:10.244656 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 24 00:22:10.249881 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 24 00:22:10.249939 systemd[1]: Reached target paths.target - Path Units. Apr 24 00:22:10.253743 systemd[1]: Reached target timers.target - Timer Units. Apr 24 00:22:10.259504 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 24 00:22:10.265680 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 24 00:22:10.273934 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Apr 24 00:22:10.280526 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Apr 24 00:22:10.286903 systemd[1]: Reached target ssh-access.target - SSH Access Available. Apr 24 00:22:10.289557 systemd-networkd[1498]: eth0: DHCPv4 address 10.0.0.81/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 24 00:22:10.290183 systemd-timesyncd[1503]: Network configuration changed, trying to establish connection. Apr 24 00:22:10.293830 systemd-timesyncd[1503]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 24 00:22:10.293876 systemd-timesyncd[1503]: Initial clock synchronization to Fri 2026-04-24 00:22:10.363697 UTC. Apr 24 00:22:10.297098 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 24 00:22:10.302887 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Apr 24 00:22:10.309674 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 24 00:22:10.315804 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 24 00:22:10.322101 systemd[1]: Reached target network.target - Network. Apr 24 00:22:10.326951 systemd[1]: Reached target sockets.target - Socket Units. Apr 24 00:22:10.334581 systemd[1]: Reached target basic.target - Basic System. Apr 24 00:22:10.348500 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 24 00:22:10.348566 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 24 00:22:10.350595 systemd[1]: Starting containerd.service - containerd container runtime... Apr 24 00:22:10.356423 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 24 00:22:10.367177 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 24 00:22:10.373464 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 24 00:22:10.390114 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 24 00:22:10.393833 jq[1547]: false Apr 24 00:22:10.394486 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 24 00:22:10.395701 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Apr 24 00:22:10.402419 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 24 00:22:10.410521 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 24 00:22:10.411735 extend-filesystems[1548]: Found /dev/vda6 Apr 24 00:22:10.418921 extend-filesystems[1548]: Found /dev/vda9 Apr 24 00:22:10.422412 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Refreshing passwd entry cache Apr 24 00:22:10.416888 oslogin_cache_refresh[1549]: Refreshing passwd entry cache Apr 24 00:22:10.419550 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 24 00:22:10.422928 extend-filesystems[1548]: Checking size of /dev/vda9 Apr 24 00:22:10.431578 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Failure getting users, quitting Apr 24 00:22:10.431578 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Apr 24 00:22:10.431578 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Refreshing group entry cache Apr 24 00:22:10.426241 oslogin_cache_refresh[1549]: Failure getting users, quitting Apr 24 00:22:10.426370 oslogin_cache_refresh[1549]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Apr 24 00:22:10.426450 oslogin_cache_refresh[1549]: Refreshing group entry cache Apr 24 00:22:10.434189 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 24 00:22:10.435080 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Failure getting groups, quitting Apr 24 00:22:10.435412 oslogin_cache_refresh[1549]: Failure getting groups, quitting Apr 24 00:22:10.436044 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Apr 24 00:22:10.435426 oslogin_cache_refresh[1549]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Apr 24 00:22:10.440552 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Apr 24 00:22:10.441642 extend-filesystems[1548]: Resized partition /dev/vda9 Apr 24 00:22:10.447120 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 24 00:22:10.456861 extend-filesystems[1570]: resize2fs 1.47.3 (8-Jul-2025) Apr 24 00:22:10.466743 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Apr 24 00:22:10.457712 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 24 00:22:10.459468 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 24 00:22:10.462390 systemd[1]: Starting update-engine.service - Update Engine... Apr 24 00:22:10.474753 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 24 00:22:10.485119 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 24 00:22:10.491178 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 24 00:22:10.491713 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 24 00:22:10.492063 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Apr 24 00:22:10.492455 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Apr 24 00:22:10.498415 jq[1576]: true Apr 24 00:22:10.498417 systemd[1]: motdgen.service: Deactivated successfully. Apr 24 00:22:10.498561 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 24 00:22:10.504850 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 24 00:22:10.505071 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 24 00:22:10.510661 update_engine[1573]: I20260424 00:22:10.510571 1573 main.cc:92] Flatcar Update Engine starting Apr 24 00:22:10.523395 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Apr 24 00:22:10.545475 extend-filesystems[1570]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Apr 24 00:22:10.545475 extend-filesystems[1570]: old_desc_blocks = 1, new_desc_blocks = 1 Apr 24 00:22:10.545475 extend-filesystems[1570]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Apr 24 00:22:10.539869 (ntainerd)[1588]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 24 00:22:10.566715 jq[1579]: true Apr 24 00:22:10.566804 extend-filesystems[1548]: Resized filesystem in /dev/vda9 Apr 24 00:22:10.545379 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 24 00:22:10.576918 dbus-daemon[1545]: [system] SELinux support is enabled Apr 24 00:22:10.545587 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 24 00:22:10.560447 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Apr 24 00:22:10.570688 systemd-logind[1564]: Watching system buttons on /dev/input/event2 (Power Button) Apr 24 00:22:10.570703 systemd-logind[1564]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Apr 24 00:22:10.572938 systemd-logind[1564]: New seat seat0. Apr 24 00:22:10.577206 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 24 00:22:10.582218 update_engine[1573]: I20260424 00:22:10.582033 1573 update_check_scheduler.cc:74] Next update check in 3m11s Apr 24 00:22:10.588642 systemd[1]: Started systemd-logind.service - User Login Management. Apr 24 00:22:10.595192 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 24 00:22:10.595222 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 24 00:22:10.597702 dbus-daemon[1545]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 24 00:22:10.600883 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 24 00:22:10.601511 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 24 00:22:10.607204 systemd[1]: Started update-engine.service - Update Engine. Apr 24 00:22:10.614959 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 24 00:22:10.650436 bash[1609]: Updated "/home/core/.ssh/authorized_keys" Apr 24 00:22:10.651774 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 24 00:22:10.660932 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 24 00:22:10.670407 locksmithd[1608]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 24 00:22:10.748166 containerd[1588]: time="2026-04-24T00:22:10Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Apr 24 00:22:10.749150 containerd[1588]: time="2026-04-24T00:22:10.749037055Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Apr 24 00:22:10.751227 sshd_keygen[1575]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 24 00:22:10.758578 containerd[1588]: time="2026-04-24T00:22:10.758491525Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.317µs" Apr 24 00:22:10.758578 containerd[1588]: time="2026-04-24T00:22:10.758548115Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Apr 24 00:22:10.758578 containerd[1588]: time="2026-04-24T00:22:10.758562181Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Apr 24 00:22:10.758686 containerd[1588]: time="2026-04-24T00:22:10.758665098Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Apr 24 00:22:10.758686 containerd[1588]: time="2026-04-24T00:22:10.758676597Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Apr 24 00:22:10.758718 containerd[1588]: time="2026-04-24T00:22:10.758692666Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 24 00:22:10.758734 containerd[1588]: time="2026-04-24T00:22:10.758727298Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Apr 24 00:22:10.758754 containerd[1588]: time="2026-04-24T00:22:10.758734812Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Apr 24 00:22:10.758967 containerd[1588]: time="2026-04-24T00:22:10.758892187Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Apr 24 00:22:10.758967 containerd[1588]: time="2026-04-24T00:22:10.758959447Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759001 containerd[1588]: time="2026-04-24T00:22:10.758969213Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759001 containerd[1588]: time="2026-04-24T00:22:10.758975223Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759033 containerd[1588]: time="2026-04-24T00:22:10.759028039Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759428 containerd[1588]: time="2026-04-24T00:22:10.759204560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759428 containerd[1588]: time="2026-04-24T00:22:10.759378747Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Apr 24 00:22:10.759428 containerd[1588]: time="2026-04-24T00:22:10.759387786Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Apr 24 00:22:10.759428 containerd[1588]: time="2026-04-24T00:22:10.759410646Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Apr 24 00:22:10.759879 containerd[1588]: time="2026-04-24T00:22:10.759728924Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Apr 24 00:22:10.759879 containerd[1588]: time="2026-04-24T00:22:10.759809858Z" level=info msg="metadata content store policy set" policy=shared Apr 24 00:22:10.765927 containerd[1588]: time="2026-04-24T00:22:10.765863236Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Apr 24 00:22:10.766046 containerd[1588]: time="2026-04-24T00:22:10.765971678Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Apr 24 00:22:10.766205 containerd[1588]: time="2026-04-24T00:22:10.766190815Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Apr 24 00:22:10.766235 containerd[1588]: time="2026-04-24T00:22:10.766203774Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Apr 24 00:22:10.766235 containerd[1588]: time="2026-04-24T00:22:10.766214851Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Apr 24 00:22:10.766235 containerd[1588]: time="2026-04-24T00:22:10.766223247Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766239898Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766249860Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766368994Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766382611Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766389452Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Apr 24 00:22:10.766423 containerd[1588]: time="2026-04-24T00:22:10.766397853Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Apr 24 00:22:10.766562 containerd[1588]: time="2026-04-24T00:22:10.766512312Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Apr 24 00:22:10.766580 containerd[1588]: time="2026-04-24T00:22:10.766570855Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Apr 24 00:22:10.766597 containerd[1588]: time="2026-04-24T00:22:10.766591755Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Apr 24 00:22:10.766611 containerd[1588]: time="2026-04-24T00:22:10.766601746Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Apr 24 00:22:10.766625 containerd[1588]: time="2026-04-24T00:22:10.766609909Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Apr 24 00:22:10.766625 containerd[1588]: time="2026-04-24T00:22:10.766617242Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Apr 24 00:22:10.766654 containerd[1588]: time="2026-04-24T00:22:10.766625132Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Apr 24 00:22:10.766654 containerd[1588]: time="2026-04-24T00:22:10.766633069Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Apr 24 00:22:10.766654 containerd[1588]: time="2026-04-24T00:22:10.766641231Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Apr 24 00:22:10.766654 containerd[1588]: time="2026-04-24T00:22:10.766648551Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Apr 24 00:22:10.766706 containerd[1588]: time="2026-04-24T00:22:10.766656159Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Apr 24 00:22:10.767639 containerd[1588]: time="2026-04-24T00:22:10.766687786Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Apr 24 00:22:10.767689 containerd[1588]: time="2026-04-24T00:22:10.767666634Z" level=info msg="Start snapshots syncer" Apr 24 00:22:10.767707 containerd[1588]: time="2026-04-24T00:22:10.767691061Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Apr 24 00:22:10.768894 containerd[1588]: time="2026-04-24T00:22:10.768485653Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Apr 24 00:22:10.769193 containerd[1588]: time="2026-04-24T00:22:10.769144117Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Apr 24 00:22:10.770907 containerd[1588]: time="2026-04-24T00:22:10.770845527Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Apr 24 00:22:10.771090 containerd[1588]: time="2026-04-24T00:22:10.770979386Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Apr 24 00:22:10.771090 containerd[1588]: time="2026-04-24T00:22:10.771082630Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Apr 24 00:22:10.771128 containerd[1588]: time="2026-04-24T00:22:10.771092948Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Apr 24 00:22:10.771128 containerd[1588]: time="2026-04-24T00:22:10.771100260Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Apr 24 00:22:10.771128 containerd[1588]: time="2026-04-24T00:22:10.771109255Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Apr 24 00:22:10.771128 containerd[1588]: time="2026-04-24T00:22:10.771120933Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Apr 24 00:22:10.771178 containerd[1588]: time="2026-04-24T00:22:10.771128850Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Apr 24 00:22:10.771178 containerd[1588]: time="2026-04-24T00:22:10.771145429Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Apr 24 00:22:10.771178 containerd[1588]: time="2026-04-24T00:22:10.771152705Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Apr 24 00:22:10.771178 containerd[1588]: time="2026-04-24T00:22:10.771160676Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771230153Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771494568Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771503920Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771511419Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771517058Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Apr 24 00:22:10.771529 containerd[1588]: time="2026-04-24T00:22:10.771529772Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771544902Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771556045Z" level=info msg="runtime interface created" Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771559777Z" level=info msg="created NRI interface" Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771565136Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771573850Z" level=info msg="Connect containerd service" Apr 24 00:22:10.771616 containerd[1588]: time="2026-04-24T00:22:10.771588660Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 24 00:22:10.772669 containerd[1588]: time="2026-04-24T00:22:10.772572421Z" 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 24 00:22:10.778537 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 24 00:22:10.784941 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 24 00:22:10.807671 systemd[1]: issuegen.service: Deactivated successfully. Apr 24 00:22:10.807915 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 24 00:22:10.814162 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 24 00:22:10.836125 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 24 00:22:10.843704 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 24 00:22:10.848977 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 24 00:22:10.853796 systemd[1]: Reached target getty.target - Login Prompts. Apr 24 00:22:10.870112 containerd[1588]: time="2026-04-24T00:22:10.870050256Z" level=info msg="Start subscribing containerd event" Apr 24 00:22:10.870418 containerd[1588]: time="2026-04-24T00:22:10.870162858Z" level=info msg="Start recovering state" Apr 24 00:22:10.870518 containerd[1588]: time="2026-04-24T00:22:10.870472716Z" level=info msg="Start event monitor" Apr 24 00:22:10.870621 containerd[1588]: time="2026-04-24T00:22:10.870556078Z" level=info msg="Start cni network conf syncer for default" Apr 24 00:22:10.870802 containerd[1588]: time="2026-04-24T00:22:10.870733357Z" level=info msg="Start streaming server" Apr 24 00:22:10.870974 containerd[1588]: time="2026-04-24T00:22:10.870931900Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Apr 24 00:22:10.870974 containerd[1588]: time="2026-04-24T00:22:10.870970734Z" level=info msg="runtime interface starting up..." Apr 24 00:22:10.871004 containerd[1588]: time="2026-04-24T00:22:10.870976408Z" level=info msg="starting plugins..." Apr 24 00:22:10.871004 containerd[1588]: time="2026-04-24T00:22:10.870988771Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Apr 24 00:22:10.871900 containerd[1588]: time="2026-04-24T00:22:10.871837852Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 24 00:22:10.871931 containerd[1588]: time="2026-04-24T00:22:10.871924947Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 24 00:22:10.872224 containerd[1588]: time="2026-04-24T00:22:10.872100170Z" level=info msg="containerd successfully booted in 0.124543s" Apr 24 00:22:10.872117 systemd[1]: Started containerd.service - containerd container runtime. Apr 24 00:22:12.132606 systemd-networkd[1498]: eth0: Gained IPv6LL Apr 24 00:22:12.136598 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 24 00:22:12.142627 systemd[1]: Reached target network-online.target - Network is Online. Apr 24 00:22:12.148996 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 24 00:22:12.163079 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 00:22:12.168963 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 24 00:22:12.202667 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 24 00:22:12.202956 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 24 00:22:12.208849 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 24 00:22:12.214545 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 24 00:22:13.027165 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 00:22:13.032729 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 24 00:22:13.033033 (kubelet)[1677]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 24 00:22:13.039431 systemd[1]: Startup finished in 9.065s (kernel) + 6.926s (initrd) + 6.303s (userspace) = 22.296s. Apr 24 00:22:13.555095 kubelet[1677]: E0424 00:22:13.554749 1677 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 24 00:22:13.557682 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 24 00:22:13.557847 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 24 00:22:13.558229 systemd[1]: kubelet.service: Consumed 962ms CPU time, 266.4M memory peak. Apr 24 00:22:14.884783 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 24 00:22:14.886147 systemd[1]: Started sshd@0-10.0.0.81:22-10.0.0.1:46856.service - OpenSSH per-connection server daemon (10.0.0.1:46856). Apr 24 00:22:14.958391 sshd[1691]: Accepted publickey for core from 10.0.0.1 port 46856 ssh2: RSA SHA256:O5eEjr93EU6o+yIitYA6KggdYqbq1kMU8aUvK/sf8Ls Apr 24 00:22:14.960568 sshd-session[1691]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 00:22:14.968971 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 24 00:22:14.970060 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 24 00:22:14.976999 systemd-logind[1564]: New session 1 of user core. Apr 24 00:22:14.997019 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 24 00:22:14.999816 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 24 00:22:15.015856 (systemd)[1696]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 24 00:22:15.019504 systemd-logind[1564]: New session c1 of user core. Apr 24 00:22:15.133520 systemd[1696]: Queued start job for default target default.target. Apr 24 00:22:15.145456 systemd[1696]: Created slice app.slice - User Application Slice. Apr 24 00:22:15.145515 systemd[1696]: Reached target paths.target - Paths. Apr 24 00:22:15.145546 systemd[1696]: Reached target timers.target - Timers. Apr 24 00:22:15.147110 systemd[1696]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 24 00:22:15.162184 systemd[1696]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 24 00:22:15.162428 systemd[1696]: Reached target sockets.target - Sockets. Apr 24 00:22:15.162496 systemd[1696]: Reached target basic.target - Basic System. Apr 24 00:22:15.162519 systemd[1696]: Reached target default.target - Main User Target. Apr 24 00:22:15.162538 systemd[1696]: Startup finished in 135ms. Apr 24 00:22:15.162658 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 24 00:22:15.164357 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 24 00:22:15.191805 systemd[1]: Started sshd@1-10.0.0.81:22-10.0.0.1:46868.service - OpenSSH per-connection server daemon (10.0.0.1:46868). Apr 24 00:22:15.253764 sshd[1707]: Accepted publickey for core from 10.0.0.1 port 46868 ssh2: RSA SHA256:O5eEjr93EU6o+yIitYA6KggdYqbq1kMU8aUvK/sf8Ls Apr 24 00:22:15.255348 sshd-session[1707]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 00:22:15.260630 systemd-logind[1564]: New session 2 of user core. Apr 24 00:22:15.270561 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 24 00:22:15.285730 sshd[1710]: Connection closed by 10.0.0.1 port 46868 Apr 24 00:22:15.285966 sshd-session[1707]: pam_unix(sshd:session): session closed for user core Apr 24 00:22:15.301079 systemd[1]: sshd@1-10.0.0.81:22-10.0.0.1:46868.service: Deactivated successfully. Apr 24 00:22:15.302638 systemd[1]: session-2.scope: Deactivated successfully. Apr 24 00:22:15.303634 systemd-logind[1564]: Session 2 logged out. Waiting for processes to exit. Apr 24 00:22:15.305679 systemd[1]: Started sshd@2-10.0.0.81:22-10.0.0.1:46884.service - OpenSSH per-connection server daemon (10.0.0.1:46884). Apr 24 00:22:15.306981 systemd-logind[1564]: Removed session 2. Apr 24 00:22:15.360939 sshd[1716]: Accepted publickey for core from 10.0.0.1 port 46884 ssh2: RSA SHA256:O5eEjr93EU6o+yIitYA6KggdYqbq1kMU8aUvK/sf8Ls Apr 24 00:22:15.361911 sshd-session[1716]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 00:22:15.367043 systemd-logind[1564]: New session 3 of user core. Apr 24 00:22:15.380577 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 24 00:22:15.388803 sshd[1719]: Connection closed by 10.0.0.1 port 46884 Apr 24 00:22:15.389383 sshd-session[1716]: pam_unix(sshd:session): session closed for user core Apr 24 00:22:15.399061 systemd[1]: sshd@2-10.0.0.81:22-10.0.0.1:46884.service: Deactivated successfully. Apr 24 00:22:15.401016 systemd[1]: session-3.scope: Deactivated successfully. Apr 24 00:22:15.402130 systemd-logind[1564]: Session 3 logged out. Waiting for processes to exit. Apr 24 00:22:15.404915 systemd[1]: Started sshd@3-10.0.0.81:22-10.0.0.1:46888.service - OpenSSH per-connection server daemon (10.0.0.1:46888). Apr 24 00:22:15.406395 systemd-logind[1564]: Removed session 3. Apr 24 00:22:15.466632 sshd[1725]: Accepted publickey for core from 10.0.0.1 port 46888 ssh2: RSA SHA256:O5eEjr93EU6o+yIitYA6KggdYqbq1kMU8aUvK/sf8Ls Apr 24 00:22:15.467997 sshd-session[1725]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 00:22:15.473240 systemd-logind[1564]: New session 4 of user core. Apr 24 00:22:15.479514 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 24 00:22:15.493723 sshd[1728]: Connection closed by 10.0.0.1 port 46888 Apr 24 00:22:15.494162 sshd-session[1725]: pam_unix(sshd:session): session closed for user core Apr 24 00:22:15.504066 systemd[1]: sshd@3-10.0.0.81:22-10.0.0.1:46888.service: Deactivated successfully. Apr 24 00:22:15.505550 systemd[1]: session-4.scope: Deactivated successfully. Apr 24 00:22:15.506449 systemd-logind[1564]: Session 4 logged out. Waiting for processes to exit. Apr 24 00:22:15.508461 systemd[1]: Started sshd@4-10.0.0.81:22-10.0.0.1:46898.service - OpenSSH per-connection server daemon (10.0.0.1:46898). Apr 24 00:22:15.509397 systemd-logind[1564]: Removed session 4. Apr 24 00:22:15.564827 sshd[1734]: Accepted publickey for core from 10.0.0.1 port 46898 ssh2: RSA SHA256:O5eEjr93EU6o+yIitYA6KggdYqbq1kMU8aUvK/sf8Ls Apr 24 00:22:15.566120 sshd-session[1734]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 00:22:15.574378 systemd-logind[1564]: New session 5 of user core. Apr 24 00:22:15.583524 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 24 00:22:15.602233 sudo[1738]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Apr 24 00:22:15.602599 sudo[1738]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 24 00:22:15.625865 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 24 00:22:15.685662 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 24 00:22:15.685910 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 24 00:22:16.330923 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 00:22:16.331115 systemd[1]: kubelet.service: Consumed 962ms CPU time, 266.4M memory peak. Apr 24 00:22:16.333536 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 00:22:16.360561 systemd[1]: Reload requested from client PID 1782 ('systemctl') (unit session-5.scope)... Apr 24 00:22:16.360612 systemd[1]: Reloading... Apr 24 00:22:16.459531 zram_generator::config[1826]: No configuration found. Apr 24 00:22:16.631479 systemd[1]: Reloading finished in 270 ms. Apr 24 00:22:16.690694 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Apr 24 00:22:16.690806 systemd[1]: kubelet.service: Failed with result 'signal'. Apr 24 00:22:16.691151 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 00:22:16.691184 systemd[1]: kubelet.service: Consumed 110ms CPU time, 98.1M memory peak. Apr 24 00:22:16.692823 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 00:22:16.858248 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 00:22:16.871649 (kubelet)[1871]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Apr 24 00:22:16.943350 kubelet[1871]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Apr 24 00:22:16.943350 kubelet[1871]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Apr 24 00:22:16.943350 kubelet[1871]: 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 24 00:22:16.943679 kubelet[1871]: I0424 00:22:16.943371 1871 server.go:212] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Apr 24 00:22:17.407213 kubelet[1871]: I0424 00:22:17.406788 1871 server.go:530] "Kubelet version" kubeletVersion="v1.33.8" Apr 24 00:22:17.407213 kubelet[1871]: I0424 00:22:17.406873 1871 server.go:532] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Apr 24 00:22:17.407213 kubelet[1871]: I0424 00:22:17.407102 1871 server.go:956] "Client rotation is on, will bootstrap in background" Apr 24 00:22:17.436789 kubelet[1871]: I0424 00:22:17.436718 1871 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Apr 24 00:22:17.447878 kubelet[1871]: I0424 00:22:17.447677 1871 server.go:1446] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Apr 24 00:22:17.455420 kubelet[1871]: I0424 00:22:17.455234 1871 server.go:782] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Apr 24 00:22:17.456853 kubelet[1871]: I0424 00:22:17.456741 1871 container_manager_linux.go:267] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Apr 24 00:22:17.457046 kubelet[1871]: I0424 00:22:17.456818 1871 container_manager_linux.go:272] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.81","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Apr 24 00:22:17.457232 kubelet[1871]: I0424 00:22:17.457052 1871 topology_manager.go:138] "Creating topology manager with none policy" Apr 24 00:22:17.457232 kubelet[1871]: I0424 00:22:17.457064 1871 container_manager_linux.go:303] "Creating device plugin manager" Apr 24 00:22:17.457402 kubelet[1871]: I0424 00:22:17.457357 1871 state_mem.go:36] "Initialized new in-memory state store" Apr 24 00:22:17.460960 kubelet[1871]: I0424 00:22:17.460905 1871 kubelet.go:480] "Attempting to sync node with API server" Apr 24 00:22:17.460960 kubelet[1871]: I0424 00:22:17.460959 1871 kubelet.go:375] "Adding static pod path" path="/etc/kubernetes/manifests" Apr 24 00:22:17.463786 kubelet[1871]: I0424 00:22:17.463228 1871 kubelet.go:386] "Adding apiserver pod source" Apr 24 00:22:17.464805 kubelet[1871]: I0424 00:22:17.464750 1871 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Apr 24 00:22:17.464893 kubelet[1871]: E0424 00:22:17.464878 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:17.464925 kubelet[1871]: E0424 00:22:17.464747 1871 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:17.467970 kubelet[1871]: I0424 00:22:17.467751 1871 kuberuntime_manager.go:279] "Container runtime initialized" containerRuntime="containerd" version="v2.0.7" apiVersion="v1" Apr 24 00:22:17.468819 kubelet[1871]: I0424 00:22:17.468754 1871 kubelet.go:935] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Apr 24 00:22:17.469766 kubelet[1871]: W0424 00:22:17.469716 1871 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Apr 24 00:22:17.475196 kubelet[1871]: I0424 00:22:17.475140 1871 watchdog_linux.go:99] "Systemd watchdog is not enabled" Apr 24 00:22:17.475486 kubelet[1871]: I0424 00:22:17.475383 1871 server.go:1289] "Started kubelet" Apr 24 00:22:17.478485 kubelet[1871]: I0424 00:22:17.476743 1871 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Apr 24 00:22:17.478485 kubelet[1871]: I0424 00:22:17.477131 1871 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Apr 24 00:22:17.480124 kubelet[1871]: I0424 00:22:17.479096 1871 server.go:255] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Apr 24 00:22:17.480124 kubelet[1871]: I0424 00:22:17.479150 1871 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Apr 24 00:22:17.480178 kubelet[1871]: I0424 00:22:17.480154 1871 server.go:317] "Adding debug handlers to kubelet server" Apr 24 00:22:17.480881 kubelet[1871]: I0424 00:22:17.480701 1871 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 24 00:22:17.482029 kubelet[1871]: E0424 00:22:17.482017 1871 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.81\" not found" Apr 24 00:22:17.482833 kubelet[1871]: I0424 00:22:17.482141 1871 volume_manager.go:297] "Starting Kubelet Volume Manager" Apr 24 00:22:17.483004 kubelet[1871]: I0424 00:22:17.482996 1871 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Apr 24 00:22:17.484496 kubelet[1871]: I0424 00:22:17.483189 1871 reconciler.go:26] "Reconciler: start to sync state" Apr 24 00:22:17.484496 kubelet[1871]: E0424 00:22:17.483898 1871 kubelet.go:1600] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Apr 24 00:22:17.484496 kubelet[1871]: I0424 00:22:17.484068 1871 factory.go:223] Registration of the systemd container factory successfully Apr 24 00:22:17.484496 kubelet[1871]: I0424 00:22:17.484142 1871 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 24 00:22:17.486140 kubelet[1871]: I0424 00:22:17.486047 1871 factory.go:223] Registration of the containerd container factory successfully Apr 24 00:22:17.494013 kubelet[1871]: E0424 00:22:17.493993 1871 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.81\" not found" node="10.0.0.81" Apr 24 00:22:17.498662 kubelet[1871]: I0424 00:22:17.498482 1871 cpu_manager.go:221] "Starting CPU manager" policy="none" Apr 24 00:22:17.498662 kubelet[1871]: I0424 00:22:17.498521 1871 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Apr 24 00:22:17.498737 kubelet[1871]: I0424 00:22:17.498704 1871 state_mem.go:36] "Initialized new in-memory state store" Apr 24 00:22:17.553452 kubelet[1871]: I0424 00:22:17.552900 1871 policy_none.go:49] "None policy: Start" Apr 24 00:22:17.553452 kubelet[1871]: I0424 00:22:17.553112 1871 memory_manager.go:186] "Starting memorymanager" policy="None" Apr 24 00:22:17.553452 kubelet[1871]: I0424 00:22:17.553129 1871 state_mem.go:35] "Initializing new in-memory state store" Apr 24 00:22:17.564113 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Apr 24 00:22:17.575028 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Apr 24 00:22:17.578947 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Apr 24 00:22:17.583092 kubelet[1871]: E0424 00:22:17.583014 1871 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.81\" not found" Apr 24 00:22:17.589372 kubelet[1871]: E0424 00:22:17.589078 1871 manager.go:517] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Apr 24 00:22:17.589372 kubelet[1871]: I0424 00:22:17.589237 1871 eviction_manager.go:189] "Eviction manager: starting control loop" Apr 24 00:22:17.589372 kubelet[1871]: I0424 00:22:17.589248 1871 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Apr 24 00:22:17.589687 kubelet[1871]: I0424 00:22:17.589670 1871 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Apr 24 00:22:17.592748 kubelet[1871]: E0424 00:22:17.592428 1871 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Apr 24 00:22:17.592748 kubelet[1871]: E0424 00:22:17.592555 1871 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.81\" not found" Apr 24 00:22:17.618984 kubelet[1871]: I0424 00:22:17.618912 1871 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv4" Apr 24 00:22:17.621818 kubelet[1871]: I0424 00:22:17.621651 1871 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv6" Apr 24 00:22:17.621818 kubelet[1871]: I0424 00:22:17.621763 1871 status_manager.go:230] "Starting to sync pod status with apiserver" Apr 24 00:22:17.623730 kubelet[1871]: I0424 00:22:17.623648 1871 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Apr 24 00:22:17.623730 kubelet[1871]: I0424 00:22:17.623726 1871 kubelet.go:2436] "Starting kubelet main sync loop" Apr 24 00:22:17.623786 kubelet[1871]: E0424 00:22:17.623761 1871 kubelet.go:2460] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Apr 24 00:22:17.692863 kubelet[1871]: I0424 00:22:17.692737 1871 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.81" Apr 24 00:22:17.700142 kubelet[1871]: I0424 00:22:17.699886 1871 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.81" Apr 24 00:22:17.700142 kubelet[1871]: E0424 00:22:17.699960 1871 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.81\": node \"10.0.0.81\" not found" Apr 24 00:22:17.713818 kubelet[1871]: I0424 00:22:17.713752 1871 kuberuntime_manager.go:1746] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Apr 24 00:22:17.715446 containerd[1588]: time="2026-04-24T00:22:17.715385680Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Apr 24 00:22:17.715725 kubelet[1871]: I0424 00:22:17.715555 1871 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Apr 24 00:22:17.891452 sudo[1738]: pam_unix(sudo:session): session closed for user root Apr 24 00:22:17.892752 sshd[1737]: Connection closed by 10.0.0.1 port 46898 Apr 24 00:22:17.893107 sshd-session[1734]: pam_unix(sshd:session): session closed for user core Apr 24 00:22:17.896936 systemd[1]: sshd@4-10.0.0.81:22-10.0.0.1:46898.service: Deactivated successfully. Apr 24 00:22:17.899102 systemd[1]: session-5.scope: Deactivated successfully. Apr 24 00:22:17.899458 systemd[1]: session-5.scope: Consumed 599ms CPU time, 74.9M memory peak. Apr 24 00:22:17.900649 systemd-logind[1564]: Session 5 logged out. Waiting for processes to exit. Apr 24 00:22:17.902392 systemd-logind[1564]: Removed session 5. Apr 24 00:22:18.410082 kubelet[1871]: I0424 00:22:18.409576 1871 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Apr 24 00:22:18.412143 kubelet[1871]: I0424 00:22:18.410691 1871 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Apr 24 00:22:18.412143 kubelet[1871]: I0424 00:22:18.410713 1871 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Apr 24 00:22:18.412143 kubelet[1871]: I0424 00:22:18.410825 1871 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Apr 24 00:22:18.465507 kubelet[1871]: I0424 00:22:18.465348 1871 apiserver.go:52] "Watching apiserver" Apr 24 00:22:18.465507 kubelet[1871]: E0424 00:22:18.465468 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:18.483437 systemd[1]: Created slice kubepods-besteffort-pod681802cc_f9c6_40e8_9f63_1ec592f77730.slice - libcontainer container kubepods-besteffort-pod681802cc_f9c6_40e8_9f63_1ec592f77730.slice. Apr 24 00:22:18.483767 kubelet[1871]: I0424 00:22:18.483595 1871 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Apr 24 00:22:18.490595 kubelet[1871]: I0424 00:22:18.490541 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/681802cc-f9c6-40e8-9f63-1ec592f77730-lib-modules\") pod \"kube-proxy-vqgv4\" (UID: \"681802cc-f9c6-40e8-9f63-1ec592f77730\") " pod="kube-system/kube-proxy-vqgv4" Apr 24 00:22:18.490595 kubelet[1871]: I0424 00:22:18.490590 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-dc84s\" (UniqueName: \"kubernetes.io/projected/681802cc-f9c6-40e8-9f63-1ec592f77730-kube-api-access-dc84s\") pod \"kube-proxy-vqgv4\" (UID: \"681802cc-f9c6-40e8-9f63-1ec592f77730\") " pod="kube-system/kube-proxy-vqgv4" Apr 24 00:22:18.490677 kubelet[1871]: I0424 00:22:18.490604 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0874a678-5e36-4c02-b530-ee1508e4f2bb-run\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490677 kubelet[1871]: I0424 00:22:18.490617 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0874a678-5e36-4c02-b530-ee1508e4f2bb-cni-plugin\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490677 kubelet[1871]: I0424 00:22:18.490630 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0874a678-5e36-4c02-b530-ee1508e4f2bb-xtables-lock\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490677 kubelet[1871]: I0424 00:22:18.490641 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-r8tzn\" (UniqueName: \"kubernetes.io/projected/0874a678-5e36-4c02-b530-ee1508e4f2bb-kube-api-access-r8tzn\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490677 kubelet[1871]: I0424 00:22:18.490651 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0874a678-5e36-4c02-b530-ee1508e4f2bb-cni\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490763 kubelet[1871]: I0424 00:22:18.490661 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0874a678-5e36-4c02-b530-ee1508e4f2bb-flannel-cfg\") pod \"kube-flannel-ds-9ghjs\" (UID: \"0874a678-5e36-4c02-b530-ee1508e4f2bb\") " pod="kube-flannel/kube-flannel-ds-9ghjs" Apr 24 00:22:18.490763 kubelet[1871]: I0424 00:22:18.490671 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/681802cc-f9c6-40e8-9f63-1ec592f77730-kube-proxy\") pod \"kube-proxy-vqgv4\" (UID: \"681802cc-f9c6-40e8-9f63-1ec592f77730\") " pod="kube-system/kube-proxy-vqgv4" Apr 24 00:22:18.490763 kubelet[1871]: I0424 00:22:18.490681 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/681802cc-f9c6-40e8-9f63-1ec592f77730-xtables-lock\") pod \"kube-proxy-vqgv4\" (UID: \"681802cc-f9c6-40e8-9f63-1ec592f77730\") " pod="kube-system/kube-proxy-vqgv4" Apr 24 00:22:18.502798 systemd[1]: Created slice kubepods-burstable-pod0874a678_5e36_4c02_b530_ee1508e4f2bb.slice - libcontainer container kubepods-burstable-pod0874a678_5e36_4c02_b530_ee1508e4f2bb.slice. Apr 24 00:22:18.803618 containerd[1588]: time="2026-04-24T00:22:18.803427293Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-vqgv4,Uid:681802cc-f9c6-40e8-9f63-1ec592f77730,Namespace:kube-system,Attempt:0,}" Apr 24 00:22:18.817383 containerd[1588]: time="2026-04-24T00:22:18.816205510Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-9ghjs,Uid:0874a678-5e36-4c02-b530-ee1508e4f2bb,Namespace:kube-flannel,Attempt:0,}" Apr 24 00:22:19.284694 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1454176973.mount: Deactivated successfully. Apr 24 00:22:19.293959 containerd[1588]: time="2026-04-24T00:22:19.293881236Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 00:22:19.295356 containerd[1588]: time="2026-04-24T00:22:19.295230056Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=321070" Apr 24 00:22:19.299608 containerd[1588]: time="2026-04-24T00:22:19.299463426Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 00:22:19.300778 containerd[1588]: time="2026-04-24T00:22:19.300704621Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 00:22:19.301761 containerd[1588]: time="2026-04-24T00:22:19.301619860Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Apr 24 00:22:19.305022 containerd[1588]: time="2026-04-24T00:22:19.304867697Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 00:22:19.305646 containerd[1588]: time="2026-04-24T00:22:19.305589824Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 494.914916ms" Apr 24 00:22:19.305832 containerd[1588]: time="2026-04-24T00:22:19.305766263Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 483.340842ms" Apr 24 00:22:19.331581 containerd[1588]: time="2026-04-24T00:22:19.331462988Z" level=info msg="connecting to shim 7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9" address="unix:///run/containerd/s/00a4aea2977b18762e7a8cb5e4912535840e87c4a2bfccdd44ddfe41ea73c672" namespace=k8s.io protocol=ttrpc version=3 Apr 24 00:22:19.345423 containerd[1588]: time="2026-04-24T00:22:19.345215164Z" level=info msg="connecting to shim 9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510" address="unix:///run/containerd/s/cbdb9f41f7c870aa15368388faa5e7b8156c176e08f905d01d7e8b975ee75643" namespace=k8s.io protocol=ttrpc version=3 Apr 24 00:22:19.369616 systemd[1]: Started cri-containerd-7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9.scope - libcontainer container 7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9. Apr 24 00:22:19.374894 systemd[1]: Started cri-containerd-9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510.scope - libcontainer container 9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510. Apr 24 00:22:19.425480 containerd[1588]: time="2026-04-24T00:22:19.425444506Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-vqgv4,Uid:681802cc-f9c6-40e8-9f63-1ec592f77730,Namespace:kube-system,Attempt:0,} returns sandbox id \"7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9\"" Apr 24 00:22:19.429417 containerd[1588]: time="2026-04-24T00:22:19.428775557Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.11\"" Apr 24 00:22:19.439238 containerd[1588]: time="2026-04-24T00:22:19.439128731Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-9ghjs,Uid:0874a678-5e36-4c02-b530-ee1508e4f2bb,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\"" Apr 24 00:22:19.466386 kubelet[1871]: E0424 00:22:19.466243 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:20.248833 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2177629711.mount: Deactivated successfully. Apr 24 00:22:20.467013 kubelet[1871]: E0424 00:22:20.466731 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:20.769208 containerd[1588]: time="2026-04-24T00:22:20.768907497Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.33.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:20.770352 containerd[1588]: time="2026-04-24T00:22:20.770026973Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.33.11: active requests=0, bytes read=32010605" Apr 24 00:22:20.771369 containerd[1588]: time="2026-04-24T00:22:20.771123540Z" level=info msg="ImageCreate event name:\"sha256:4ce1332df15d2a0b1c2d3b18292afb4ff670070401211daebb00b7293b26f6d0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:20.773678 containerd[1588]: time="2026-04-24T00:22:20.773578537Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:8d18637b5c5f58a4ca0163d3cf184e53d4c522963c242860562be7cb25e9303e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:20.774127 containerd[1588]: time="2026-04-24T00:22:20.774054205Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.33.11\" with image id \"sha256:4ce1332df15d2a0b1c2d3b18292afb4ff670070401211daebb00b7293b26f6d0\", repo tag \"registry.k8s.io/kube-proxy:v1.33.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:8d18637b5c5f58a4ca0163d3cf184e53d4c522963c242860562be7cb25e9303e\", size \"32009730\" in 1.345252077s" Apr 24 00:22:20.774197 containerd[1588]: time="2026-04-24T00:22:20.774128513Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.11\" returns image reference \"sha256:4ce1332df15d2a0b1c2d3b18292afb4ff670070401211daebb00b7293b26f6d0\"" Apr 24 00:22:20.775876 containerd[1588]: time="2026-04-24T00:22:20.775692209Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Apr 24 00:22:20.780970 containerd[1588]: time="2026-04-24T00:22:20.780947780Z" level=info msg="CreateContainer within sandbox \"7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Apr 24 00:22:20.797553 containerd[1588]: time="2026-04-24T00:22:20.797326391Z" level=info msg="Container d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:20.811026 containerd[1588]: time="2026-04-24T00:22:20.810948661Z" level=info msg="CreateContainer within sandbox \"7c7a74e89b750c50d5264cbf8312f815f80610ac06d8194242d2beb3fe3db9a9\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304\"" Apr 24 00:22:20.811998 containerd[1588]: time="2026-04-24T00:22:20.811935086Z" level=info msg="StartContainer for \"d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304\"" Apr 24 00:22:20.813428 containerd[1588]: time="2026-04-24T00:22:20.813398824Z" level=info msg="connecting to shim d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304" address="unix:///run/containerd/s/00a4aea2977b18762e7a8cb5e4912535840e87c4a2bfccdd44ddfe41ea73c672" protocol=ttrpc version=3 Apr 24 00:22:20.843546 systemd[1]: Started cri-containerd-d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304.scope - libcontainer container d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304. Apr 24 00:22:20.927189 containerd[1588]: time="2026-04-24T00:22:20.927002727Z" level=info msg="StartContainer for \"d5c908a97bc5c05832c1beffd0b7d10d50b6c95d29fd2b05bb9f3d9b9a89d304\" returns successfully" Apr 24 00:22:21.466957 kubelet[1871]: E0424 00:22:21.466918 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:21.656957 kubelet[1871]: I0424 00:22:21.656807 1871 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-vqgv4" podStartSLOduration=3.309439826 podStartE2EDuration="4.656794047s" podCreationTimestamp="2026-04-24 00:22:17 +0000 UTC" firstStartedPulling="2026-04-24 00:22:19.428120967 +0000 UTC m=+2.550500616" lastFinishedPulling="2026-04-24 00:22:20.775475188 +0000 UTC m=+3.897854837" observedRunningTime="2026-04-24 00:22:21.656182058 +0000 UTC m=+4.778561724" watchObservedRunningTime="2026-04-24 00:22:21.656794047 +0000 UTC m=+4.779173713" Apr 24 00:22:22.266926 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2610758806.mount: Deactivated successfully. Apr 24 00:22:22.319027 containerd[1588]: time="2026-04-24T00:22:22.318902701Z" 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 24 00:22:22.320230 containerd[1588]: time="2026-04-24T00:22:22.320121398Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Apr 24 00:22:22.322147 containerd[1588]: time="2026-04-24T00:22:22.322062685Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:22.324939 containerd[1588]: time="2026-04-24T00:22:22.324843870Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:22.325568 containerd[1588]: time="2026-04-24T00:22:22.325508295Z" 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.549783259s" Apr 24 00:22:22.325568 containerd[1588]: time="2026-04-24T00:22:22.325565863Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Apr 24 00:22:22.331548 containerd[1588]: time="2026-04-24T00:22:22.331483763Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Apr 24 00:22:22.341487 containerd[1588]: time="2026-04-24T00:22:22.341436531Z" level=info msg="Container 89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:22.351686 containerd[1588]: time="2026-04-24T00:22:22.351498614Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246\"" Apr 24 00:22:22.352535 containerd[1588]: time="2026-04-24T00:22:22.352475437Z" level=info msg="StartContainer for \"89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246\"" Apr 24 00:22:22.353603 containerd[1588]: time="2026-04-24T00:22:22.353248073Z" level=info msg="connecting to shim 89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246" address="unix:///run/containerd/s/cbdb9f41f7c870aa15368388faa5e7b8156c176e08f905d01d7e8b975ee75643" protocol=ttrpc version=3 Apr 24 00:22:22.378509 systemd[1]: Started cri-containerd-89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246.scope - libcontainer container 89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246. Apr 24 00:22:22.415758 systemd[1]: cri-containerd-89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246.scope: Deactivated successfully. Apr 24 00:22:22.420225 containerd[1588]: time="2026-04-24T00:22:22.420055664Z" level=info msg="received container exit event container_id:\"89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246\" id:\"89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246\" pid:2211 exited_at:{seconds:1776990142 nanos:419132958}" Apr 24 00:22:22.420378 containerd[1588]: time="2026-04-24T00:22:22.420351718Z" level=info msg="StartContainer for \"89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246\" returns successfully" Apr 24 00:22:22.467976 kubelet[1871]: E0424 00:22:22.467721 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:22.647367 containerd[1588]: time="2026-04-24T00:22:22.646908476Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Apr 24 00:22:23.172190 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-89d1db248d091f8db5640496927b48e2858809f36d4799a0eb34625f149c4246-rootfs.mount: Deactivated successfully. Apr 24 00:22:23.468952 kubelet[1871]: E0424 00:22:23.468708 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:24.469356 kubelet[1871]: E0424 00:22:24.469244 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:24.817712 containerd[1588]: time="2026-04-24T00:22:24.817117281Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:24.818608 containerd[1588]: time="2026-04-24T00:22:24.818560426Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Apr 24 00:22:24.819911 containerd[1588]: time="2026-04-24T00:22:24.819764797Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:24.823120 containerd[1588]: time="2026-04-24T00:22:24.823064073Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:24.824116 containerd[1588]: time="2026-04-24T00:22:24.824047037Z" 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 2.177072093s" Apr 24 00:22:24.824116 containerd[1588]: time="2026-04-24T00:22:24.824101596Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Apr 24 00:22:24.829025 containerd[1588]: time="2026-04-24T00:22:24.828970288Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Apr 24 00:22:24.836610 containerd[1588]: time="2026-04-24T00:22:24.836557330Z" level=info msg="Container 6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:24.845698 containerd[1588]: time="2026-04-24T00:22:24.845625118Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb\"" Apr 24 00:22:24.846783 containerd[1588]: time="2026-04-24T00:22:24.846625016Z" level=info msg="StartContainer for \"6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb\"" Apr 24 00:22:24.847818 containerd[1588]: time="2026-04-24T00:22:24.847513842Z" level=info msg="connecting to shim 6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb" address="unix:///run/containerd/s/cbdb9f41f7c870aa15368388faa5e7b8156c176e08f905d01d7e8b975ee75643" protocol=ttrpc version=3 Apr 24 00:22:24.873698 systemd[1]: Started cri-containerd-6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb.scope - libcontainer container 6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb. Apr 24 00:22:24.912474 systemd[1]: cri-containerd-6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb.scope: Deactivated successfully. Apr 24 00:22:24.914707 containerd[1588]: time="2026-04-24T00:22:24.914559941Z" level=info msg="received container exit event container_id:\"6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb\" id:\"6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb\" pid:2285 exited_at:{seconds:1776990144 nanos:912011717}" Apr 24 00:22:24.916383 containerd[1588]: time="2026-04-24T00:22:24.916227113Z" level=info msg="StartContainer for \"6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb\" returns successfully" Apr 24 00:22:24.918796 kubelet[1871]: I0424 00:22:24.918777 1871 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Apr 24 00:22:24.946404 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-6a1ea9f9bf9874e20b996eb74a97d37b92aa68c53d08933adf1e603f551854fb-rootfs.mount: Deactivated successfully. Apr 24 00:22:25.469786 kubelet[1871]: E0424 00:22:25.469567 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:25.663947 containerd[1588]: time="2026-04-24T00:22:25.663791033Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Apr 24 00:22:25.678614 containerd[1588]: time="2026-04-24T00:22:25.678517588Z" level=info msg="Container f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:25.689873 containerd[1588]: time="2026-04-24T00:22:25.689620669Z" level=info msg="CreateContainer within sandbox \"9ca725083bcee29d2eb7788d0a8772f17f4382f3693fbc8d2983c6d2225fe510\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2\"" Apr 24 00:22:25.692428 containerd[1588]: time="2026-04-24T00:22:25.692236733Z" level=info msg="StartContainer for \"f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2\"" Apr 24 00:22:25.693681 containerd[1588]: time="2026-04-24T00:22:25.693485304Z" level=info msg="connecting to shim f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2" address="unix:///run/containerd/s/cbdb9f41f7c870aa15368388faa5e7b8156c176e08f905d01d7e8b975ee75643" protocol=ttrpc version=3 Apr 24 00:22:25.719595 systemd[1]: Started cri-containerd-f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2.scope - libcontainer container f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2. Apr 24 00:22:25.772888 containerd[1588]: time="2026-04-24T00:22:25.772598873Z" level=info msg="StartContainer for \"f19350edd4358beb67c1185cc7c5d6ed4b847a1efe7695987ec9d2cf7f6145f2\" returns successfully" Apr 24 00:22:26.471070 kubelet[1871]: E0424 00:22:26.470841 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:26.864029 systemd-networkd[1498]: flannel.1: Link UP Apr 24 00:22:26.864039 systemd-networkd[1498]: flannel.1: Gained carrier Apr 24 00:22:27.472549 kubelet[1871]: E0424 00:22:27.472057 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:28.473418 kubelet[1871]: E0424 00:22:28.472920 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:28.516465 systemd-networkd[1498]: flannel.1: Gained IPv6LL Apr 24 00:22:28.641886 kubelet[1871]: I0424 00:22:28.641394 1871 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-9ghjs" podStartSLOduration=6.25706992 podStartE2EDuration="11.6413709s" podCreationTimestamp="2026-04-24 00:22:17 +0000 UTC" firstStartedPulling="2026-04-24 00:22:19.440707326 +0000 UTC m=+2.563086974" lastFinishedPulling="2026-04-24 00:22:24.825008306 +0000 UTC m=+7.947387954" observedRunningTime="2026-04-24 00:22:26.687205416 +0000 UTC m=+9.809585079" watchObservedRunningTime="2026-04-24 00:22:28.6413709 +0000 UTC m=+11.763750553" Apr 24 00:22:28.654700 systemd[1]: Created slice kubepods-besteffort-podfc203e61_2dc2_47c9_95b4_2c71ef1ba62c.slice - libcontainer container kubepods-besteffort-podfc203e61_2dc2_47c9_95b4_2c71ef1ba62c.slice. Apr 24 00:22:28.669417 kubelet[1871]: I0424 00:22:28.668813 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zwfpd\" (UniqueName: \"kubernetes.io/projected/fc203e61-2dc2-47c9-95b4-2c71ef1ba62c-kube-api-access-zwfpd\") pod \"nginx-deployment-7fcdb87857-pz4fw\" (UID: \"fc203e61-2dc2-47c9-95b4-2c71ef1ba62c\") " pod="default/nginx-deployment-7fcdb87857-pz4fw" Apr 24 00:22:28.960043 containerd[1588]: time="2026-04-24T00:22:28.959781734Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-pz4fw,Uid:fc203e61-2dc2-47c9-95b4-2c71ef1ba62c,Namespace:default,Attempt:0,}" Apr 24 00:22:28.982793 systemd-networkd[1498]: cni0: Link UP Apr 24 00:22:28.994227 systemd-networkd[1498]: veth1b097cb0: Link UP Apr 24 00:22:29.000216 kernel: cni0: port 1(veth1b097cb0) entered blocking state Apr 24 00:22:29.000707 kernel: cni0: port 1(veth1b097cb0) entered disabled state Apr 24 00:22:29.000736 kernel: veth1b097cb0: entered allmulticast mode Apr 24 00:22:29.006818 kernel: veth1b097cb0: entered promiscuous mode Apr 24 00:22:29.021467 kernel: cni0: port 1(veth1b097cb0) entered blocking state Apr 24 00:22:29.021551 kernel: cni0: port 1(veth1b097cb0) entered forwarding state Apr 24 00:22:29.023553 systemd-networkd[1498]: veth1b097cb0: Gained carrier Apr 24 00:22:29.024384 systemd-networkd[1498]: cni0: Gained carrier Apr 24 00:22:29.025611 containerd[1588]: 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)(0xc00011a950), "name":"cbr0", "type":"bridge"} Apr 24 00:22:29.025611 containerd[1588]: delegateAdd: netconf sent to delegate plugin: Apr 24 00:22:29.064996 containerd[1588]: {"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-24T00:22:29.064915748Z" level=info msg="connecting to shim 42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33" address="unix:///run/containerd/s/340fa17ef398df2ca8ef204b04dd9b7e3113100c0ef4128d65e6082e169d6f70" namespace=k8s.io protocol=ttrpc version=3 Apr 24 00:22:29.105573 systemd[1]: Started cri-containerd-42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33.scope - libcontainer container 42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33. Apr 24 00:22:29.118386 systemd-resolved[1501]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 24 00:22:29.167722 containerd[1588]: time="2026-04-24T00:22:29.167490117Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-pz4fw,Uid:fc203e61-2dc2-47c9-95b4-2c71ef1ba62c,Namespace:default,Attempt:0,} returns sandbox id \"42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33\"" Apr 24 00:22:29.170126 containerd[1588]: time="2026-04-24T00:22:29.169931040Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 24 00:22:29.474526 kubelet[1871]: E0424 00:22:29.474428 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:30.475489 kubelet[1871]: E0424 00:22:30.475025 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:30.820733 systemd-networkd[1498]: veth1b097cb0: Gained IPv6LL Apr 24 00:22:30.947910 systemd-networkd[1498]: cni0: Gained IPv6LL Apr 24 00:22:31.475557 kubelet[1871]: E0424 00:22:31.475327 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:31.802848 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4080626323.mount: Deactivated successfully. Apr 24 00:22:32.475917 kubelet[1871]: E0424 00:22:32.475871 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:33.510923 kubelet[1871]: E0424 00:22:33.510576 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:34.053842 containerd[1588]: time="2026-04-24T00:22:34.053525409Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:34.054748 containerd[1588]: time="2026-04-24T00:22:34.054638246Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=66917163" Apr 24 00:22:34.056238 containerd[1588]: time="2026-04-24T00:22:34.056171339Z" level=info msg="ImageCreate event name:\"sha256:4ef7ae9013671710084f86771f08d1c9aac3b76e23970ccb73c46f12abeed59d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:34.059160 containerd[1588]: time="2026-04-24T00:22:34.059074743Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:34.060006 containerd[1588]: time="2026-04-24T00:22:34.059931924Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:4ef7ae9013671710084f86771f08d1c9aac3b76e23970ccb73c46f12abeed59d\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\", size \"66917041\" in 4.889940789s" Apr 24 00:22:34.060006 containerd[1588]: time="2026-04-24T00:22:34.059993215Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:4ef7ae9013671710084f86771f08d1c9aac3b76e23970ccb73c46f12abeed59d\"" Apr 24 00:22:34.065615 containerd[1588]: time="2026-04-24T00:22:34.065551699Z" level=info msg="CreateContainer within sandbox \"42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Apr 24 00:22:34.077865 containerd[1588]: time="2026-04-24T00:22:34.077741829Z" level=info msg="Container 60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:34.086557 containerd[1588]: time="2026-04-24T00:22:34.086414285Z" level=info msg="CreateContainer within sandbox \"42599c518cd1aa60dd881d887f039f6abfe45a24fcf38abd3d3c992c328deb33\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf\"" Apr 24 00:22:34.089341 containerd[1588]: time="2026-04-24T00:22:34.088078064Z" level=info msg="StartContainer for \"60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf\"" Apr 24 00:22:34.089918 containerd[1588]: time="2026-04-24T00:22:34.089791595Z" level=info msg="connecting to shim 60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf" address="unix:///run/containerd/s/340fa17ef398df2ca8ef204b04dd9b7e3113100c0ef4128d65e6082e169d6f70" protocol=ttrpc version=3 Apr 24 00:22:34.154623 systemd[1]: Started cri-containerd-60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf.scope - libcontainer container 60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf. Apr 24 00:22:34.375938 containerd[1588]: time="2026-04-24T00:22:34.375785495Z" level=info msg="StartContainer for \"60e7c045e190c89458160e237958b0deae131b4f072e785c0209d7122c0afccf\" returns successfully" Apr 24 00:22:34.512050 kubelet[1871]: E0424 00:22:34.511901 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:35.513210 kubelet[1871]: E0424 00:22:35.512844 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:36.514970 kubelet[1871]: E0424 00:22:36.514416 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:37.465830 kubelet[1871]: E0424 00:22:37.465453 1871 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:37.516737 kubelet[1871]: E0424 00:22:37.516250 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:38.517893 kubelet[1871]: E0424 00:22:38.517577 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:39.518761 kubelet[1871]: E0424 00:22:39.518541 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:40.141833 kubelet[1871]: I0424 00:22:40.141595 1871 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-pz4fw" podStartSLOduration=7.249814291 podStartE2EDuration="12.141571774s" podCreationTimestamp="2026-04-24 00:22:28 +0000 UTC" firstStartedPulling="2026-04-24 00:22:29.169421639 +0000 UTC m=+12.291801288" lastFinishedPulling="2026-04-24 00:22:34.061179123 +0000 UTC m=+17.183558771" observedRunningTime="2026-04-24 00:22:34.715967388 +0000 UTC m=+17.838347055" watchObservedRunningTime="2026-04-24 00:22:40.141571774 +0000 UTC m=+23.263951486" Apr 24 00:22:40.150546 systemd[1]: Created slice kubepods-besteffort-pod92236290_4c5c_4a0f_a2e0_1054c7eb6dc7.slice - libcontainer container kubepods-besteffort-pod92236290_4c5c_4a0f_a2e0_1054c7eb6dc7.slice. Apr 24 00:22:40.241180 kubelet[1871]: I0424 00:22:40.240799 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-88sfq\" (UniqueName: \"kubernetes.io/projected/92236290-4c5c-4a0f-a2e0-1054c7eb6dc7-kube-api-access-88sfq\") pod \"nfs-server-provisioner-0\" (UID: \"92236290-4c5c-4a0f-a2e0-1054c7eb6dc7\") " pod="default/nfs-server-provisioner-0" Apr 24 00:22:40.241180 kubelet[1871]: I0424 00:22:40.240971 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/92236290-4c5c-4a0f-a2e0-1054c7eb6dc7-data\") pod \"nfs-server-provisioner-0\" (UID: \"92236290-4c5c-4a0f-a2e0-1054c7eb6dc7\") " pod="default/nfs-server-provisioner-0" Apr 24 00:22:40.454800 containerd[1588]: time="2026-04-24T00:22:40.454718990Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:92236290-4c5c-4a0f-a2e0-1054c7eb6dc7,Namespace:default,Attempt:0,}" Apr 24 00:22:40.480703 kernel: cni0: port 2(veth8630fca8) entered blocking state Apr 24 00:22:40.480799 kernel: cni0: port 2(veth8630fca8) entered disabled state Apr 24 00:22:40.480774 systemd-networkd[1498]: veth8630fca8: Link UP Apr 24 00:22:40.483579 kernel: veth8630fca8: entered allmulticast mode Apr 24 00:22:40.483674 kernel: veth8630fca8: entered promiscuous mode Apr 24 00:22:40.496369 kernel: cni0: port 2(veth8630fca8) entered blocking state Apr 24 00:22:40.496424 kernel: cni0: port 2(veth8630fca8) entered forwarding state Apr 24 00:22:40.496454 systemd-networkd[1498]: veth8630fca8: Gained carrier Apr 24 00:22:40.498444 containerd[1588]: 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 24 00:22:40.498444 containerd[1588]: delegateAdd: netconf sent to delegate plugin: Apr 24 00:22:40.520004 kubelet[1871]: E0424 00:22:40.519895 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:40.539195 containerd[1588]: {"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-24T00:22:40.538728300Z" level=info msg="connecting to shim 1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1" address="unix:///run/containerd/s/a26728bbc3fd91e65dc9920ece68c47a17cfc13ef8bf66accc151ff6f640df7e" namespace=k8s.io protocol=ttrpc version=3 Apr 24 00:22:40.689474 systemd[1]: Started cri-containerd-1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1.scope - libcontainer container 1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1. Apr 24 00:22:40.722787 systemd-resolved[1501]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 24 00:22:40.845973 containerd[1588]: time="2026-04-24T00:22:40.845816736Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:92236290-4c5c-4a0f-a2e0-1054c7eb6dc7,Namespace:default,Attempt:0,} returns sandbox id \"1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1\"" Apr 24 00:22:40.848382 containerd[1588]: time="2026-04-24T00:22:40.848330734Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Apr 24 00:22:41.521385 kubelet[1871]: E0424 00:22:41.520645 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:42.404184 systemd-networkd[1498]: veth8630fca8: Gained IPv6LL Apr 24 00:22:42.521033 kubelet[1871]: E0424 00:22:42.520863 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:43.185888 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount616157234.mount: Deactivated successfully. Apr 24 00:22:43.529339 kubelet[1871]: E0424 00:22:43.527700 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:44.528447 kubelet[1871]: E0424 00:22:44.528198 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:45.476467 containerd[1588]: time="2026-04-24T00:22:45.476249356Z" 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 24 00:22:45.478032 containerd[1588]: time="2026-04-24T00:22:45.477455399Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039034" Apr 24 00:22:45.480015 containerd[1588]: time="2026-04-24T00:22:45.479479339Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:45.483295 containerd[1588]: time="2026-04-24T00:22:45.483048700Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:45.483856 containerd[1588]: time="2026-04-24T00:22:45.483798319Z" 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 4.635433401s" Apr 24 00:22:45.483856 containerd[1588]: time="2026-04-24T00:22:45.483845222Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Apr 24 00:22:45.489154 containerd[1588]: time="2026-04-24T00:22:45.489119083Z" level=info msg="CreateContainer within sandbox \"1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Apr 24 00:22:45.505249 containerd[1588]: time="2026-04-24T00:22:45.505209266Z" level=info msg="Container a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:45.509158 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2285395739.mount: Deactivated successfully. Apr 24 00:22:45.519139 containerd[1588]: time="2026-04-24T00:22:45.518826847Z" level=info msg="CreateContainer within sandbox \"1c622c5fe20f42524818aecfb5157a3b2d55f8964fbc4a2ca49a5ee7599368d1\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d\"" Apr 24 00:22:45.519958 containerd[1588]: time="2026-04-24T00:22:45.519919914Z" level=info msg="StartContainer for \"a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d\"" Apr 24 00:22:45.522222 containerd[1588]: time="2026-04-24T00:22:45.522029791Z" level=info msg="connecting to shim a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d" address="unix:///run/containerd/s/a26728bbc3fd91e65dc9920ece68c47a17cfc13ef8bf66accc151ff6f640df7e" protocol=ttrpc version=3 Apr 24 00:22:45.528633 kubelet[1871]: E0424 00:22:45.528603 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:45.557458 systemd[1]: Started cri-containerd-a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d.scope - libcontainer container a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d. Apr 24 00:22:45.644083 containerd[1588]: time="2026-04-24T00:22:45.644046307Z" level=info msg="StartContainer for \"a70e12fdf78e50f82376eff6542bdbfe3ee91919bb32ffaafad6d3af4830b81d\" returns successfully" Apr 24 00:22:45.764129 kubelet[1871]: I0424 00:22:45.763656 1871 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.126991439 podStartE2EDuration="5.763636683s" podCreationTimestamp="2026-04-24 00:22:40 +0000 UTC" firstStartedPulling="2026-04-24 00:22:40.848088573 +0000 UTC m=+23.970468226" lastFinishedPulling="2026-04-24 00:22:45.48473382 +0000 UTC m=+28.607113470" observedRunningTime="2026-04-24 00:22:45.76347389 +0000 UTC m=+28.885853558" watchObservedRunningTime="2026-04-24 00:22:45.763636683 +0000 UTC m=+28.886016339" Apr 24 00:22:46.529989 kubelet[1871]: E0424 00:22:46.529756 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:47.530848 kubelet[1871]: E0424 00:22:47.530457 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:48.530893 kubelet[1871]: E0424 00:22:48.530760 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:49.532189 kubelet[1871]: E0424 00:22:49.531978 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:50.532822 kubelet[1871]: E0424 00:22:50.532523 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:50.946533 systemd[1]: Created slice kubepods-besteffort-pod3298fa0e_baa9_463c_b4f0_984810238bbc.slice - libcontainer container kubepods-besteffort-pod3298fa0e_baa9_463c_b4f0_984810238bbc.slice. Apr 24 00:22:51.122190 kubelet[1871]: I0424 00:22:51.121752 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-jkr5t\" (UniqueName: \"kubernetes.io/projected/3298fa0e-baa9-463c-b4f0-984810238bbc-kube-api-access-jkr5t\") pod \"test-pod-1\" (UID: \"3298fa0e-baa9-463c-b4f0-984810238bbc\") " pod="default/test-pod-1" Apr 24 00:22:51.122190 kubelet[1871]: I0424 00:22:51.122080 1871 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-11aebcab-e0f5-4306-882b-7aff6668da0c\" (UniqueName: \"kubernetes.io/nfs/3298fa0e-baa9-463c-b4f0-984810238bbc-pvc-11aebcab-e0f5-4306-882b-7aff6668da0c\") pod \"test-pod-1\" (UID: \"3298fa0e-baa9-463c-b4f0-984810238bbc\") " pod="default/test-pod-1" Apr 24 00:22:51.272408 kernel: netfs: FS-Cache loaded Apr 24 00:22:51.338362 kernel: RPC: Registered named UNIX socket transport module. Apr 24 00:22:51.338923 kernel: RPC: Registered udp transport module. Apr 24 00:22:51.338943 kernel: RPC: Registered tcp transport module. Apr 24 00:22:51.339186 kernel: RPC: Registered tcp-with-tls transport module. Apr 24 00:22:51.340573 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 24 00:22:51.512128 kernel: NFS: Registering the id_resolver key type Apr 24 00:22:51.512414 kernel: Key type id_resolver registered Apr 24 00:22:51.512436 kernel: Key type id_legacy registered Apr 24 00:22:51.532935 kubelet[1871]: E0424 00:22:51.532825 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:51.542708 nfsidmap[2877]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Apr 24 00:22:51.543472 nfsidmap[2877]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 24 00:22:51.545501 nfsidmap[2878]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Apr 24 00:22:51.545656 nfsidmap[2878]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 24 00:22:51.854179 containerd[1588]: time="2026-04-24T00:22:51.854004562Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:3298fa0e-baa9-463c-b4f0-984810238bbc,Namespace:default,Attempt:0,}" Apr 24 00:22:51.883712 systemd-networkd[1498]: veth2a42bab6: Link UP Apr 24 00:22:51.886236 kernel: cni0: port 3(veth2a42bab6) entered blocking state Apr 24 00:22:51.886321 kernel: cni0: port 3(veth2a42bab6) entered disabled state Apr 24 00:22:51.888409 kernel: veth2a42bab6: entered allmulticast mode Apr 24 00:22:51.889337 kernel: veth2a42bab6: entered promiscuous mode Apr 24 00:22:51.902340 kernel: cni0: port 3(veth2a42bab6) entered blocking state Apr 24 00:22:51.902556 kernel: cni0: port 3(veth2a42bab6) entered forwarding state Apr 24 00:22:51.902382 systemd-networkd[1498]: veth2a42bab6: Gained carrier Apr 24 00:22:51.904161 containerd[1588]: 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)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Apr 24 00:22:51.904161 containerd[1588]: delegateAdd: netconf sent to delegate plugin: Apr 24 00:22:51.932272 containerd[1588]: {"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-24T00:22:51.932198051Z" level=info msg="connecting to shim 6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0" address="unix:///run/containerd/s/c2c08e68e350792ccdeacb1691c3136782fca91a9c5064a1056ed3c579ec7faf" namespace=k8s.io protocol=ttrpc version=3 Apr 24 00:22:51.977498 systemd[1]: Started cri-containerd-6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0.scope - libcontainer container 6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0. Apr 24 00:22:51.991742 systemd-resolved[1501]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 24 00:22:52.351362 containerd[1588]: time="2026-04-24T00:22:52.351225475Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:3298fa0e-baa9-463c-b4f0-984810238bbc,Namespace:default,Attempt:0,} returns sandbox id \"6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0\"" Apr 24 00:22:52.352890 containerd[1588]: time="2026-04-24T00:22:52.352669018Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 24 00:22:52.534045 kubelet[1871]: E0424 00:22:52.533809 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:52.825586 containerd[1588]: time="2026-04-24T00:22:52.825367664Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 00:22:52.826896 containerd[1588]: time="2026-04-24T00:22:52.826715820Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Apr 24 00:22:52.829945 containerd[1588]: time="2026-04-24T00:22:52.829840676Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:4ef7ae9013671710084f86771f08d1c9aac3b76e23970ccb73c46f12abeed59d\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\", size \"66917041\" in 477.143405ms" Apr 24 00:22:52.829945 containerd[1588]: time="2026-04-24T00:22:52.829936889Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:4ef7ae9013671710084f86771f08d1c9aac3b76e23970ccb73c46f12abeed59d\"" Apr 24 00:22:52.835779 containerd[1588]: time="2026-04-24T00:22:52.835736898Z" level=info msg="CreateContainer within sandbox \"6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0\" for container &ContainerMetadata{Name:test,Attempt:0,}" Apr 24 00:22:52.846890 containerd[1588]: time="2026-04-24T00:22:52.846831594Z" level=info msg="Container c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27: CDI devices from CRI Config.CDIDevices: []" Apr 24 00:22:52.849890 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2801960170.mount: Deactivated successfully. Apr 24 00:22:52.856415 containerd[1588]: time="2026-04-24T00:22:52.856355610Z" level=info msg="CreateContainer within sandbox \"6538f7f49b553ff93676b58aaf272deaf070d1e1c9cc506954a37306278313e0\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27\"" Apr 24 00:22:52.857193 containerd[1588]: time="2026-04-24T00:22:52.857167361Z" level=info msg="StartContainer for \"c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27\"" Apr 24 00:22:52.858739 containerd[1588]: time="2026-04-24T00:22:52.858086023Z" level=info msg="connecting to shim c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27" address="unix:///run/containerd/s/c2c08e68e350792ccdeacb1691c3136782fca91a9c5064a1056ed3c579ec7faf" protocol=ttrpc version=3 Apr 24 00:22:52.878484 systemd[1]: Started cri-containerd-c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27.scope - libcontainer container c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27. Apr 24 00:22:52.912085 containerd[1588]: time="2026-04-24T00:22:52.912011882Z" level=info msg="StartContainer for \"c61bcb62f12ce94074f00d03136995ab4d0984de82d8d289a3a401420fca9f27\" returns successfully" Apr 24 00:22:53.534580 kubelet[1871]: E0424 00:22:53.534374 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:53.539628 systemd-networkd[1498]: veth2a42bab6: Gained IPv6LL Apr 24 00:22:53.784239 kubelet[1871]: I0424 00:22:53.783996 1871 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=13.305462446 podStartE2EDuration="13.783978308s" podCreationTimestamp="2026-04-24 00:22:40 +0000 UTC" firstStartedPulling="2026-04-24 00:22:52.352417814 +0000 UTC m=+35.474797462" lastFinishedPulling="2026-04-24 00:22:52.83093367 +0000 UTC m=+35.953313324" observedRunningTime="2026-04-24 00:22:53.783853994 +0000 UTC m=+36.906233653" watchObservedRunningTime="2026-04-24 00:22:53.783978308 +0000 UTC m=+36.906357971" Apr 24 00:22:54.535531 kubelet[1871]: E0424 00:22:54.535227 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:55.536769 kubelet[1871]: E0424 00:22:55.536517 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:55.748028 update_engine[1573]: I20260424 00:22:55.746392 1573 update_attempter.cc:509] Updating boot flags... Apr 24 00:22:56.537632 kubelet[1871]: E0424 00:22:56.537351 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:57.464442 kubelet[1871]: E0424 00:22:57.463940 1871 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 00:22:57.537688 kubelet[1871]: E0424 00:22:57.537631 1871 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"