Jul 23 12:51:24.877629 kernel: Linux version 6.6.144-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Tue Jul 21 22:37:50 -00 2026 Jul 23 12:51:24.877650 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=2d91882d943e69b27bf8e0cc1d759bb914232ac1324e41b6960fd29207b8ecad Jul 23 12:51:24.877660 kernel: BIOS-provided physical RAM map: Jul 23 12:51:24.877665 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jul 23 12:51:24.877670 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Jul 23 12:51:24.877675 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Jul 23 12:51:24.877681 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Jul 23 12:51:24.877686 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Jul 23 12:51:24.877691 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Jul 23 12:51:24.877696 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Jul 23 12:51:24.877702 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Jul 23 12:51:24.877708 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Jul 23 12:51:24.877713 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Jul 23 12:51:24.877718 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Jul 23 12:51:24.877725 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Jul 23 12:51:24.877730 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Jul 23 12:51:24.877737 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Jul 23 12:51:24.877743 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Jul 23 12:51:24.877748 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Jul 23 12:51:24.877753 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jul 23 12:51:24.877759 kernel: NX (Execute Disable) protection: active Jul 23 12:51:24.877764 kernel: APIC: Static calls initialized Jul 23 12:51:24.877769 kernel: efi: EFI v2.7 by EDK II Jul 23 12:51:24.877775 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b675198 Jul 23 12:51:24.877780 kernel: SMBIOS 2.8 present. Jul 23 12:51:24.877786 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Jul 23 12:51:24.877791 kernel: Hypervisor detected: KVM Jul 23 12:51:24.877796 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 23 12:51:24.877803 kernel: kvm-clock: using sched offset of 4833278729 cycles Jul 23 12:51:24.877809 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 23 12:51:24.877815 kernel: tsc: Detected 2793.438 MHz processor Jul 23 12:51:24.877821 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 23 12:51:24.877827 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 23 12:51:24.877832 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x10000000000 Jul 23 12:51:24.877838 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jul 23 12:51:24.877844 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 23 12:51:24.877851 kernel: Using GB pages for direct mapping Jul 23 12:51:24.877856 kernel: Secure boot disabled Jul 23 12:51:24.877862 kernel: ACPI: Early table checksum verification disabled Jul 23 12:51:24.877868 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Jul 23 12:51:24.877876 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Jul 23 12:51:24.877882 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877888 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877895 kernel: ACPI: FACS 0x000000009CBDD000 000040 Jul 23 12:51:24.877901 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877906 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877912 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877918 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 23 12:51:24.877924 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Jul 23 12:51:24.877930 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Jul 23 12:51:24.877938 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Jul 23 12:51:24.877943 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Jul 23 12:51:24.877949 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Jul 23 12:51:24.877955 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Jul 23 12:51:24.877961 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Jul 23 12:51:24.877967 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Jul 23 12:51:24.877972 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Jul 23 12:51:24.877978 kernel: No NUMA configuration found Jul 23 12:51:24.877984 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Jul 23 12:51:24.877990 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Jul 23 12:51:24.877997 kernel: Zone ranges: Jul 23 12:51:24.878003 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 23 12:51:24.878009 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Jul 23 12:51:24.878037 kernel: Normal empty Jul 23 12:51:24.878046 kernel: Movable zone start for each node Jul 23 12:51:24.878055 kernel: Early memory node ranges Jul 23 12:51:24.878063 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jul 23 12:51:24.878072 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Jul 23 12:51:24.878081 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Jul 23 12:51:24.878126 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Jul 23 12:51:24.878134 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Jul 23 12:51:24.878143 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Jul 23 12:51:24.878152 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Jul 23 12:51:24.878161 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 23 12:51:24.878170 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jul 23 12:51:24.878180 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Jul 23 12:51:24.878188 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 23 12:51:24.878197 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Jul 23 12:51:24.878205 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Jul 23 12:51:24.878216 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Jul 23 12:51:24.878225 kernel: ACPI: PM-Timer IO Port: 0x608 Jul 23 12:51:24.878233 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 23 12:51:24.878242 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 23 12:51:24.878250 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 23 12:51:24.878258 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 23 12:51:24.878267 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 23 12:51:24.878274 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 23 12:51:24.878282 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 23 12:51:24.878292 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 23 12:51:24.878301 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 23 12:51:24.878310 kernel: TSC deadline timer available Jul 23 12:51:24.878319 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jul 23 12:51:24.878327 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 23 12:51:24.878335 kernel: kvm-guest: KVM setup pv remote TLB flush Jul 23 12:51:24.878340 kernel: kvm-guest: setup PV sched yield Jul 23 12:51:24.878345 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Jul 23 12:51:24.878350 kernel: Booting paravirtualized kernel on KVM Jul 23 12:51:24.878357 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 23 12:51:24.878362 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 23 12:51:24.878367 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u524288 Jul 23 12:51:24.878372 kernel: pcpu-alloc: s196392 r8192 d28888 u524288 alloc=1*2097152 Jul 23 12:51:24.878377 kernel: pcpu-alloc: [0] 0 1 2 3 Jul 23 12:51:24.878382 kernel: kvm-guest: PV spinlocks enabled Jul 23 12:51:24.878387 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 23 12:51:24.878393 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=2d91882d943e69b27bf8e0cc1d759bb914232ac1324e41b6960fd29207b8ecad Jul 23 12:51:24.878400 kernel: random: crng init done Jul 23 12:51:24.878405 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 23 12:51:24.878409 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 23 12:51:24.878414 kernel: Fallback order for Node 0: 0 Jul 23 12:51:24.878419 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Jul 23 12:51:24.878424 kernel: Policy zone: DMA32 Jul 23 12:51:24.878429 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 23 12:51:24.878434 kernel: Memory: 2397612K/2567000K available (14336K kernel code, 2288K rwdata, 22764K rodata, 42908K init, 2252K bss, 169184K reserved, 0K cma-reserved) Jul 23 12:51:24.878439 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 23 12:51:24.878446 kernel: ftrace: allocating 37469 entries in 148 pages Jul 23 12:51:24.878451 kernel: ftrace: allocated 148 pages with 3 groups Jul 23 12:51:24.878456 kernel: Dynamic Preempt: voluntary Jul 23 12:51:24.878461 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 23 12:51:24.878471 kernel: rcu: RCU event tracing is enabled. Jul 23 12:51:24.878478 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 23 12:51:24.878484 kernel: Trampoline variant of Tasks RCU enabled. Jul 23 12:51:24.878489 kernel: Rude variant of Tasks RCU enabled. Jul 23 12:51:24.878495 kernel: Tracing variant of Tasks RCU enabled. Jul 23 12:51:24.878500 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 23 12:51:24.878506 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 23 12:51:24.878511 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jul 23 12:51:24.878518 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 23 12:51:24.878523 kernel: Console: colour dummy device 80x25 Jul 23 12:51:24.878529 kernel: printk: console [ttyS0] enabled Jul 23 12:51:24.878534 kernel: ACPI: Core revision 20230628 Jul 23 12:51:24.878540 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 23 12:51:24.878547 kernel: APIC: Switch to symmetric I/O mode setup Jul 23 12:51:24.878552 kernel: x2apic enabled Jul 23 12:51:24.878558 kernel: APIC: Switched APIC routing to: physical x2apic Jul 23 12:51:24.878563 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jul 23 12:51:24.878569 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jul 23 12:51:24.878574 kernel: kvm-guest: setup PV IPIs Jul 23 12:51:24.878580 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 23 12:51:24.878585 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jul 23 12:51:24.878591 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Jul 23 12:51:24.878598 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 23 12:51:24.878603 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jul 23 12:51:24.878609 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jul 23 12:51:24.878614 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 23 12:51:24.878626 kernel: Spectre V2 : Mitigation: Retpolines Jul 23 12:51:24.878635 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 23 12:51:24.878644 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Jul 23 12:51:24.878652 kernel: RETBleed: Vulnerable Jul 23 12:51:24.878661 kernel: Speculative Store Bypass: Vulnerable Jul 23 12:51:24.878672 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Jul 23 12:51:24.878681 kernel: GDS: Unknown: Dependent on hypervisor status Jul 23 12:51:24.878690 kernel: active return thunk: its_return_thunk Jul 23 12:51:24.878699 kernel: ITS: Mitigation: Aligned branch/return thunks Jul 23 12:51:24.878704 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 23 12:51:24.878710 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 23 12:51:24.878715 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 23 12:51:24.878721 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Jul 23 12:51:24.878726 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Jul 23 12:51:24.878734 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Jul 23 12:51:24.878739 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 23 12:51:24.878744 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Jul 23 12:51:24.878750 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Jul 23 12:51:24.878755 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Jul 23 12:51:24.878761 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Jul 23 12:51:24.878766 kernel: Freeing SMP alternatives memory: 32K Jul 23 12:51:24.878772 kernel: pid_max: default: 32768 minimum: 301 Jul 23 12:51:24.878777 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jul 23 12:51:24.878784 kernel: landlock: Up and running. Jul 23 12:51:24.878790 kernel: SELinux: Initializing. Jul 23 12:51:24.878796 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 23 12:51:24.878801 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 23 12:51:24.878807 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Jul 23 12:51:24.878812 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 23 12:51:24.878818 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 23 12:51:24.878823 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 23 12:51:24.878830 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Jul 23 12:51:24.878836 kernel: signal: max sigframe size: 3632 Jul 23 12:51:24.878841 kernel: rcu: Hierarchical SRCU implementation. Jul 23 12:51:24.878847 kernel: rcu: Max phase no-delay instances is 400. Jul 23 12:51:24.878852 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jul 23 12:51:24.878858 kernel: smp: Bringing up secondary CPUs ... Jul 23 12:51:24.878863 kernel: smpboot: x86: Booting SMP configuration: Jul 23 12:51:24.878869 kernel: .... node #0, CPUs: #1 #2 #3 Jul 23 12:51:24.878874 kernel: smp: Brought up 1 node, 4 CPUs Jul 23 12:51:24.878881 kernel: smpboot: Max logical packages: 1 Jul 23 12:51:24.878887 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Jul 23 12:51:24.878892 kernel: devtmpfs: initialized Jul 23 12:51:24.878897 kernel: x86/mm: Memory block size: 128MB Jul 23 12:51:24.878903 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Jul 23 12:51:24.878908 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Jul 23 12:51:24.878914 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Jul 23 12:51:24.878920 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Jul 23 12:51:24.878925 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Jul 23 12:51:24.878932 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 23 12:51:24.878938 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 23 12:51:24.878943 kernel: pinctrl core: initialized pinctrl subsystem Jul 23 12:51:24.878949 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 23 12:51:24.878954 kernel: audit: initializing netlink subsys (disabled) Jul 23 12:51:24.878960 kernel: audit: type=2000 audit(1784811084.694:1): state=initialized audit_enabled=0 res=1 Jul 23 12:51:24.878965 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 23 12:51:24.879004 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 23 12:51:24.879012 kernel: cpuidle: using governor menu Jul 23 12:51:24.879042 kernel: efi: Freeing EFI boot services memory: 29232K Jul 23 12:51:24.879049 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 23 12:51:24.879054 kernel: dca service started, version 1.12.1 Jul 23 12:51:24.879060 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jul 23 12:51:24.879066 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jul 23 12:51:24.879071 kernel: PCI: Using configuration type 1 for base access Jul 23 12:51:24.879076 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 23 12:51:24.879082 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 23 12:51:24.879171 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 23 12:51:24.879179 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 23 12:51:24.879184 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 23 12:51:24.879190 kernel: ACPI: Added _OSI(Module Device) Jul 23 12:51:24.879196 kernel: ACPI: Added _OSI(Processor Device) Jul 23 12:51:24.879201 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 23 12:51:24.879207 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 23 12:51:24.879212 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jul 23 12:51:24.879218 kernel: ACPI: Interpreter enabled Jul 23 12:51:24.879223 kernel: ACPI: PM: (supports S0 S3 S5) Jul 23 12:51:24.879230 kernel: ACPI: Using IOAPIC for interrupt routing Jul 23 12:51:24.879236 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 23 12:51:24.879242 kernel: PCI: Using E820 reservations for host bridge windows Jul 23 12:51:24.879248 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jul 23 12:51:24.879253 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 23 12:51:24.879376 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 23 12:51:24.879440 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jul 23 12:51:24.879494 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jul 23 12:51:24.879504 kernel: PCI host bridge to bus 0000:00 Jul 23 12:51:24.879565 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 23 12:51:24.879614 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 23 12:51:24.879662 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 23 12:51:24.879710 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jul 23 12:51:24.879758 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jul 23 12:51:24.879806 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Jul 23 12:51:24.879856 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 23 12:51:24.879925 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jul 23 12:51:24.879990 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Jul 23 12:51:24.880082 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Jul 23 12:51:24.880191 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Jul 23 12:51:24.880261 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Jul 23 12:51:24.880321 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Jul 23 12:51:24.880375 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 23 12:51:24.880449 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Jul 23 12:51:24.880509 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Jul 23 12:51:24.880565 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Jul 23 12:51:24.880620 kernel: pci 0000:00:02.0: BAR 4 [mem 0x800000000-0x800003fff 64bit pref] Jul 23 12:51:24.880679 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Jul 23 12:51:24.880737 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Jul 23 12:51:24.880791 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Jul 23 12:51:24.880846 kernel: pci 0000:00:03.0: BAR 4 [mem 0x800004000-0x800007fff 64bit pref] Jul 23 12:51:24.880906 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Jul 23 12:51:24.880960 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Jul 23 12:51:24.881033 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Jul 23 12:51:24.881112 kernel: pci 0000:00:04.0: BAR 4 [mem 0x800008000-0x80000bfff 64bit pref] Jul 23 12:51:24.881172 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Jul 23 12:51:24.881231 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jul 23 12:51:24.881286 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jul 23 12:51:24.881353 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jul 23 12:51:24.881417 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Jul 23 12:51:24.881470 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Jul 23 12:51:24.881533 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jul 23 12:51:24.881587 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Jul 23 12:51:24.881594 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 23 12:51:24.881599 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 23 12:51:24.881605 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 23 12:51:24.881610 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 23 12:51:24.881616 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jul 23 12:51:24.881621 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jul 23 12:51:24.881627 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jul 23 12:51:24.881634 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jul 23 12:51:24.881640 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jul 23 12:51:24.881645 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jul 23 12:51:24.881651 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jul 23 12:51:24.881656 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jul 23 12:51:24.881662 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jul 23 12:51:24.881668 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jul 23 12:51:24.881673 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jul 23 12:51:24.881679 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jul 23 12:51:24.881686 kernel: iommu: Default domain type: Translated Jul 23 12:51:24.881692 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 23 12:51:24.881697 kernel: efivars: Registered efivars operations Jul 23 12:51:24.881703 kernel: PCI: Using ACPI for IRQ routing Jul 23 12:51:24.881708 kernel: PCI: pci_cache_line_size set to 64 bytes Jul 23 12:51:24.881714 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Jul 23 12:51:24.881719 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Jul 23 12:51:24.881724 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Jul 23 12:51:24.881731 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Jul 23 12:51:24.881786 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jul 23 12:51:24.881839 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jul 23 12:51:24.881893 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 23 12:51:24.881900 kernel: vgaarb: loaded Jul 23 12:51:24.881906 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 23 12:51:24.881912 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 23 12:51:24.881917 kernel: clocksource: Switched to clocksource kvm-clock Jul 23 12:51:24.881923 kernel: VFS: Disk quotas dquot_6.6.0 Jul 23 12:51:24.881930 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 23 12:51:24.881936 kernel: pnp: PnP ACPI init Jul 23 12:51:24.881995 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jul 23 12:51:24.882003 kernel: pnp: PnP ACPI: found 6 devices Jul 23 12:51:24.882009 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 23 12:51:24.882056 kernel: NET: Registered PF_INET protocol family Jul 23 12:51:24.882066 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 23 12:51:24.882071 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 23 12:51:24.882077 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 23 12:51:24.882107 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 23 12:51:24.882113 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 23 12:51:24.882119 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 23 12:51:24.882124 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 23 12:51:24.882130 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 23 12:51:24.882135 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 23 12:51:24.882141 kernel: NET: Registered PF_XDP protocol family Jul 23 12:51:24.882210 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Jul 23 12:51:24.882269 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Jul 23 12:51:24.882323 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 23 12:51:24.882373 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 23 12:51:24.882422 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 23 12:51:24.882471 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jul 23 12:51:24.882521 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jul 23 12:51:24.882569 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Jul 23 12:51:24.882576 kernel: PCI: CLS 0 bytes, default 64 Jul 23 12:51:24.882583 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jul 23 12:51:24.882589 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Jul 23 12:51:24.882595 kernel: Initialise system trusted keyrings Jul 23 12:51:24.882600 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 23 12:51:24.882606 kernel: Key type asymmetric registered Jul 23 12:51:24.882611 kernel: Asymmetric key parser 'x509' registered Jul 23 12:51:24.882617 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jul 23 12:51:24.882622 kernel: io scheduler mq-deadline registered Jul 23 12:51:24.882628 kernel: io scheduler kyber registered Jul 23 12:51:24.882635 kernel: io scheduler bfq registered Jul 23 12:51:24.882641 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 23 12:51:24.882647 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jul 23 12:51:24.882653 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jul 23 12:51:24.882658 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jul 23 12:51:24.882664 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 23 12:51:24.882669 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 23 12:51:24.882675 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 23 12:51:24.882681 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 23 12:51:24.882688 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 23 12:51:24.882750 kernel: rtc_cmos 00:04: RTC can wake from S4 Jul 23 12:51:24.882801 kernel: rtc_cmos 00:04: registered as rtc0 Jul 23 12:51:24.882852 kernel: rtc_cmos 00:04: setting system clock to 2026-07-23T12:51:24 UTC (1784811084) Jul 23 12:51:24.882859 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jul 23 12:51:24.882911 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Jul 23 12:51:24.882918 kernel: intel_pstate: CPU model not supported Jul 23 12:51:24.882924 kernel: efifb: probing for efifb Jul 23 12:51:24.882931 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Jul 23 12:51:24.882937 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Jul 23 12:51:24.882943 kernel: efifb: scrolling: redraw Jul 23 12:51:24.882948 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Jul 23 12:51:24.882954 kernel: Console: switching to colour frame buffer device 100x37 Jul 23 12:51:24.882971 kernel: fb0: EFI VGA frame buffer device Jul 23 12:51:24.882978 kernel: pstore: Using crash dump compression: deflate Jul 23 12:51:24.882984 kernel: pstore: Registered efi_pstore as persistent store backend Jul 23 12:51:24.882990 kernel: NET: Registered PF_INET6 protocol family Jul 23 12:51:24.882997 kernel: Segment Routing with IPv6 Jul 23 12:51:24.883003 kernel: In-situ OAM (IOAM) with IPv6 Jul 23 12:51:24.883009 kernel: NET: Registered PF_PACKET protocol family Jul 23 12:51:24.883048 kernel: Key type dns_resolver registered Jul 23 12:51:24.883058 kernel: IPI shorthand broadcast: enabled Jul 23 12:51:24.883064 kernel: sched_clock: Marking stable (765030930, 206967722)->(1023140222, -51141570) Jul 23 12:51:24.883070 kernel: registered taskstats version 1 Jul 23 12:51:24.883076 kernel: Loading compiled-in X.509 certificates Jul 23 12:51:24.883126 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.144-flatcar: 55ab173a887fd252c1a931e3a78d9fdf7356b8f8' Jul 23 12:51:24.883146 kernel: Key type .fscrypt registered Jul 23 12:51:24.883152 kernel: Key type fscrypt-provisioning registered Jul 23 12:51:24.883157 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 23 12:51:24.883163 kernel: ima: Allocated hash algorithm: sha1 Jul 23 12:51:24.883169 kernel: ima: No architecture policies found Jul 23 12:51:24.883174 kernel: clk: Disabling unused clocks Jul 23 12:51:24.883180 kernel: Freeing unused kernel image (initmem) memory: 42908K Jul 23 12:51:24.883186 kernel: Write protecting the kernel read-only data: 38912k Jul 23 12:51:24.883192 kernel: Freeing unused kernel image (rodata/data gap) memory: 1812K Jul 23 12:51:24.883199 kernel: Run /init as init process Jul 23 12:51:24.883205 kernel: with arguments: Jul 23 12:51:24.883212 kernel: /init Jul 23 12:51:24.883217 kernel: with environment: Jul 23 12:51:24.883223 kernel: HOME=/ Jul 23 12:51:24.883228 kernel: TERM=linux Jul 23 12:51:24.883238 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 23 12:51:24.883246 systemd[1]: Detected virtualization kvm. Jul 23 12:51:24.883252 systemd[1]: Detected architecture x86-64. Jul 23 12:51:24.883258 systemd[1]: Running in initrd. Jul 23 12:51:24.883264 systemd[1]: No hostname configured, using default hostname. Jul 23 12:51:24.883270 systemd[1]: Hostname set to . Jul 23 12:51:24.883278 systemd[1]: Initializing machine ID from VM UUID. Jul 23 12:51:24.883284 systemd[1]: Queued start job for default target initrd.target. Jul 23 12:51:24.883290 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 12:51:24.883296 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 12:51:24.883302 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 23 12:51:24.883309 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 23 12:51:24.883315 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 23 12:51:24.883321 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 23 12:51:24.883330 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 23 12:51:24.883336 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 23 12:51:24.883342 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 12:51:24.883348 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 23 12:51:24.883354 systemd[1]: Reached target paths.target - Path Units. Jul 23 12:51:24.883361 systemd[1]: Reached target slices.target - Slice Units. Jul 23 12:51:24.883367 systemd[1]: Reached target swap.target - Swaps. Jul 23 12:51:24.883373 systemd[1]: Reached target timers.target - Timer Units. Jul 23 12:51:24.883380 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 23 12:51:24.883386 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 23 12:51:24.883394 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 23 12:51:24.883400 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 23 12:51:24.883406 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 23 12:51:24.883412 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 23 12:51:24.883418 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 23 12:51:24.883424 systemd[1]: Reached target sockets.target - Socket Units. Jul 23 12:51:24.883432 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 23 12:51:24.883438 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 23 12:51:24.883444 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 23 12:51:24.883450 systemd[1]: Starting systemd-fsck-usr.service... Jul 23 12:51:24.883456 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 23 12:51:24.883462 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 23 12:51:24.883468 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:24.883474 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 23 12:51:24.883480 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 12:51:24.883506 systemd-journald[194]: Collecting audit messages is disabled. Jul 23 12:51:24.883525 systemd[1]: Finished systemd-fsck-usr.service. Jul 23 12:51:24.883538 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 23 12:51:24.883548 systemd-journald[194]: Journal started Jul 23 12:51:24.883571 systemd-journald[194]: Runtime Journal (/run/log/journal/64bcb72faaf04290b081a29ba1d5b26e) is 6.0M, max 48.2M, 42.2M free. Jul 23 12:51:24.886396 systemd[1]: Started systemd-journald.service - Journal Service. Jul 23 12:51:24.888400 systemd-modules-load[195]: Inserted module 'overlay' Jul 23 12:51:24.892266 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 23 12:51:24.895420 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:24.897302 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 23 12:51:24.902668 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 23 12:51:24.908215 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 23 12:51:24.912340 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 12:51:24.919540 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 12:51:24.927138 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 23 12:51:24.927437 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 12:51:24.931915 systemd-modules-load[195]: Inserted module 'br_netfilter' Jul 23 12:51:24.933403 kernel: Bridge firewalling registered Jul 23 12:51:24.934272 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 23 12:51:24.934904 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 23 12:51:24.939793 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 23 12:51:24.950511 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 23 12:51:24.953306 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 23 12:51:24.958733 dracut-cmdline[223]: dracut-dracut-053 Jul 23 12:51:24.962913 dracut-cmdline[223]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=2d91882d943e69b27bf8e0cc1d759bb914232ac1324e41b6960fd29207b8ecad Jul 23 12:51:24.988670 systemd-resolved[238]: Positive Trust Anchors: Jul 23 12:51:24.988697 systemd-resolved[238]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 23 12:51:24.988725 systemd-resolved[238]: 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 Jul 23 12:51:24.991113 systemd-resolved[238]: Defaulting to hostname 'linux'. Jul 23 12:51:24.992178 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 23 12:51:24.994237 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 23 12:51:25.075167 kernel: SCSI subsystem initialized Jul 23 12:51:25.084210 kernel: Loading iSCSI transport class v2.0-870. Jul 23 12:51:25.097133 kernel: iscsi: registered transport (tcp) Jul 23 12:51:25.121132 kernel: iscsi: registered transport (qla4xxx) Jul 23 12:51:25.121205 kernel: QLogic iSCSI HBA Driver Jul 23 12:51:25.164620 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 23 12:51:25.183303 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 23 12:51:25.206980 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 23 12:51:25.207127 kernel: device-mapper: uevent: version 1.0.3 Jul 23 12:51:25.207146 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 23 12:51:25.252167 kernel: raid6: avx512x4 gen() 32425 MB/s Jul 23 12:51:25.270223 kernel: raid6: avx512x2 gen() 32115 MB/s Jul 23 12:51:25.288156 kernel: raid6: avx512x1 gen() 27921 MB/s Jul 23 12:51:25.305156 kernel: raid6: avx2x4 gen() 22480 MB/s Jul 23 12:51:25.323165 kernel: raid6: avx2x2 gen() 23247 MB/s Jul 23 12:51:25.341516 kernel: raid6: avx2x1 gen() 15862 MB/s Jul 23 12:51:25.341606 kernel: raid6: using algorithm avx512x4 gen() 32425 MB/s Jul 23 12:51:25.360229 kernel: raid6: .... xor() 9494 MB/s, rmw enabled Jul 23 12:51:25.360344 kernel: raid6: using avx512x2 recovery algorithm Jul 23 12:51:25.381205 kernel: xor: automatically using best checksumming function avx Jul 23 12:51:25.527149 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 23 12:51:25.538355 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 23 12:51:25.550404 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 12:51:25.559929 systemd-udevd[415]: Using default interface naming scheme 'v255'. Jul 23 12:51:25.562632 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 12:51:25.566436 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 23 12:51:25.584297 dracut-pre-trigger[426]: rd.md=0: removing MD RAID activation Jul 23 12:51:25.614933 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 23 12:51:25.631440 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 23 12:51:25.673211 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 12:51:25.682411 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 23 12:51:25.694498 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 23 12:51:25.699059 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 23 12:51:25.701474 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 12:51:25.707333 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 23 12:51:25.714509 kernel: cryptd: max_cpu_qlen set to 1000 Jul 23 12:51:25.718141 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jul 23 12:51:25.718422 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 23 12:51:25.723606 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jul 23 12:51:25.732455 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 23 12:51:25.739247 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 23 12:51:25.739267 kernel: GPT:9289727 != 19775487 Jul 23 12:51:25.739274 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 23 12:51:25.739281 kernel: GPT:9289727 != 19775487 Jul 23 12:51:25.739287 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 23 12:51:25.739294 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 23 12:51:25.739301 kernel: AVX2 version of gcm_enc/dec engaged. Jul 23 12:51:25.744128 kernel: AES CTR mode by8 optimization enabled Jul 23 12:51:25.745613 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 23 12:51:25.747604 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 12:51:25.749903 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 23 12:51:25.755641 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 12:51:25.756002 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:25.759763 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:25.768121 kernel: libata version 3.00 loaded. Jul 23 12:51:25.771642 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:25.783192 kernel: ahci 0000:00:1f.2: version 3.0 Jul 23 12:51:25.783402 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jul 23 12:51:25.786135 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jul 23 12:51:25.786277 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jul 23 12:51:25.789260 kernel: scsi host0: ahci Jul 23 12:51:25.789452 kernel: scsi host1: ahci Jul 23 12:51:25.789577 kernel: BTRFS: device fsid e7fae0b8-8bb9-4087-95e6-453a6d9c3ba7 devid 1 transid 32 /dev/vda3 scanned by (udev-worker) (463) Jul 23 12:51:25.789593 kernel: scsi host2: ahci Jul 23 12:51:25.791481 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 23 12:51:25.795566 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (477) Jul 23 12:51:25.798547 kernel: scsi host3: ahci Jul 23 12:51:25.802174 kernel: scsi host4: ahci Jul 23 12:51:25.803116 kernel: scsi host5: ahci Jul 23 12:51:25.803285 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Jul 23 12:51:25.805611 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Jul 23 12:51:25.805648 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Jul 23 12:51:25.807133 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Jul 23 12:51:25.808639 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 23 12:51:25.814198 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Jul 23 12:51:25.814219 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Jul 23 12:51:25.821463 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 23 12:51:25.822617 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 23 12:51:25.826679 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 23 12:51:25.842369 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 23 12:51:25.843511 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 12:51:25.843584 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:25.850348 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:25.858528 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 23 12:51:25.854366 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:25.859618 disk-uuid[568]: Primary Header is updated. Jul 23 12:51:25.859618 disk-uuid[568]: Secondary Entries is updated. Jul 23 12:51:25.859618 disk-uuid[568]: Secondary Header is updated. Jul 23 12:51:25.881134 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 23 12:51:25.883958 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:25.897337 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 23 12:51:25.920795 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 12:51:26.129191 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 23 12:51:26.131167 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jul 23 12:51:26.133145 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jul 23 12:51:26.135199 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 23 12:51:26.135296 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 23 12:51:26.138279 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jul 23 12:51:26.138350 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 23 12:51:26.140308 kernel: ata3.00: applying bridge limits Jul 23 12:51:26.140369 kernel: ata3.00: configured for UDMA/100 Jul 23 12:51:26.142130 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 23 12:51:26.192303 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 23 12:51:26.220256 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 23 12:51:26.233132 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 23 12:51:26.883110 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 23 12:51:26.883487 disk-uuid[569]: The operation has completed successfully. Jul 23 12:51:26.909019 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 23 12:51:26.909171 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 23 12:51:26.933512 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 23 12:51:26.937125 sh[600]: Success Jul 23 12:51:26.949117 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Jul 23 12:51:26.986352 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 23 12:51:27.001049 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 23 12:51:27.008078 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 23 12:51:27.017501 kernel: BTRFS info (device dm-0): first mount of filesystem e7fae0b8-8bb9-4087-95e6-453a6d9c3ba7 Jul 23 12:51:27.017523 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 23 12:51:27.017531 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 23 12:51:27.017546 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 23 12:51:27.018360 kernel: BTRFS info (device dm-0): using free space tree Jul 23 12:51:27.024642 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 23 12:51:27.028398 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 23 12:51:27.034415 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 23 12:51:27.036407 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 23 12:51:27.047372 kernel: BTRFS info (device vda6): first mount of filesystem a4c5dc6a-5e78-4075-b3b8-603040871c79 Jul 23 12:51:27.047406 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 23 12:51:27.047429 kernel: BTRFS info (device vda6): using free space tree Jul 23 12:51:27.051168 kernel: BTRFS info (device vda6): auto enabling async discard Jul 23 12:51:27.059852 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 23 12:51:27.063016 kernel: BTRFS info (device vda6): last unmount of filesystem a4c5dc6a-5e78-4075-b3b8-603040871c79 Jul 23 12:51:27.068951 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 23 12:51:27.080365 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 23 12:51:27.137978 ignition[689]: Ignition 2.19.0 Jul 23 12:51:27.137999 ignition[689]: Stage: fetch-offline Jul 23 12:51:27.138397 ignition[689]: no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:27.138408 ignition[689]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:27.138527 ignition[689]: parsed url from cmdline: "" Jul 23 12:51:27.138530 ignition[689]: no config URL provided Jul 23 12:51:27.138535 ignition[689]: reading system config file "/usr/lib/ignition/user.ign" Jul 23 12:51:27.138543 ignition[689]: no config at "/usr/lib/ignition/user.ign" Jul 23 12:51:27.138623 ignition[689]: op(1): [started] loading QEMU firmware config module Jul 23 12:51:27.138629 ignition[689]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 23 12:51:27.149895 ignition[689]: op(1): [finished] loading QEMU firmware config module Jul 23 12:51:27.150759 ignition[689]: parsing config with SHA512: 849808ed8de89f6db3db941a69a3e8b70747926bb2b3c95525f64150b60dd97a2bb2dd4943f95fba5544cd581df6f3323721613ba77eca6b80e56040c73a3257 Jul 23 12:51:27.153071 unknown[689]: fetched base config from "system" Jul 23 12:51:27.153081 unknown[689]: fetched user config from "qemu" Jul 23 12:51:27.153374 ignition[689]: fetch-offline: fetch-offline passed Jul 23 12:51:27.153431 ignition[689]: Ignition finished successfully Jul 23 12:51:27.157807 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 23 12:51:27.180411 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 23 12:51:27.197481 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 23 12:51:27.221739 systemd-networkd[790]: lo: Link UP Jul 23 12:51:27.221766 systemd-networkd[790]: lo: Gained carrier Jul 23 12:51:27.223135 systemd-networkd[790]: Enumeration completed Jul 23 12:51:27.223246 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 23 12:51:27.224122 systemd[1]: Reached target network.target - Network. Jul 23 12:51:27.224953 systemd-networkd[790]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 23 12:51:27.224956 systemd-networkd[790]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 23 12:51:27.225822 systemd-networkd[790]: eth0: Link UP Jul 23 12:51:27.225826 systemd-networkd[790]: eth0: Gained carrier Jul 23 12:51:27.225833 systemd-networkd[790]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 23 12:51:27.226979 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 23 12:51:27.243196 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 23 12:51:27.244293 systemd-networkd[790]: eth0: DHCPv4 address 10.0.0.30/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 23 12:51:27.256877 ignition[792]: Ignition 2.19.0 Jul 23 12:51:27.256897 ignition[792]: Stage: kargs Jul 23 12:51:27.257130 ignition[792]: no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:27.257139 ignition[792]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:27.257618 ignition[792]: kargs: kargs passed Jul 23 12:51:27.257647 ignition[792]: Ignition finished successfully Jul 23 12:51:27.263242 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 23 12:51:27.282445 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 23 12:51:27.300065 ignition[801]: Ignition 2.19.0 Jul 23 12:51:27.300108 ignition[801]: Stage: disks Jul 23 12:51:27.300353 ignition[801]: no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:27.300365 ignition[801]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:27.301328 ignition[801]: disks: disks passed Jul 23 12:51:27.304962 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 23 12:51:27.301397 ignition[801]: Ignition finished successfully Jul 23 12:51:27.308880 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 23 12:51:27.310530 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 23 12:51:27.315298 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 23 12:51:27.317234 systemd[1]: Reached target sysinit.target - System Initialization. Jul 23 12:51:27.317403 systemd[1]: Reached target basic.target - Basic System. Jul 23 12:51:27.333532 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 23 12:51:27.347649 systemd-fsck[811]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 23 12:51:27.352173 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 23 12:51:27.363313 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 23 12:51:27.459137 kernel: EXT4-fs (vda9): mounted filesystem 50239b93-ebce-49c3-9b20-45108efcfb22 r/w with ordered data mode. Quota mode: none. Jul 23 12:51:27.459881 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 23 12:51:27.462721 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 23 12:51:27.478338 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 23 12:51:27.481189 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 23 12:51:27.488278 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (819) Jul 23 12:51:27.483391 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 23 12:51:27.498191 kernel: BTRFS info (device vda6): first mount of filesystem a4c5dc6a-5e78-4075-b3b8-603040871c79 Jul 23 12:51:27.498217 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 23 12:51:27.498227 kernel: BTRFS info (device vda6): using free space tree Jul 23 12:51:27.498234 kernel: BTRFS info (device vda6): auto enabling async discard Jul 23 12:51:27.483447 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 23 12:51:27.483481 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 23 12:51:27.490263 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 23 12:51:27.499838 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 23 12:51:27.505018 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 23 12:51:27.545492 initrd-setup-root[843]: cut: /sysroot/etc/passwd: No such file or directory Jul 23 12:51:27.550612 initrd-setup-root[850]: cut: /sysroot/etc/group: No such file or directory Jul 23 12:51:27.559378 initrd-setup-root[857]: cut: /sysroot/etc/shadow: No such file or directory Jul 23 12:51:27.563350 initrd-setup-root[864]: cut: /sysroot/etc/gshadow: No such file or directory Jul 23 12:51:27.666005 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 23 12:51:27.683415 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 23 12:51:27.686377 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 23 12:51:27.695175 kernel: BTRFS info (device vda6): last unmount of filesystem a4c5dc6a-5e78-4075-b3b8-603040871c79 Jul 23 12:51:27.717384 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 23 12:51:27.724017 ignition[932]: INFO : Ignition 2.19.0 Jul 23 12:51:27.724017 ignition[932]: INFO : Stage: mount Jul 23 12:51:27.726354 ignition[932]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:27.726354 ignition[932]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:27.726354 ignition[932]: INFO : mount: mount passed Jul 23 12:51:27.726354 ignition[932]: INFO : Ignition finished successfully Jul 23 12:51:27.732503 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 23 12:51:27.743365 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 23 12:51:28.013938 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 23 12:51:28.026441 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 23 12:51:28.036166 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (946) Jul 23 12:51:28.039494 kernel: BTRFS info (device vda6): first mount of filesystem a4c5dc6a-5e78-4075-b3b8-603040871c79 Jul 23 12:51:28.039575 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 23 12:51:28.039590 kernel: BTRFS info (device vda6): using free space tree Jul 23 12:51:28.044200 kernel: BTRFS info (device vda6): auto enabling async discard Jul 23 12:51:28.046309 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 23 12:51:28.078656 ignition[963]: INFO : Ignition 2.19.0 Jul 23 12:51:28.078656 ignition[963]: INFO : Stage: files Jul 23 12:51:28.082395 ignition[963]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:28.082395 ignition[963]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:28.082395 ignition[963]: DEBUG : files: compiled without relabeling support, skipping Jul 23 12:51:28.089016 ignition[963]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 23 12:51:28.089016 ignition[963]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 23 12:51:28.098708 ignition[963]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 23 12:51:28.101824 ignition[963]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 23 12:51:28.104654 unknown[963]: wrote ssh authorized keys file for user: core Jul 23 12:51:28.106452 ignition[963]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.4-x86-64.raw" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.4-x86-64.raw" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.4-x86-64.raw" Jul 23 12:51:28.108733 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.4-x86-64.raw: attempt #1 Jul 23 12:51:28.253249 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jul 23 12:51:28.593610 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.4-x86-64.raw" Jul 23 12:51:28.593610 ignition[963]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jul 23 12:51:28.601971 ignition[963]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 23 12:51:28.606406 ignition[963]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 23 12:51:28.606406 ignition[963]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jul 23 12:51:28.606406 ignition[963]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jul 23 12:51:28.641623 ignition[963]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 23 12:51:28.647274 ignition[963]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 23 12:51:28.650083 ignition[963]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jul 23 12:51:28.650083 ignition[963]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 23 12:51:28.650083 ignition[963]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 23 12:51:28.650083 ignition[963]: INFO : files: files passed Jul 23 12:51:28.650083 ignition[963]: INFO : Ignition finished successfully Jul 23 12:51:28.659510 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 23 12:51:28.670589 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 23 12:51:28.674847 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 23 12:51:28.684490 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 23 12:51:28.684599 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 23 12:51:28.700550 initrd-setup-root-after-ignition[991]: grep: /sysroot/oem/oem-release: No such file or directory Jul 23 12:51:28.706553 initrd-setup-root-after-ignition[993]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 23 12:51:28.706553 initrd-setup-root-after-ignition[993]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 23 12:51:28.712867 initrd-setup-root-after-ignition[997]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 23 12:51:28.715672 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 23 12:51:28.722021 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 23 12:51:28.741565 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 23 12:51:28.782967 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 23 12:51:28.783164 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 23 12:51:28.788926 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 23 12:51:28.789611 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 23 12:51:28.792807 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 23 12:51:28.794599 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 23 12:51:28.816407 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 23 12:51:28.820165 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 23 12:51:28.840492 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 23 12:51:28.844385 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 12:51:28.845990 systemd[1]: Stopped target timers.target - Timer Units. Jul 23 12:51:28.849215 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 23 12:51:28.849409 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 23 12:51:28.853703 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 23 12:51:28.857773 systemd[1]: Stopped target basic.target - Basic System. Jul 23 12:51:28.858826 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 23 12:51:28.862564 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 23 12:51:28.863545 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 23 12:51:28.868150 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 23 12:51:28.873070 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 23 12:51:28.873870 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 23 12:51:28.878117 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 23 12:51:28.882408 systemd[1]: Stopped target swap.target - Swaps. Jul 23 12:51:28.885558 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 23 12:51:28.885957 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 23 12:51:28.890766 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 23 12:51:28.891724 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 12:51:28.894623 systemd-networkd[790]: eth0: Gained IPv6LL Jul 23 12:51:28.895167 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 23 12:51:28.895594 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 12:51:28.908557 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 23 12:51:28.908766 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 23 12:51:28.915128 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 23 12:51:28.915435 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 23 12:51:28.916945 systemd[1]: Stopped target paths.target - Path Units. Jul 23 12:51:28.923019 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 23 12:51:28.925243 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 12:51:28.930466 systemd[1]: Stopped target slices.target - Slice Units. Jul 23 12:51:28.936267 systemd[1]: Stopped target sockets.target - Socket Units. Jul 23 12:51:28.936998 systemd[1]: iscsid.socket: Deactivated successfully. Jul 23 12:51:28.937111 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 23 12:51:28.940028 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 23 12:51:28.940131 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 23 12:51:28.943883 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 23 12:51:28.944148 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 23 12:51:28.947164 systemd[1]: ignition-files.service: Deactivated successfully. Jul 23 12:51:28.947311 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 23 12:51:28.964459 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 23 12:51:28.965364 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 23 12:51:28.965469 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 12:51:28.973153 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 23 12:51:28.976456 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 23 12:51:28.977366 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 12:51:28.983995 ignition[1017]: INFO : Ignition 2.19.0 Jul 23 12:51:28.983995 ignition[1017]: INFO : Stage: umount Jul 23 12:51:28.983995 ignition[1017]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 23 12:51:28.983995 ignition[1017]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 23 12:51:28.980556 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 23 12:51:28.989903 ignition[1017]: INFO : umount: umount passed Jul 23 12:51:28.989903 ignition[1017]: INFO : Ignition finished successfully Jul 23 12:51:28.980757 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 23 12:51:28.987194 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 23 12:51:28.987339 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 23 12:51:29.000785 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 23 12:51:29.003357 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 23 12:51:29.003494 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 23 12:51:29.006981 systemd[1]: Stopped target network.target - Network. Jul 23 12:51:29.008455 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 23 12:51:29.008562 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 23 12:51:29.010576 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 23 12:51:29.010651 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 23 12:51:29.014188 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 23 12:51:29.014324 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 23 12:51:29.016814 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 23 12:51:29.016879 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 23 12:51:29.021452 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 23 12:51:29.022685 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 23 12:51:29.028253 systemd-networkd[790]: eth0: DHCPv6 lease lost Jul 23 12:51:29.031599 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 23 12:51:29.031765 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 23 12:51:29.033556 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 23 12:51:29.033598 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 23 12:51:29.044412 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 23 12:51:29.048207 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 23 12:51:29.048319 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 23 12:51:29.051525 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 12:51:29.054737 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 23 12:51:29.054907 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 23 12:51:29.056730 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 23 12:51:29.056820 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 23 12:51:29.059834 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 23 12:51:29.060543 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 23 12:51:29.060809 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 23 12:51:29.060838 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 23 12:51:29.064110 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 23 12:51:29.064167 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 23 12:51:29.066898 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 23 12:51:29.066962 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 12:51:29.081399 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 23 12:51:29.081540 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 23 12:51:29.087431 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 23 12:51:29.087687 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 12:51:29.089937 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 23 12:51:29.089981 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 23 12:51:29.093601 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 23 12:51:29.093652 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 23 12:51:29.097432 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 23 12:51:29.097522 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 23 12:51:29.103004 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 23 12:51:29.103287 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 23 12:51:29.108593 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 23 12:51:29.108676 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 23 12:51:29.125384 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 23 12:51:29.126172 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 23 12:51:29.126273 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 12:51:29.126633 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 12:51:29.126684 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:29.138350 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 23 12:51:29.138447 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 23 12:51:29.139494 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 23 12:51:29.153568 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 23 12:51:29.165350 systemd[1]: Switching root. Jul 23 12:51:29.203549 systemd-journald[194]: Journal stopped Jul 23 12:51:29.969009 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). Jul 23 12:51:29.969123 kernel: SELinux: policy capability network_peer_controls=1 Jul 23 12:51:29.969146 kernel: SELinux: policy capability open_perms=1 Jul 23 12:51:29.969160 kernel: SELinux: policy capability extended_socket_class=1 Jul 23 12:51:29.969177 kernel: SELinux: policy capability always_check_network=0 Jul 23 12:51:29.969189 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 23 12:51:29.969202 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 23 12:51:29.969214 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 23 12:51:29.969230 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 23 12:51:29.969248 kernel: audit: type=1403 audit(1784811089.319:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 23 12:51:29.969265 systemd[1]: Successfully loaded SELinux policy in 40.099ms. Jul 23 12:51:29.969286 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 8.991ms. Jul 23 12:51:29.969306 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 23 12:51:29.969320 systemd[1]: Detected virtualization kvm. Jul 23 12:51:29.969334 systemd[1]: Detected architecture x86-64. Jul 23 12:51:29.969351 systemd[1]: Detected first boot. Jul 23 12:51:29.969365 systemd[1]: Initializing machine ID from VM UUID. Jul 23 12:51:29.969379 zram_generator::config[1061]: No configuration found. Jul 23 12:51:29.969396 systemd[1]: Populated /etc with preset unit settings. Jul 23 12:51:29.969409 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 23 12:51:29.969423 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 23 12:51:29.969437 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 23 12:51:29.969455 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 23 12:51:29.969469 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 23 12:51:29.969488 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 23 12:51:29.969502 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 23 12:51:29.969516 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 23 12:51:29.969530 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 23 12:51:29.969545 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 23 12:51:29.969558 systemd[1]: Created slice user.slice - User and Session Slice. Jul 23 12:51:29.969572 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 23 12:51:29.969588 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 23 12:51:29.969602 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 23 12:51:29.969616 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 23 12:51:29.969631 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 23 12:51:29.969645 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 23 12:51:29.969658 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 23 12:51:29.969672 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 23 12:51:29.969687 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 23 12:51:29.969704 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 23 12:51:29.969721 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 23 12:51:29.969734 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 23 12:51:29.969748 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 23 12:51:29.969762 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 23 12:51:29.969776 systemd[1]: Reached target slices.target - Slice Units. Jul 23 12:51:29.969789 systemd[1]: Reached target swap.target - Swaps. Jul 23 12:51:29.969803 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 23 12:51:29.969819 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 23 12:51:29.969833 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 23 12:51:29.969847 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 23 12:51:29.969861 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 23 12:51:29.969875 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 23 12:51:29.969889 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 23 12:51:29.969903 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 23 12:51:29.969917 systemd[1]: Mounting media.mount - External Media Directory... Jul 23 12:51:29.969931 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:29.969947 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 23 12:51:29.969961 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 23 12:51:29.969975 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 23 12:51:29.969990 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). Jul 23 12:51:29.970005 systemd[1]: Reached target machines.target - Containers. Jul 23 12:51:29.970019 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 23 12:51:29.970054 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 23 12:51:29.970074 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 23 12:51:29.970206 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 23 12:51:29.970234 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 23 12:51:29.970250 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 23 12:51:29.970263 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 23 12:51:29.970277 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 23 12:51:29.970291 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 23 12:51:29.970306 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 23 12:51:29.970320 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 23 12:51:29.970334 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 23 12:51:29.970350 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 23 12:51:29.970364 systemd[1]: Stopped systemd-fsck-usr.service. Jul 23 12:51:29.970377 kernel: fuse: init (API version 7.39) Jul 23 12:51:29.970390 kernel: loop: module loaded Jul 23 12:51:29.970404 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 23 12:51:29.970417 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 23 12:51:29.970435 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 23 12:51:29.970449 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 23 12:51:29.970463 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 23 12:51:29.970479 systemd[1]: verity-setup.service: Deactivated successfully. Jul 23 12:51:29.970493 systemd[1]: Stopped verity-setup.service. Jul 23 12:51:29.970508 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:29.970522 kernel: ACPI: bus type drm_connector registered Jul 23 12:51:29.970535 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 23 12:51:29.970576 systemd-journald[1135]: Collecting audit messages is disabled. Jul 23 12:51:29.970603 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 23 12:51:29.970618 systemd-journald[1135]: Journal started Jul 23 12:51:29.970650 systemd-journald[1135]: Runtime Journal (/run/log/journal/64bcb72faaf04290b081a29ba1d5b26e) is 6.0M, max 48.2M, 42.2M free. Jul 23 12:51:29.693538 systemd[1]: Queued start job for default target multi-user.target. Jul 23 12:51:29.714672 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 23 12:51:29.715153 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 23 12:51:29.975392 systemd[1]: Started systemd-journald.service - Journal Service. Jul 23 12:51:29.975827 systemd[1]: Mounted media.mount - External Media Directory. Jul 23 12:51:29.977518 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 23 12:51:29.979324 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 23 12:51:29.980915 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 23 12:51:29.982410 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 23 12:51:29.984174 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 23 12:51:29.985927 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 23 12:51:29.986124 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 23 12:51:29.987832 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 23 12:51:29.987986 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 23 12:51:29.989719 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 23 12:51:29.989831 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 23 12:51:29.991528 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 23 12:51:29.991633 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 23 12:51:29.993643 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 23 12:51:29.993752 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 23 12:51:29.995456 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 23 12:51:29.995562 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 23 12:51:29.997689 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 23 12:51:29.999733 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 23 12:51:30.001863 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 23 12:51:30.010754 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 23 12:51:30.032598 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 23 12:51:30.038508 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 23 12:51:30.040556 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 23 12:51:30.040609 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 23 12:51:30.042751 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jul 23 12:51:30.045755 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 23 12:51:30.048973 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 23 12:51:30.050557 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 23 12:51:30.052558 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 23 12:51:30.055794 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 23 12:51:30.057421 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 23 12:51:30.058339 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 23 12:51:30.060329 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 23 12:51:30.061279 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 23 12:51:30.069214 systemd-journald[1135]: Time spent on flushing to /var/log/journal/64bcb72faaf04290b081a29ba1d5b26e is 19.806ms for 978 entries. Jul 23 12:51:30.069214 systemd-journald[1135]: System Journal (/var/log/journal/64bcb72faaf04290b081a29ba1d5b26e) is 8.0M, max 195.6M, 187.6M free. Jul 23 12:51:30.119431 systemd-journald[1135]: Received client request to flush runtime journal. Jul 23 12:51:30.119479 kernel: loop0: detected capacity change from 0 to 219192 Jul 23 12:51:30.119503 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 23 12:51:30.069247 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 23 12:51:30.076428 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 23 12:51:30.080625 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 23 12:51:30.082828 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 23 12:51:30.086300 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 23 12:51:30.088455 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 23 12:51:30.091518 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 23 12:51:30.096366 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 23 12:51:30.108460 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jul 23 12:51:30.120556 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 23 12:51:30.122612 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 23 12:51:30.126401 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 23 12:51:30.134589 udevadm[1190]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 23 12:51:30.138690 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 23 12:51:30.139394 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jul 23 12:51:30.149965 kernel: loop1: detected capacity change from 0 to 142488 Jul 23 12:51:30.147396 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 23 12:51:30.156319 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 23 12:51:30.181256 systemd-tmpfiles[1197]: ACLs are not supported, ignoring. Jul 23 12:51:30.181277 systemd-tmpfiles[1197]: ACLs are not supported, ignoring. Jul 23 12:51:30.185321 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 23 12:51:30.188132 kernel: loop2: detected capacity change from 0 to 140768 Jul 23 12:51:30.224486 kernel: loop3: detected capacity change from 0 to 219192 Jul 23 12:51:30.235145 kernel: loop4: detected capacity change from 0 to 142488 Jul 23 12:51:30.246138 kernel: loop5: detected capacity change from 0 to 140768 Jul 23 12:51:30.255715 (sd-merge)[1203]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jul 23 12:51:30.256237 (sd-merge)[1203]: Merged extensions into '/usr'. Jul 23 12:51:30.259468 systemd[1]: Reloading requested from client PID 1175 ('systemd-sysext') (unit systemd-sysext.service)... Jul 23 12:51:30.259611 systemd[1]: Reloading... Jul 23 12:51:30.305130 zram_generator::config[1232]: No configuration found. Jul 23 12:51:30.347013 ldconfig[1170]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 23 12:51:30.384029 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 23 12:51:30.414204 systemd[1]: Reloading finished in 154 ms. Jul 23 12:51:30.440935 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 23 12:51:30.442880 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 23 12:51:30.455372 systemd[1]: Starting ensure-sysext.service... Jul 23 12:51:30.460277 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 23 12:51:30.463630 systemd[1]: Reloading requested from client PID 1266 ('systemctl') (unit ensure-sysext.service)... Jul 23 12:51:30.463656 systemd[1]: Reloading... Jul 23 12:51:30.473274 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 23 12:51:30.473492 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 23 12:51:30.473976 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 23 12:51:30.474224 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Jul 23 12:51:30.474270 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Jul 23 12:51:30.478215 systemd-tmpfiles[1267]: Detected autofs mount point /boot during canonicalization of boot. Jul 23 12:51:30.478238 systemd-tmpfiles[1267]: Skipping /boot Jul 23 12:51:30.483971 systemd-tmpfiles[1267]: Detected autofs mount point /boot during canonicalization of boot. Jul 23 12:51:30.483981 systemd-tmpfiles[1267]: Skipping /boot Jul 23 12:51:30.512144 zram_generator::config[1300]: No configuration found. Jul 23 12:51:30.591875 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 23 12:51:30.625401 systemd[1]: Reloading finished in 161 ms. Jul 23 12:51:30.641135 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 23 12:51:30.652603 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 23 12:51:30.660537 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 23 12:51:30.663317 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 23 12:51:30.665726 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 23 12:51:30.669358 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 23 12:51:30.672641 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 23 12:51:30.675446 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 23 12:51:30.678977 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.679598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 23 12:51:30.684466 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 23 12:51:30.687356 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 23 12:51:30.690006 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 23 12:51:30.692888 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 23 12:51:30.695934 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 23 12:51:30.697655 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.698486 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 23 12:51:30.698586 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 23 12:51:30.700392 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 23 12:51:30.700497 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 23 12:51:30.702447 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 23 12:51:30.702556 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 23 12:51:30.708948 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.709706 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 23 12:51:30.713346 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 23 12:51:30.717161 systemd-udevd[1339]: Using default interface naming scheme 'v255'. Jul 23 12:51:30.718309 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 23 12:51:30.721671 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 23 12:51:30.723333 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 23 12:51:30.723472 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.724498 augenrules[1362]: No rules Jul 23 12:51:30.724491 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 23 12:51:30.727127 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 23 12:51:30.729195 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 23 12:51:30.731365 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 23 12:51:30.731466 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 23 12:51:30.733376 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 23 12:51:30.733529 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 23 12:51:30.735583 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 23 12:51:30.735684 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 23 12:51:30.738342 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 23 12:51:30.761554 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 23 12:51:30.763716 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 23 12:51:30.779282 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.780214 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 23 12:51:30.787347 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 23 12:51:30.791430 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 23 12:51:30.799404 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 23 12:51:30.811520 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 23 12:51:30.812891 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 23 12:51:30.816784 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 23 12:51:30.821857 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 23 12:51:30.825305 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). Jul 23 12:51:30.825458 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 23 12:51:30.826909 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 23 12:51:30.827621 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 23 12:51:30.830799 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 23 12:51:30.830957 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 23 12:51:30.832827 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 23 12:51:30.834180 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 23 12:51:30.837028 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 23 12:51:30.838322 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 23 12:51:30.840850 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1399) Jul 23 12:51:30.850765 systemd[1]: Finished ensure-sysext.service. Jul 23 12:51:30.854004 systemd-resolved[1337]: Positive Trust Anchors: Jul 23 12:51:30.854017 systemd-resolved[1337]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 23 12:51:30.854078 systemd-resolved[1337]: 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 Jul 23 12:51:30.860442 systemd-resolved[1337]: Defaulting to hostname 'linux'. Jul 23 12:51:30.861648 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 23 12:51:30.871300 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 23 12:51:30.873236 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 23 12:51:30.874143 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jul 23 12:51:30.878925 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 23 12:51:30.879114 kernel: ACPI: button: Power Button [PWRF] Jul 23 12:51:30.882488 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 23 12:51:30.891428 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 23 12:51:30.895485 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 23 12:51:30.895584 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 23 12:51:30.899277 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 23 12:51:30.908317 systemd-networkd[1405]: lo: Link UP Jul 23 12:51:30.908323 systemd-networkd[1405]: lo: Gained carrier Jul 23 12:51:30.909571 systemd-networkd[1405]: Enumeration completed Jul 23 12:51:30.909939 systemd-networkd[1405]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 23 12:51:30.909941 systemd-networkd[1405]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 23 12:51:30.910507 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 23 12:51:30.910511 systemd-networkd[1405]: eth0: Link UP Jul 23 12:51:30.910514 systemd-networkd[1405]: eth0: Gained carrier Jul 23 12:51:30.910522 systemd-networkd[1405]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 23 12:51:30.913337 systemd[1]: Reached target network.target - Network. Jul 23 12:51:30.922238 systemd-networkd[1405]: eth0: DHCPv4 address 10.0.0.30/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 23 12:51:30.922833 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 23 12:51:30.927143 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 23 12:51:30.951504 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Jul 23 12:51:30.963870 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jul 23 12:51:30.964014 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jul 23 12:51:30.987358 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 23 12:51:31.007149 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:31.027281 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Jul 23 12:51:31.047128 kernel: mousedev: PS/2 mouse device common for all mice Jul 23 12:51:31.049798 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 23 12:51:32.108892 systemd-timesyncd[1422]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 23 12:51:32.108941 systemd-timesyncd[1422]: Initial clock synchronization to Thu 2026-07-23 12:51:32.108796 UTC. Jul 23 12:51:32.109204 systemd-resolved[1337]: Clock change detected. Flushing caches. Jul 23 12:51:32.119980 systemd[1]: Reached target time-set.target - System Time Set. Jul 23 12:51:32.127435 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 23 12:51:32.128185 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:32.168925 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 23 12:51:32.180653 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 23 12:51:32.189733 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 23 12:51:32.196838 lvm[1439]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 23 12:51:32.213565 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 23 12:51:32.229792 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 23 12:51:32.232447 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 23 12:51:32.234760 systemd[1]: Reached target sysinit.target - System Initialization. Jul 23 12:51:32.237096 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 23 12:51:32.239828 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 23 12:51:32.242644 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 23 12:51:32.245008 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 23 12:51:32.247799 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 23 12:51:32.250284 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 23 12:51:32.250338 systemd[1]: Reached target paths.target - Path Units. Jul 23 12:51:32.252301 systemd[1]: Reached target timers.target - Timer Units. Jul 23 12:51:32.255621 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 23 12:51:32.259650 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 23 12:51:32.265236 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 23 12:51:32.268170 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 23 12:51:32.270569 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 23 12:51:32.272402 systemd[1]: Reached target sockets.target - Socket Units. Jul 23 12:51:32.274182 systemd[1]: Reached target basic.target - Basic System. Jul 23 12:51:32.275823 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 23 12:51:32.275854 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 23 12:51:32.276767 systemd[1]: Starting containerd.service - containerd container runtime... Jul 23 12:51:32.276933 lvm[1446]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 23 12:51:32.279233 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 23 12:51:32.284695 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 23 12:51:32.287560 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 23 12:51:32.289420 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). Jul 23 12:51:32.290608 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 23 12:51:32.291896 jq[1449]: false Jul 23 12:51:32.292913 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 23 12:51:32.298424 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 23 12:51:32.305295 extend-filesystems[1450]: Found loop3 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found loop4 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found loop5 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found sr0 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda1 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda2 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda3 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found usr Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda4 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda6 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda7 Jul 23 12:51:32.306822 extend-filesystems[1450]: Found vda9 Jul 23 12:51:32.306822 extend-filesystems[1450]: Checking size of /dev/vda9 Jul 23 12:51:32.345989 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (1385) Jul 23 12:51:32.346026 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jul 23 12:51:32.346043 extend-filesystems[1450]: Resized partition /dev/vda9 Jul 23 12:51:32.318021 dbus-daemon[1448]: [system] SELinux support is enabled Jul 23 12:51:32.307656 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 23 12:51:32.360994 extend-filesystems[1465]: resize2fs 1.47.1 (20-May-2024) Jul 23 12:51:32.310357 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 23 12:51:32.310760 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 23 12:51:32.364623 update_engine[1460]: I20260723 12:51:32.349956 1460 main.cc:92] Flatcar Update Engine starting Jul 23 12:51:32.364623 update_engine[1460]: I20260723 12:51:32.353211 1460 update_check_scheduler.cc:74] Next update check in 2m9s Jul 23 12:51:32.313662 systemd[1]: Starting update-engine.service - Update Engine... Jul 23 12:51:32.364975 jq[1466]: true Jul 23 12:51:32.320913 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 23 12:51:32.365129 jq[1473]: true Jul 23 12:51:32.323727 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 23 12:51:32.330301 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 23 12:51:32.341156 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 23 12:51:32.342573 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 23 12:51:32.342809 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 23 12:51:32.342915 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 23 12:51:32.349992 systemd[1]: motdgen.service: Deactivated successfully. Jul 23 12:51:32.350615 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 23 12:51:32.371129 (ntainerd)[1480]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 23 12:51:32.377731 systemd[1]: Started update-engine.service - Update Engine. Jul 23 12:51:32.380534 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jul 23 12:51:32.381397 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). Jul 23 12:51:32.381478 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 23 12:51:32.384126 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). Jul 23 12:51:32.384141 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 23 12:51:32.393693 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 23 12:51:32.399716 extend-filesystems[1465]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jul 23 12:51:32.399716 extend-filesystems[1465]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 23 12:51:32.399716 extend-filesystems[1465]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jul 23 12:51:32.406392 extend-filesystems[1450]: Resized filesystem in /dev/vda9 Jul 23 12:51:32.401328 systemd-logind[1455]: Watching system buttons on /dev/input/event1 (Power Button) Jul 23 12:51:32.401341 systemd-logind[1455]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 23 12:51:32.401850 systemd-logind[1455]: New seat seat0. Jul 23 12:51:32.408890 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 23 12:51:32.409418 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 23 12:51:32.411636 systemd[1]: Started systemd-logind.service - User Login Management. Jul 23 12:51:32.432804 bash[1500]: Updated "/home/core/.ssh/authorized_keys" Jul 23 12:51:32.435586 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 23 12:51:32.436562 locksmithd[1484]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 23 12:51:32.438139 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 23 12:51:32.556293 kernel: hrtimer: interrupt took 4474357 ns Jul 23 12:51:32.622272 containerd[1480]: time="2026-07-23T12:51:32.622115245Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jul 23 12:51:32.648721 containerd[1480]: time="2026-07-23T12:51:32.648576968Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650359 containerd[1480]: time="2026-07-23T12:51:32.650310502Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.144-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650359 containerd[1480]: time="2026-07-23T12:51:32.650348652Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 23 12:51:32.650359 containerd[1480]: time="2026-07-23T12:51:32.650361238Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 23 12:51:32.650537 containerd[1480]: time="2026-07-23T12:51:32.650529002Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 23 12:51:32.650590 containerd[1480]: time="2026-07-23T12:51:32.650541925Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650590 containerd[1480]: time="2026-07-23T12:51:32.650583060Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650640 containerd[1480]: time="2026-07-23T12:51:32.650592248Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650758 containerd[1480]: time="2026-07-23T12:51:32.650727404Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650758 containerd[1480]: time="2026-07-23T12:51:32.650747700Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650813 containerd[1480]: time="2026-07-23T12:51:32.650757675Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650813 containerd[1480]: time="2026-07-23T12:51:32.650764931Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650860 containerd[1480]: time="2026-07-23T12:51:32.650817604Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.650973 containerd[1480]: time="2026-07-23T12:51:32.650953905Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 23 12:51:32.651067 containerd[1480]: time="2026-07-23T12:51:32.651048798Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 23 12:51:32.651067 containerd[1480]: time="2026-07-23T12:51:32.651065149Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 23 12:51:32.651131 containerd[1480]: time="2026-07-23T12:51:32.651114375Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 23 12:51:32.651159 containerd[1480]: time="2026-07-23T12:51:32.651151950Z" level=info msg="metadata content store policy set" policy=shared Jul 23 12:51:32.656533 containerd[1480]: time="2026-07-23T12:51:32.656399394Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 23 12:51:32.656533 containerd[1480]: time="2026-07-23T12:51:32.656545605Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 23 12:51:32.656728 containerd[1480]: time="2026-07-23T12:51:32.656566820Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 23 12:51:32.656728 containerd[1480]: time="2026-07-23T12:51:32.656578716Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 23 12:51:32.656728 containerd[1480]: time="2026-07-23T12:51:32.656589786Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 23 12:51:32.656776 containerd[1480]: time="2026-07-23T12:51:32.656728829Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 23 12:51:32.658998 containerd[1480]: time="2026-07-23T12:51:32.658923032Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659113969Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659139125Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659149759Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659162248Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659172530Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659182297Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659193826Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659204749Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659215165Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659224244Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659234592Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659251122Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659262614Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659533 containerd[1480]: time="2026-07-23T12:51:32.659272684Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659282358Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659291255Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659303314Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659312131Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659322475Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659341541Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659359263Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659373462Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659390539Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659405383Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659421640Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659437641Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659450901Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.659800 containerd[1480]: time="2026-07-23T12:51:32.659484727Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659549842Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659565942Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659574349Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659582576Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659590139Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659599214Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659608267Z" level=info msg="NRI interface is disabled by configuration." Jul 23 12:51:32.660000 containerd[1480]: time="2026-07-23T12:51:32.659621916Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 23 12:51:32.660138 containerd[1480]: time="2026-07-23T12:51:32.659829164Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 23 12:51:32.660138 containerd[1480]: time="2026-07-23T12:51:32.659872134Z" level=info msg="Connect containerd service" Jul 23 12:51:32.660138 containerd[1480]: time="2026-07-23T12:51:32.659900606Z" level=info msg="using legacy CRI server" Jul 23 12:51:32.660138 containerd[1480]: time="2026-07-23T12:51:32.659905701Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 23 12:51:32.660138 containerd[1480]: time="2026-07-23T12:51:32.659973989Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 23 12:51:32.660484 containerd[1480]: time="2026-07-23T12:51:32.660431663Z" 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" Jul 23 12:51:32.660629 containerd[1480]: time="2026-07-23T12:51:32.660554342Z" level=info msg="Start subscribing containerd event" Jul 23 12:51:32.660692 containerd[1480]: time="2026-07-23T12:51:32.660659900Z" level=info msg="Start recovering state" Jul 23 12:51:32.660896 containerd[1480]: time="2026-07-23T12:51:32.660714419Z" level=info msg="Start event monitor" Jul 23 12:51:32.660896 containerd[1480]: time="2026-07-23T12:51:32.660731784Z" level=info msg="Start snapshots syncer" Jul 23 12:51:32.660896 containerd[1480]: time="2026-07-23T12:51:32.660739620Z" level=info msg="Start cni network conf syncer for default" Jul 23 12:51:32.660896 containerd[1480]: time="2026-07-23T12:51:32.660745124Z" level=info msg="Start streaming server" Jul 23 12:51:32.660984 containerd[1480]: time="2026-07-23T12:51:32.660905285Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 23 12:51:32.660984 containerd[1480]: time="2026-07-23T12:51:32.660944406Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 23 12:51:32.661010 containerd[1480]: time="2026-07-23T12:51:32.660996254Z" level=info msg="containerd successfully booted in 0.039847s" Jul 23 12:51:32.661098 systemd[1]: Started containerd.service - containerd container runtime. Jul 23 12:51:32.693300 sshd_keygen[1471]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 23 12:51:32.725983 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 23 12:51:32.738981 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 23 12:51:32.745144 systemd[1]: issuegen.service: Deactivated successfully. Jul 23 12:51:32.745314 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 23 12:51:32.748726 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 23 12:51:32.764791 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 23 12:51:32.767664 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 23 12:51:32.770069 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 23 12:51:32.771830 systemd[1]: Reached target getty.target - Login Prompts. Jul 23 12:51:33.983050 systemd-networkd[1405]: eth0: Gained IPv6LL Jul 23 12:51:33.985613 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 23 12:51:33.988000 systemd[1]: Reached target network-online.target - Network is Online. Jul 23 12:51:33.999781 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 23 12:51:34.002445 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 23 12:51:34.005710 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 23 12:51:34.022621 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 23 12:51:34.022894 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 23 12:51:34.025985 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 23 12:51:34.029194 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 23 12:51:34.695915 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 23 12:51:34.698728 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 23 12:51:34.700052 systemd[1]: Startup finished in 883ms (kernel) + 4.620s (initrd) + 4.360s (userspace) = 9.864s. Jul 23 12:51:34.700921 (kubelet)[1554]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jul 23 12:51:35.089868 kubelet[1554]: E0723 12:51:35.089745 1554 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" Jul 23 12:51:35.092091 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jul 23 12:51:35.092205 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jul 23 12:51:38.966688 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 23 12:51:38.968294 systemd[1]: Started sshd@0-10.0.0.30:22-10.0.0.1:52368.service - OpenSSH per-connection server daemon (10.0.0.1:52368). Jul 23 12:51:39.025975 sshd[1568]: Accepted publickey for core from 10.0.0.1 port 52368 ssh2: RSA SHA256:1URfHxBZTZyqRWYQkuBM62DQMSyEvnBlTQqiwkdNwEg Jul 23 12:51:39.029710 sshd[1568]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 23 12:51:39.037799 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 23 12:51:39.048020 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 23 12:51:39.050928 systemd-logind[1455]: New session 1 of user core. Jul 23 12:51:39.060467 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 23 12:51:39.073068 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 23 12:51:39.075720 (systemd)[1572]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 23 12:51:39.178767 systemd[1572]: Queued start job for default target default.target. Jul 23 12:51:39.189209 systemd[1572]: Created slice app.slice - User Application Slice. Jul 23 12:51:39.189330 systemd[1572]: Reached target paths.target - Paths. Jul 23 12:51:39.189350 systemd[1572]: Reached target timers.target - Timers. Jul 23 12:51:39.191281 systemd[1572]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 23 12:51:39.204906 systemd[1572]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 23 12:51:39.205023 systemd[1572]: Reached target sockets.target - Sockets. Jul 23 12:51:39.205034 systemd[1572]: Reached target basic.target - Basic System. Jul 23 12:51:39.205067 systemd[1572]: Reached target default.target - Main User Target. Jul 23 12:51:39.205091 systemd[1572]: Startup finished in 123ms. Jul 23 12:51:39.205521 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 23 12:51:39.221949 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 23 12:51:39.298847 systemd[1]: Started sshd@1-10.0.0.30:22-10.0.0.1:52384.service - OpenSSH per-connection server daemon (10.0.0.1:52384). Jul 23 12:51:39.331435 sshd[1583]: Accepted publickey for core from 10.0.0.1 port 52384 ssh2: RSA SHA256:1URfHxBZTZyqRWYQkuBM62DQMSyEvnBlTQqiwkdNwEg Jul 23 12:51:39.332961 sshd[1583]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 23 12:51:39.337073 systemd-logind[1455]: New session 2 of user core. Jul 23 12:51:39.351168 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 23 12:51:39.409022 sshd[1583]: pam_unix(sshd:session): session closed for user core Jul 23 12:51:39.419855 systemd[1]: sshd@1-10.0.0.30:22-10.0.0.1:52384.service: Deactivated successfully. Jul 23 12:51:39.421823 systemd[1]: session-2.scope: Deactivated successfully. Jul 23 12:51:39.423710 systemd-logind[1455]: Session 2 logged out. Waiting for processes to exit. Jul 23 12:51:39.439107 systemd[1]: Started sshd@2-10.0.0.30:22-10.0.0.1:52398.service - OpenSSH per-connection server daemon (10.0.0.1:52398). Jul 23 12:51:39.440330 systemd-logind[1455]: Removed session 2. Jul 23 12:51:39.469397 sshd[1590]: Accepted publickey for core from 10.0.0.1 port 52398 ssh2: RSA SHA256:1URfHxBZTZyqRWYQkuBM62DQMSyEvnBlTQqiwkdNwEg Jul 23 12:51:39.470939 sshd[1590]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 23 12:51:39.475043 systemd-logind[1455]: New session 3 of user core. Jul 23 12:51:39.489262 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 23 12:51:39.540005 sshd[1590]: pam_unix(sshd:session): session closed for user core Jul 23 12:51:39.549526 systemd[1]: sshd@2-10.0.0.30:22-10.0.0.1:52398.service: Deactivated successfully. Jul 23 12:51:39.551241 systemd[1]: session-3.scope: Deactivated successfully. Jul 23 12:51:39.553197 systemd-logind[1455]: Session 3 logged out. Waiting for processes to exit. Jul 23 12:51:39.562999 systemd[1]: Started sshd@3-10.0.0.30:22-10.0.0.1:52406.service - OpenSSH per-connection server daemon (10.0.0.1:52406). Jul 23 12:51:39.563939 systemd-logind[1455]: Removed session 3. Jul 23 12:51:39.593540 sshd[1597]: Accepted publickey for core from 10.0.0.1 port 52406 ssh2: RSA SHA256:1URfHxBZTZyqRWYQkuBM62DQMSyEvnBlTQqiwkdNwEg Jul 23 12:51:39.594824 sshd[1597]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 23 12:51:39.599171 systemd-logind[1455]: New session 4 of user core. Jul 23 12:51:39.609893 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 23 12:51:39.666130 sshd[1597]: pam_unix(sshd:session): session closed for user core Jul 23 12:51:39.681730 systemd[1]: sshd@3-10.0.0.30:22-10.0.0.1:52406.service: Deactivated successfully. Jul 23 12:51:39.683316 systemd[1]: session-4.scope: Deactivated successfully. Jul 23 12:51:39.684638 systemd-logind[1455]: Session 4 logged out. Waiting for processes to exit. Jul 23 12:51:39.685974 systemd[1]: Started sshd@4-10.0.0.30:22-10.0.0.1:52410.service - OpenSSH per-connection server daemon (10.0.0.1:52410). Jul 23 12:51:39.686920 systemd-logind[1455]: Removed session 4. Jul 23 12:51:39.717295 sshd[1604]: Accepted publickey for core from 10.0.0.1 port 52410 ssh2: RSA SHA256:1URfHxBZTZyqRWYQkuBM62DQMSyEvnBlTQqiwkdNwEg Jul 23 12:51:39.719324 sshd[1604]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 23 12:51:39.723732 systemd-logind[1455]: New session 5 of user core. Jul 23 12:51:39.739918 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 23 12:51:39.801382 sudo[1607]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jul 23 12:51:39.801683 sudo[1607]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 23 12:51:39.823987 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 23 12:51:39.842693 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 23 12:51:39.842927 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 23 12:51:40.354779 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 23 12:51:40.366989 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 23 12:51:40.399437 systemd[1]: Reloading requested from client PID 1648 ('systemctl') (unit session-5.scope)... Jul 23 12:51:40.399466 systemd[1]: Reloading... Jul 23 12:51:40.478650 zram_generator::config[1686]: No configuration found. Jul 23 12:51:40.590037 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 23 12:51:40.645812 systemd[1]: Reloading finished in 245 ms. Jul 23 12:51:40.710283 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 23 12:51:40.714353 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Jul 23 12:51:40.716740 systemd[1]: kubelet.service: Deactivated successfully. Jul 23 12:51:40.717222 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 23 12:51:40.719667 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 23 12:51:40.854798 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 23 12:51:40.859806 (kubelet)[1736]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jul 23 12:51:40.913328 kubelet[1736]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Jul 23 12:51:40.913328 kubelet[1736]: 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. Jul 23 12:51:40.913328 kubelet[1736]: I0723 12:51:40.913240 1736 server.go:213] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jul 23 12:51:41.387273 kubelet[1736]: I0723 12:51:41.386925 1736 server.go:529] "Kubelet version" kubeletVersion="v1.34.4" Jul 23 12:51:41.387273 kubelet[1736]: I0723 12:51:41.387136 1736 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jul 23 12:51:41.390024 kubelet[1736]: I0723 12:51:41.389821 1736 watchdog_linux.go:95] "Systemd watchdog is not enabled" Jul 23 12:51:41.390174 kubelet[1736]: I0723 12:51:41.390050 1736 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jul 23 12:51:41.390472 kubelet[1736]: I0723 12:51:41.390397 1736 server.go:956] "Client rotation is on, will bootstrap in background" Jul 23 12:51:41.396318 kubelet[1736]: I0723 12:51:41.396214 1736 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jul 23 12:51:41.406843 kubelet[1736]: E0723 12:51:41.406748 1736 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Jul 23 12:51:41.406843 kubelet[1736]: I0723 12:51:41.406825 1736 server.go:1400] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Jul 23 12:51:41.415448 kubelet[1736]: I0723 12:51:41.415398 1736 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Jul 23 12:51:41.417017 kubelet[1736]: I0723 12:51:41.416921 1736 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jul 23 12:51:41.417190 kubelet[1736]: I0723 12:51:41.417000 1736 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.30","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} Jul 23 12:51:41.417298 kubelet[1736]: I0723 12:51:41.417194 1736 topology_manager.go:138] "Creating topology manager with none policy" Jul 23 12:51:41.417298 kubelet[1736]: I0723 12:51:41.417206 1736 container_manager_linux.go:306] "Creating device plugin manager" Jul 23 12:51:41.417346 kubelet[1736]: I0723 12:51:41.417324 1736 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Jul 23 12:51:41.456389 kubelet[1736]: I0723 12:51:41.456220 1736 state_mem.go:36] "Initialized new in-memory state store" Jul 23 12:51:41.456803 kubelet[1736]: I0723 12:51:41.456782 1736 kubelet.go:475] "Attempting to sync node with API server" Jul 23 12:51:41.456803 kubelet[1736]: I0723 12:51:41.456801 1736 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Jul 23 12:51:41.456879 kubelet[1736]: I0723 12:51:41.456820 1736 kubelet.go:387] "Adding apiserver pod source" Jul 23 12:51:41.456879 kubelet[1736]: I0723 12:51:41.456830 1736 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jul 23 12:51:41.457349 kubelet[1736]: E0723 12:51:41.457281 1736 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:41.457349 kubelet[1736]: E0723 12:51:41.457337 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:41.459398 kubelet[1736]: I0723 12:51:41.459358 1736 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Jul 23 12:51:41.460241 kubelet[1736]: I0723 12:51:41.460113 1736 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Jul 23 12:51:41.460381 kubelet[1736]: I0723 12:51:41.460301 1736 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Jul 23 12:51:41.460412 kubelet[1736]: W0723 12:51:41.460402 1736 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jul 23 12:51:41.467102 kubelet[1736]: I0723 12:51:41.467012 1736 server.go:1262] "Started kubelet" Jul 23 12:51:41.467983 kubelet[1736]: I0723 12:51:41.467903 1736 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Jul 23 12:51:41.468736 kubelet[1736]: I0723 12:51:41.468552 1736 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jul 23 12:51:41.469142 kubelet[1736]: I0723 12:51:41.468772 1736 server_v1.go:49] "podresources" method="list" useActivePods=true Jul 23 12:51:41.469142 kubelet[1736]: I0723 12:51:41.469113 1736 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jul 23 12:51:41.472377 kubelet[1736]: I0723 12:51:41.471872 1736 server.go:310] "Adding debug handlers to kubelet server" Jul 23 12:51:41.474572 kubelet[1736]: I0723 12:51:41.474397 1736 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jul 23 12:51:41.475164 kubelet[1736]: I0723 12:51:41.475055 1736 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jul 23 12:51:41.475256 kubelet[1736]: I0723 12:51:41.475228 1736 volume_manager.go:313] "Starting Kubelet Volume Manager" Jul 23 12:51:41.475351 kubelet[1736]: E0723 12:51:41.475316 1736 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.30\" not found" Jul 23 12:51:41.475922 kubelet[1736]: I0723 12:51:41.475827 1736 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Jul 23 12:51:41.476442 kubelet[1736]: I0723 12:51:41.476415 1736 reconciler.go:29] "Reconciler: start to sync state" Jul 23 12:51:41.478021 kubelet[1736]: E0723 12:51:41.477859 1736 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jul 23 12:51:41.478790 kubelet[1736]: I0723 12:51:41.478751 1736 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 Jul 23 12:51:41.482413 kubelet[1736]: I0723 12:51:41.482225 1736 factory.go:223] Registration of the containerd container factory successfully Jul 23 12:51:41.482413 kubelet[1736]: I0723 12:51:41.482379 1736 factory.go:223] Registration of the systemd container factory successfully Jul 23 12:51:41.489958 kubelet[1736]: E0723 12:51:41.489909 1736 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.30\" not found" node="10.0.0.30" Jul 23 12:51:41.497353 kubelet[1736]: I0723 12:51:41.497263 1736 cpu_manager.go:221] "Starting CPU manager" policy="none" Jul 23 12:51:41.497353 kubelet[1736]: I0723 12:51:41.497310 1736 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Jul 23 12:51:41.497353 kubelet[1736]: I0723 12:51:41.497367 1736 state_mem.go:36] "Initialized new in-memory state store" Jul 23 12:51:41.502245 kubelet[1736]: I0723 12:51:41.502137 1736 policy_none.go:49] "None policy: Start" Jul 23 12:51:41.502402 kubelet[1736]: I0723 12:51:41.502278 1736 memory_manager.go:187] "Starting memorymanager" policy="None" Jul 23 12:51:41.502402 kubelet[1736]: I0723 12:51:41.502312 1736 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Jul 23 12:51:41.505325 kubelet[1736]: I0723 12:51:41.505205 1736 policy_none.go:47] "Start" Jul 23 12:51:41.514757 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jul 23 12:51:41.528129 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jul 23 12:51:41.533617 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jul 23 12:51:41.548960 kubelet[1736]: E0723 12:51:41.548759 1736 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Jul 23 12:51:41.549363 kubelet[1736]: I0723 12:51:41.549308 1736 eviction_manager.go:189] "Eviction manager: starting control loop" Jul 23 12:51:41.549899 kubelet[1736]: I0723 12:51:41.549368 1736 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jul 23 12:51:41.549984 kubelet[1736]: I0723 12:51:41.549907 1736 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jul 23 12:51:41.553162 kubelet[1736]: E0723 12:51:41.553063 1736 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jul 23 12:51:41.553162 kubelet[1736]: E0723 12:51:41.553123 1736 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.30\" not found" Jul 23 12:51:41.575413 kubelet[1736]: I0723 12:51:41.575287 1736 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Jul 23 12:51:41.576766 kubelet[1736]: I0723 12:51:41.576730 1736 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Jul 23 12:51:41.576766 kubelet[1736]: I0723 12:51:41.576760 1736 status_manager.go:244] "Starting to sync pod status with apiserver" Jul 23 12:51:41.576766 kubelet[1736]: I0723 12:51:41.576783 1736 kubelet.go:2428] "Starting kubelet main sync loop" Jul 23 12:51:41.576948 kubelet[1736]: E0723 12:51:41.576826 1736 kubelet.go:2452] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jul 23 12:51:41.655714 kubelet[1736]: I0723 12:51:41.655149 1736 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.30" Jul 23 12:51:41.664542 kubelet[1736]: I0723 12:51:41.664436 1736 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.30" Jul 23 12:51:41.664542 kubelet[1736]: E0723 12:51:41.664531 1736 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"10.0.0.30\": node \"10.0.0.30\" not found" Jul 23 12:51:41.685257 kubelet[1736]: I0723 12:51:41.685218 1736 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jul 23 12:51:41.686276 containerd[1480]: time="2026-07-23T12:51:41.686093297Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jul 23 12:51:41.686848 kubelet[1736]: I0723 12:51:41.686732 1736 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jul 23 12:51:41.869014 sudo[1607]: pam_unix(sudo:session): session closed for user root Jul 23 12:51:41.871171 sshd[1604]: pam_unix(sshd:session): session closed for user core Jul 23 12:51:41.876053 systemd[1]: sshd@4-10.0.0.30:22-10.0.0.1:52410.service: Deactivated successfully. Jul 23 12:51:41.877420 systemd[1]: session-5.scope: Deactivated successfully. Jul 23 12:51:41.878229 systemd-logind[1455]: Session 5 logged out. Waiting for processes to exit. Jul 23 12:51:41.879303 systemd-logind[1455]: Removed session 5. Jul 23 12:51:42.393920 kubelet[1736]: I0723 12:51:42.393849 1736 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jul 23 12:51:42.394971 kubelet[1736]: I0723 12:51:42.394102 1736 reflector.go:571] "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" Jul 23 12:51:42.394971 kubelet[1736]: I0723 12:51:42.394118 1736 reflector.go:571] "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" Jul 23 12:51:42.394971 kubelet[1736]: I0723 12:51:42.394116 1736 reflector.go:571] "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" Jul 23 12:51:42.458088 kubelet[1736]: I0723 12:51:42.457978 1736 apiserver.go:52] "Watching apiserver" Jul 23 12:51:42.458288 kubelet[1736]: E0723 12:51:42.457979 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:42.481093 kubelet[1736]: I0723 12:51:42.480371 1736 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Jul 23 12:51:42.485828 kubelet[1736]: I0723 12:51:42.485665 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/83afa320-8ef9-4f32-a38d-f0dfda66f68c-run\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.485828 kubelet[1736]: I0723 12:51:42.485736 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/83afa320-8ef9-4f32-a38d-f0dfda66f68c-cni\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.485828 kubelet[1736]: I0723 12:51:42.485763 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/83afa320-8ef9-4f32-a38d-f0dfda66f68c-flannel-cfg\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.485828 kubelet[1736]: I0723 12:51:42.485834 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/83afa320-8ef9-4f32-a38d-f0dfda66f68c-xtables-lock\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.486043 kubelet[1736]: I0723 12:51:42.485855 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rvn87\" (UniqueName: \"kubernetes.io/projected/83afa320-8ef9-4f32-a38d-f0dfda66f68c-kube-api-access-rvn87\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.486043 kubelet[1736]: I0723 12:51:42.485876 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qk9qq\" (UniqueName: \"kubernetes.io/projected/3c453b9a-278e-4cbb-a9bc-b39d9c2741da-kube-api-access-qk9qq\") pod \"kube-proxy-v8rpz\" (UID: \"3c453b9a-278e-4cbb-a9bc-b39d9c2741da\") " pod="kube-system/kube-proxy-v8rpz" Jul 23 12:51:42.486043 kubelet[1736]: I0723 12:51:42.485948 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/83afa320-8ef9-4f32-a38d-f0dfda66f68c-cni-plugin\") pod \"kube-flannel-ds-6tfgp\" (UID: \"83afa320-8ef9-4f32-a38d-f0dfda66f68c\") " pod="kube-flannel/kube-flannel-ds-6tfgp" Jul 23 12:51:42.486043 kubelet[1736]: I0723 12:51:42.485968 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/3c453b9a-278e-4cbb-a9bc-b39d9c2741da-kube-proxy\") pod \"kube-proxy-v8rpz\" (UID: \"3c453b9a-278e-4cbb-a9bc-b39d9c2741da\") " pod="kube-system/kube-proxy-v8rpz" Jul 23 12:51:42.486043 kubelet[1736]: I0723 12:51:42.485987 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/3c453b9a-278e-4cbb-a9bc-b39d9c2741da-xtables-lock\") pod \"kube-proxy-v8rpz\" (UID: \"3c453b9a-278e-4cbb-a9bc-b39d9c2741da\") " pod="kube-system/kube-proxy-v8rpz" Jul 23 12:51:42.486223 kubelet[1736]: I0723 12:51:42.486004 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/3c453b9a-278e-4cbb-a9bc-b39d9c2741da-lib-modules\") pod \"kube-proxy-v8rpz\" (UID: \"3c453b9a-278e-4cbb-a9bc-b39d9c2741da\") " pod="kube-system/kube-proxy-v8rpz" Jul 23 12:51:42.490568 systemd[1]: Created slice kubepods-burstable-pod83afa320_8ef9_4f32_a38d_f0dfda66f68c.slice - libcontainer container kubepods-burstable-pod83afa320_8ef9_4f32_a38d_f0dfda66f68c.slice. Jul 23 12:51:42.590947 systemd[1]: Created slice kubepods-besteffort-pod3c453b9a_278e_4cbb_a9bc_b39d9c2741da.slice - libcontainer container kubepods-besteffort-pod3c453b9a_278e_4cbb_a9bc_b39d9c2741da.slice. Jul 23 12:51:42.892007 kubelet[1736]: E0723 12:51:42.891763 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:42.893407 containerd[1480]: time="2026-07-23T12:51:42.893306656Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-6tfgp,Uid:83afa320-8ef9-4f32-a38d-f0dfda66f68c,Namespace:kube-flannel,Attempt:0,}" Jul 23 12:51:42.905288 kubelet[1736]: E0723 12:51:42.905240 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:42.906268 containerd[1480]: time="2026-07-23T12:51:42.906126639Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-v8rpz,Uid:3c453b9a-278e-4cbb-a9bc-b39d9c2741da,Namespace:kube-system,Attempt:0,}" Jul 23 12:51:43.310390 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1758961547.mount: Deactivated successfully. Jul 23 12:51:43.326313 containerd[1480]: time="2026-07-23T12:51:43.323832199Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 23 12:51:43.326313 containerd[1480]: time="2026-07-23T12:51:43.325072913Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 23 12:51:43.326313 containerd[1480]: time="2026-07-23T12:51:43.326105037Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=311988" Jul 23 12:51:43.328146 containerd[1480]: time="2026-07-23T12:51:43.328089212Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 23 12:51:43.328747 containerd[1480]: time="2026-07-23T12:51:43.328715367Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Jul 23 12:51:43.330697 containerd[1480]: time="2026-07-23T12:51:43.330593090Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 23 12:51:43.331176 containerd[1480]: time="2026-07-23T12:51:43.331128698Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 424.756643ms" Jul 23 12:51:43.332463 containerd[1480]: time="2026-07-23T12:51:43.332246122Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 438.802707ms" Jul 23 12:51:43.459047 kubelet[1736]: E0723 12:51:43.458982 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:43.674216 containerd[1480]: time="2026-07-23T12:51:43.673557760Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 23 12:51:43.674216 containerd[1480]: time="2026-07-23T12:51:43.673688540Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 23 12:51:43.674216 containerd[1480]: time="2026-07-23T12:51:43.673708870Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:43.674216 containerd[1480]: time="2026-07-23T12:51:43.673934278Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:43.680994 containerd[1480]: time="2026-07-23T12:51:43.680448821Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 23 12:51:43.680994 containerd[1480]: time="2026-07-23T12:51:43.680749059Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 23 12:51:43.680994 containerd[1480]: time="2026-07-23T12:51:43.680785720Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:43.681632 containerd[1480]: time="2026-07-23T12:51:43.681519736Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:43.948945 systemd[1]: Started cri-containerd-4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab.scope - libcontainer container 4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab. Jul 23 12:51:43.950804 systemd[1]: Started cri-containerd-535c3d9e435bf1080e990eb71adaaf2e66206de670ab785c166532e57c5eeb24.scope - libcontainer container 535c3d9e435bf1080e990eb71adaaf2e66206de670ab785c166532e57c5eeb24. Jul 23 12:51:44.012800 containerd[1480]: time="2026-07-23T12:51:44.012724835Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-v8rpz,Uid:3c453b9a-278e-4cbb-a9bc-b39d9c2741da,Namespace:kube-system,Attempt:0,} returns sandbox id \"535c3d9e435bf1080e990eb71adaaf2e66206de670ab785c166532e57c5eeb24\"" Jul 23 12:51:44.014439 kubelet[1736]: E0723 12:51:44.014394 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:44.016562 containerd[1480]: time="2026-07-23T12:51:44.016446190Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.10\"" Jul 23 12:51:44.019303 containerd[1480]: time="2026-07-23T12:51:44.019245102Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-6tfgp,Uid:83afa320-8ef9-4f32-a38d-f0dfda66f68c,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\"" Jul 23 12:51:44.020280 kubelet[1736]: E0723 12:51:44.020208 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:44.461541 kubelet[1736]: E0723 12:51:44.459930 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:45.219471 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3400486270.mount: Deactivated successfully. Jul 23 12:51:45.460615 kubelet[1736]: E0723 12:51:45.460572 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:45.680590 containerd[1480]: time="2026-07-23T12:51:45.680388044Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:45.681033 containerd[1480]: time="2026-07-23T12:51:45.680966484Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.10: active requests=0, bytes read=27132103" Jul 23 12:51:45.681614 containerd[1480]: time="2026-07-23T12:51:45.681572704Z" level=info msg="ImageCreate event name:\"sha256:301c07627deeb3c3f30116345221a9d94d1f1ebff133d0abe57cac3e61479337\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:45.683894 containerd[1480]: time="2026-07-23T12:51:45.683845431Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:c6771898c0fd1ddaa99dd841cfe46d32260268ba45f513cc1ebd8cd240c18782\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:45.684822 containerd[1480]: time="2026-07-23T12:51:45.684793659Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.10\" with image id \"sha256:301c07627deeb3c3f30116345221a9d94d1f1ebff133d0abe57cac3e61479337\", repo tag \"registry.k8s.io/kube-proxy:v1.34.10\", repo digest \"registry.k8s.io/kube-proxy@sha256:c6771898c0fd1ddaa99dd841cfe46d32260268ba45f513cc1ebd8cd240c18782\", size \"27131228\" in 1.668303801s" Jul 23 12:51:45.684888 containerd[1480]: time="2026-07-23T12:51:45.684826344Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.10\" returns image reference \"sha256:301c07627deeb3c3f30116345221a9d94d1f1ebff133d0abe57cac3e61479337\"" Jul 23 12:51:45.686096 containerd[1480]: time="2026-07-23T12:51:45.686050309Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Jul 23 12:51:45.689952 containerd[1480]: time="2026-07-23T12:51:45.689834463Z" level=info msg="CreateContainer within sandbox \"535c3d9e435bf1080e990eb71adaaf2e66206de670ab785c166532e57c5eeb24\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jul 23 12:51:45.706857 containerd[1480]: time="2026-07-23T12:51:45.706782905Z" level=info msg="CreateContainer within sandbox \"535c3d9e435bf1080e990eb71adaaf2e66206de670ab785c166532e57c5eeb24\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"f51131483ab275b78fe8c90bdadc3e35aa259c218d3c6cfea8a91970b6e3124d\"" Jul 23 12:51:45.707688 containerd[1480]: time="2026-07-23T12:51:45.707646119Z" level=info msg="StartContainer for \"f51131483ab275b78fe8c90bdadc3e35aa259c218d3c6cfea8a91970b6e3124d\"" Jul 23 12:51:45.758723 systemd[1]: Started cri-containerd-f51131483ab275b78fe8c90bdadc3e35aa259c218d3c6cfea8a91970b6e3124d.scope - libcontainer container f51131483ab275b78fe8c90bdadc3e35aa259c218d3c6cfea8a91970b6e3124d. Jul 23 12:51:45.879622 containerd[1480]: time="2026-07-23T12:51:45.879554246Z" level=info msg="StartContainer for \"f51131483ab275b78fe8c90bdadc3e35aa259c218d3c6cfea8a91970b6e3124d\" returns successfully" Jul 23 12:51:46.461662 kubelet[1736]: E0723 12:51:46.461472 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:46.632308 kubelet[1736]: E0723 12:51:46.632272 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:46.645789 kubelet[1736]: I0723 12:51:46.645711 1736 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-v8rpz" podStartSLOduration=3.975943988 podStartE2EDuration="5.64569882s" podCreationTimestamp="2026-07-23 12:51:41 +0000 UTC" firstStartedPulling="2026-07-23 12:51:44.016032548 +0000 UTC m=+3.152415343" lastFinishedPulling="2026-07-23 12:51:45.685787374 +0000 UTC m=+4.822170175" observedRunningTime="2026-07-23 12:51:46.645658883 +0000 UTC m=+5.782041686" watchObservedRunningTime="2026-07-23 12:51:46.64569882 +0000 UTC m=+5.782081625" Jul 23 12:51:47.462175 kubelet[1736]: E0723 12:51:47.462084 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:47.634530 kubelet[1736]: E0723 12:51:47.634455 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:48.436239 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3277467219.mount: Deactivated successfully. Jul 23 12:51:48.463442 kubelet[1736]: E0723 12:51:48.463350 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:48.514034 containerd[1480]: time="2026-07-23T12:51:48.513913063Z" 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\"}" Jul 23 12:51:48.514728 containerd[1480]: time="2026-07-23T12:51:48.514684950Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Jul 23 12:51:48.515792 containerd[1480]: time="2026-07-23T12:51:48.515736486Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:48.518896 containerd[1480]: time="2026-07-23T12:51:48.518853084Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:48.520693 containerd[1480]: time="2026-07-23T12:51:48.520253310Z" 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 2.834157179s" Jul 23 12:51:48.520693 containerd[1480]: time="2026-07-23T12:51:48.520285331Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Jul 23 12:51:48.526093 containerd[1480]: time="2026-07-23T12:51:48.526035528Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jul 23 12:51:48.540432 containerd[1480]: time="2026-07-23T12:51:48.540360035Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9\"" Jul 23 12:51:48.541024 containerd[1480]: time="2026-07-23T12:51:48.540998537Z" level=info msg="StartContainer for \"bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9\"" Jul 23 12:51:48.603756 systemd[1]: Started cri-containerd-bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9.scope - libcontainer container bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9. Jul 23 12:51:48.721006 containerd[1480]: time="2026-07-23T12:51:48.720875361Z" level=info msg="StartContainer for \"bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9\" returns successfully" Jul 23 12:51:48.730302 systemd[1]: cri-containerd-bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9.scope: Deactivated successfully. Jul 23 12:51:48.794075 containerd[1480]: time="2026-07-23T12:51:48.793948087Z" level=info msg="shim disconnected" id=bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9 namespace=k8s.io Jul 23 12:51:48.794075 containerd[1480]: time="2026-07-23T12:51:48.794031263Z" level=warning msg="cleaning up after shim disconnected" id=bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9 namespace=k8s.io Jul 23 12:51:48.794075 containerd[1480]: time="2026-07-23T12:51:48.794042215Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 23 12:51:49.269363 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-bbc1ca7848749fe338516f4adece090428e97ee604c29c38377ea8cb0f9038c9-rootfs.mount: Deactivated successfully. Jul 23 12:51:49.463805 kubelet[1736]: E0723 12:51:49.463714 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:49.643199 kubelet[1736]: E0723 12:51:49.643044 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:49.644239 containerd[1480]: time="2026-07-23T12:51:49.644162773Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Jul 23 12:51:50.464184 kubelet[1736]: E0723 12:51:50.463985 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:51.465487 kubelet[1736]: E0723 12:51:51.465422 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:52.466398 kubelet[1736]: E0723 12:51:52.466198 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:53.467422 kubelet[1736]: E0723 12:51:53.467284 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:54.468395 kubelet[1736]: E0723 12:51:54.468332 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:55.469284 kubelet[1736]: E0723 12:51:55.469212 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:55.639451 containerd[1480]: time="2026-07-23T12:51:55.639366325Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:55.640214 containerd[1480]: time="2026-07-23T12:51:55.640157408Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Jul 23 12:51:55.641728 containerd[1480]: time="2026-07-23T12:51:55.641649470Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:55.645598 containerd[1480]: time="2026-07-23T12:51:55.645526593Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:51:55.646825 containerd[1480]: time="2026-07-23T12:51:55.646784293Z" 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 6.002522674s" Jul 23 12:51:55.646825 containerd[1480]: time="2026-07-23T12:51:55.646823588Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Jul 23 12:51:55.670068 containerd[1480]: time="2026-07-23T12:51:55.669935861Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jul 23 12:51:55.691163 containerd[1480]: time="2026-07-23T12:51:55.691059811Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896\"" Jul 23 12:51:55.693713 containerd[1480]: time="2026-07-23T12:51:55.692154825Z" level=info msg="StartContainer for \"2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896\"" Jul 23 12:51:55.816915 systemd[1]: Started cri-containerd-2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896.scope - libcontainer container 2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896. Jul 23 12:51:56.069809 systemd[1]: cri-containerd-2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896.scope: Deactivated successfully. Jul 23 12:51:56.073493 containerd[1480]: time="2026-07-23T12:51:56.073415528Z" level=info msg="StartContainer for \"2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896\" returns successfully" Jul 23 12:51:56.127758 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896-rootfs.mount: Deactivated successfully. Jul 23 12:51:56.171572 kubelet[1736]: I0723 12:51:56.171455 1736 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Jul 23 12:51:56.211255 containerd[1480]: time="2026-07-23T12:51:56.211160486Z" level=info msg="shim disconnected" id=2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896 namespace=k8s.io Jul 23 12:51:56.211255 containerd[1480]: time="2026-07-23T12:51:56.211243857Z" level=warning msg="cleaning up after shim disconnected" id=2f9e8d18f3e386ebdefde01f813e7d05fdc9436c9cacfa658abc3afcad0b3896 namespace=k8s.io Jul 23 12:51:56.211255 containerd[1480]: time="2026-07-23T12:51:56.211251831Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 23 12:51:56.470209 kubelet[1736]: E0723 12:51:56.469946 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:56.678103 kubelet[1736]: E0723 12:51:56.677652 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:56.693274 containerd[1480]: time="2026-07-23T12:51:56.693228553Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jul 23 12:51:56.717588 containerd[1480]: time="2026-07-23T12:51:56.717304684Z" level=info msg="CreateContainer within sandbox \"4ab1489fc85a29515bbd41d02175703c76d62c55170117dedbc0c56cf8391eab\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"a30f7c6ff74230185ecd645a45972143e52601be55d878e17edd05d1e344c673\"" Jul 23 12:51:56.718735 containerd[1480]: time="2026-07-23T12:51:56.718641501Z" level=info msg="StartContainer for \"a30f7c6ff74230185ecd645a45972143e52601be55d878e17edd05d1e344c673\"" Jul 23 12:51:56.836965 systemd[1]: Started cri-containerd-a30f7c6ff74230185ecd645a45972143e52601be55d878e17edd05d1e344c673.scope - libcontainer container a30f7c6ff74230185ecd645a45972143e52601be55d878e17edd05d1e344c673. Jul 23 12:51:56.885739 containerd[1480]: time="2026-07-23T12:51:56.885564288Z" level=info msg="StartContainer for \"a30f7c6ff74230185ecd645a45972143e52601be55d878e17edd05d1e344c673\" returns successfully" Jul 23 12:51:57.471137 kubelet[1736]: E0723 12:51:57.471020 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:57.702060 kubelet[1736]: E0723 12:51:57.701985 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:58.169862 kubelet[1736]: I0723 12:51:58.169803 1736 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-6tfgp" podStartSLOduration=5.541736517 podStartE2EDuration="17.169783079s" podCreationTimestamp="2026-07-23 12:51:41 +0000 UTC" firstStartedPulling="2026-07-23 12:51:44.020852491 +0000 UTC m=+3.157235288" lastFinishedPulling="2026-07-23 12:51:55.648899056 +0000 UTC m=+14.785281850" observedRunningTime="2026-07-23 12:51:57.773942549 +0000 UTC m=+16.910325371" watchObservedRunningTime="2026-07-23 12:51:58.169783079 +0000 UTC m=+17.306165874" Jul 23 12:51:58.185772 systemd[1]: Created slice kubepods-besteffort-pode0880969_b66e_412d_8e76_ea66dde33768.slice - libcontainer container kubepods-besteffort-pode0880969_b66e_412d_8e76_ea66dde33768.slice. Jul 23 12:51:58.187733 kubelet[1736]: I0723 12:51:58.187128 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-kmgpr\" (UniqueName: \"kubernetes.io/projected/e0880969-b66e-412d-8e76-ea66dde33768-kube-api-access-kmgpr\") pod \"nginx-deployment-bb8f74bfb-b48j7\" (UID: \"e0880969-b66e-412d-8e76-ea66dde33768\") " pod="default/nginx-deployment-bb8f74bfb-b48j7" Jul 23 12:51:58.203859 systemd-networkd[1405]: flannel.1: Link UP Jul 23 12:51:58.211321 systemd-networkd[1405]: flannel.1: Gained carrier Jul 23 12:51:58.472317 kubelet[1736]: E0723 12:51:58.471973 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:58.494780 containerd[1480]: time="2026-07-23T12:51:58.494704362Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-b48j7,Uid:e0880969-b66e-412d-8e76-ea66dde33768,Namespace:default,Attempt:0,}" Jul 23 12:51:58.542368 systemd-networkd[1405]: cni0: Link UP Jul 23 12:51:58.542383 systemd-networkd[1405]: cni0: Gained carrier Jul 23 12:51:58.542670 systemd-networkd[1405]: cni0: Lost carrier Jul 23 12:51:58.552391 systemd-networkd[1405]: veth5c483943: Link UP Jul 23 12:51:58.556073 kernel: cni0: port 1(veth5c483943) entered blocking state Jul 23 12:51:58.556636 kernel: cni0: port 1(veth5c483943) entered disabled state Jul 23 12:51:58.558612 kernel: veth5c483943: entered allmulticast mode Jul 23 12:51:58.558710 kernel: veth5c483943: entered promiscuous mode Jul 23 12:51:58.560663 kernel: cni0: port 1(veth5c483943) entered blocking state Jul 23 12:51:58.560726 kernel: cni0: port 1(veth5c483943) entered forwarding state Jul 23 12:51:58.561707 kernel: cni0: port 1(veth5c483943) entered disabled state Jul 23 12:51:58.577793 kernel: cni0: port 1(veth5c483943) entered blocking state Jul 23 12:51:58.577912 kernel: cni0: port 1(veth5c483943) entered forwarding state Jul 23 12:51:58.577999 systemd-networkd[1405]: veth5c483943: Gained carrier Jul 23 12:51:58.579031 systemd-networkd[1405]: cni0: Gained carrier Jul 23 12:51:58.583017 containerd[1480]: 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"} Jul 23 12:51:58.583017 containerd[1480]: delegateAdd: netconf sent to delegate plugin: Jul 23 12:51:58.679902 containerd[1480]: {"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-07-23T12:51:58.679091402Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 23 12:51:58.680121 containerd[1480]: time="2026-07-23T12:51:58.680023375Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 23 12:51:58.680121 containerd[1480]: time="2026-07-23T12:51:58.680079823Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:58.680404 containerd[1480]: time="2026-07-23T12:51:58.680285199Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:51:58.703796 kubelet[1736]: E0723 12:51:58.703744 1736 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 23 12:51:58.735797 systemd[1]: Started cri-containerd-0dbe286c2ef08d21b283e8be717420545149567c0494b40bb5350056f3afc8a6.scope - libcontainer container 0dbe286c2ef08d21b283e8be717420545149567c0494b40bb5350056f3afc8a6. Jul 23 12:51:58.787122 systemd-resolved[1337]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 23 12:51:58.828455 containerd[1480]: time="2026-07-23T12:51:58.828368342Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-b48j7,Uid:e0880969-b66e-412d-8e76-ea66dde33768,Namespace:default,Attempt:0,} returns sandbox id \"0dbe286c2ef08d21b283e8be717420545149567c0494b40bb5350056f3afc8a6\"" Jul 23 12:51:58.830333 containerd[1480]: time="2026-07-23T12:51:58.830284125Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 23 12:51:59.390936 systemd-networkd[1405]: flannel.1: Gained IPv6LL Jul 23 12:51:59.473623 kubelet[1736]: E0723 12:51:59.473465 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:51:59.838832 systemd-networkd[1405]: cni0: Gained IPv6LL Jul 23 12:52:00.068821 systemd-networkd[1405]: veth5c483943: Gained IPv6LL Jul 23 12:52:00.476276 kubelet[1736]: E0723 12:52:00.475920 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:01.457093 kubelet[1736]: E0723 12:52:01.457030 1736 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:01.476854 kubelet[1736]: E0723 12:52:01.476711 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:02.083396 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount892445602.mount: Deactivated successfully. Jul 23 12:52:02.479112 kubelet[1736]: E0723 12:52:02.478443 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:03.391270 containerd[1480]: time="2026-07-23T12:52:03.391022336Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:03.391952 containerd[1480]: time="2026-07-23T12:52:03.391851055Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=64104220" Jul 23 12:52:03.393440 containerd[1480]: time="2026-07-23T12:52:03.393333634Z" level=info msg="ImageCreate event name:\"sha256:f91c43d45520959a835dfeb3d9e62ec52610b983c6c20ea409b2f212b2d38fb0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:03.399418 containerd[1480]: time="2026-07-23T12:52:03.399345983Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:70aae0bfcd7c307fa7af235a49ce4b10b331d9bfa3c21a5aa85609bd875e3c10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:03.400851 containerd[1480]: time="2026-07-23T12:52:03.400770759Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f91c43d45520959a835dfeb3d9e62ec52610b983c6c20ea409b2f212b2d38fb0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:70aae0bfcd7c307fa7af235a49ce4b10b331d9bfa3c21a5aa85609bd875e3c10\", size \"64104098\" in 4.570441214s" Jul 23 12:52:03.400851 containerd[1480]: time="2026-07-23T12:52:03.400814748Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f91c43d45520959a835dfeb3d9e62ec52610b983c6c20ea409b2f212b2d38fb0\"" Jul 23 12:52:03.407890 containerd[1480]: time="2026-07-23T12:52:03.407848600Z" level=info msg="CreateContainer within sandbox \"0dbe286c2ef08d21b283e8be717420545149567c0494b40bb5350056f3afc8a6\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jul 23 12:52:03.422381 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2176388813.mount: Deactivated successfully. Jul 23 12:52:03.424645 containerd[1480]: time="2026-07-23T12:52:03.424425008Z" level=info msg="CreateContainer within sandbox \"0dbe286c2ef08d21b283e8be717420545149567c0494b40bb5350056f3afc8a6\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"586bbf1cf0ca62fa815719ee3904bd5000ba934a9662366b2e33be5ef8369971\"" Jul 23 12:52:03.426550 containerd[1480]: time="2026-07-23T12:52:03.426397563Z" level=info msg="StartContainer for \"586bbf1cf0ca62fa815719ee3904bd5000ba934a9662366b2e33be5ef8369971\"" Jul 23 12:52:03.479103 kubelet[1736]: E0723 12:52:03.479069 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:03.485893 systemd[1]: Started cri-containerd-586bbf1cf0ca62fa815719ee3904bd5000ba934a9662366b2e33be5ef8369971.scope - libcontainer container 586bbf1cf0ca62fa815719ee3904bd5000ba934a9662366b2e33be5ef8369971. Jul 23 12:52:03.543181 containerd[1480]: time="2026-07-23T12:52:03.543099407Z" level=info msg="StartContainer for \"586bbf1cf0ca62fa815719ee3904bd5000ba934a9662366b2e33be5ef8369971\" returns successfully" Jul 23 12:52:04.481909 kubelet[1736]: E0723 12:52:04.481241 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:05.482353 kubelet[1736]: E0723 12:52:05.482116 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:06.483811 kubelet[1736]: E0723 12:52:06.483734 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:07.484889 kubelet[1736]: E0723 12:52:07.484649 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:08.485563 kubelet[1736]: E0723 12:52:08.485413 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:09.468905 kubelet[1736]: I0723 12:52:09.468785 1736 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-b48j7" podStartSLOduration=6.895931022 podStartE2EDuration="11.468761276s" podCreationTimestamp="2026-07-23 12:51:58 +0000 UTC" firstStartedPulling="2026-07-23 12:51:58.829395542 +0000 UTC m=+17.965778357" lastFinishedPulling="2026-07-23 12:52:03.402225816 +0000 UTC m=+22.538608611" observedRunningTime="2026-07-23 12:52:03.788188207 +0000 UTC m=+22.924571005" watchObservedRunningTime="2026-07-23 12:52:09.468761276 +0000 UTC m=+28.605144082" Jul 23 12:52:09.477611 systemd[1]: Created slice kubepods-besteffort-pod7f6176c6_eadb_4386_b250_8e42d2b56124.slice - libcontainer container kubepods-besteffort-pod7f6176c6_eadb_4386_b250_8e42d2b56124.slice. Jul 23 12:52:09.485814 kubelet[1736]: E0723 12:52:09.485720 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:09.502495 kubelet[1736]: I0723 12:52:09.502379 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/7f6176c6-eadb-4386-b250-8e42d2b56124-data\") pod \"nfs-server-provisioner-0\" (UID: \"7f6176c6-eadb-4386-b250-8e42d2b56124\") " pod="default/nfs-server-provisioner-0" Jul 23 12:52:09.502495 kubelet[1736]: I0723 12:52:09.502459 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qvdqv\" (UniqueName: \"kubernetes.io/projected/7f6176c6-eadb-4386-b250-8e42d2b56124-kube-api-access-qvdqv\") pod \"nfs-server-provisioner-0\" (UID: \"7f6176c6-eadb-4386-b250-8e42d2b56124\") " pod="default/nfs-server-provisioner-0" Jul 23 12:52:09.788956 containerd[1480]: time="2026-07-23T12:52:09.788799187Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7f6176c6-eadb-4386-b250-8e42d2b56124,Namespace:default,Attempt:0,}" Jul 23 12:52:09.820132 systemd-networkd[1405]: veth2fe89b47: Link UP Jul 23 12:52:09.826957 kernel: cni0: port 2(veth2fe89b47) entered blocking state Jul 23 12:52:09.827916 kernel: cni0: port 2(veth2fe89b47) entered disabled state Jul 23 12:52:09.828026 kernel: veth2fe89b47: entered allmulticast mode Jul 23 12:52:09.828124 kernel: veth2fe89b47: entered promiscuous mode Jul 23 12:52:09.850967 kernel: cni0: port 2(veth2fe89b47) entered blocking state Jul 23 12:52:09.851342 kernel: cni0: port 2(veth2fe89b47) entered forwarding state Jul 23 12:52:09.849684 systemd-networkd[1405]: veth2fe89b47: Gained carrier Jul 23 12:52:09.854930 containerd[1480]: 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)(0xc0000a0950), "name":"cbr0", "type":"bridge"} Jul 23 12:52:09.854930 containerd[1480]: delegateAdd: netconf sent to delegate plugin: Jul 23 12:52:09.904681 containerd[1480]: {"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-07-23T12:52:09.904389692Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 23 12:52:09.904887 containerd[1480]: time="2026-07-23T12:52:09.904802173Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 23 12:52:09.905031 containerd[1480]: time="2026-07-23T12:52:09.904976059Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:52:09.908937 containerd[1480]: time="2026-07-23T12:52:09.908794892Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:52:09.951832 systemd[1]: Started cri-containerd-77871e984a354d71f19b8f009aae42f3f95565248e4e8df747a7f2f11be7cdf5.scope - libcontainer container 77871e984a354d71f19b8f009aae42f3f95565248e4e8df747a7f2f11be7cdf5. Jul 23 12:52:09.976555 systemd-resolved[1337]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 23 12:52:10.021672 containerd[1480]: time="2026-07-23T12:52:10.021590948Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7f6176c6-eadb-4386-b250-8e42d2b56124,Namespace:default,Attempt:0,} returns sandbox id \"77871e984a354d71f19b8f009aae42f3f95565248e4e8df747a7f2f11be7cdf5\"" Jul 23 12:52:10.026563 containerd[1480]: time="2026-07-23T12:52:10.026490846Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jul 23 12:52:10.489152 kubelet[1736]: E0723 12:52:10.488940 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:11.038701 systemd-networkd[1405]: veth2fe89b47: Gained IPv6LL Jul 23 12:52:11.488280 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount603149845.mount: Deactivated successfully. Jul 23 12:52:11.489984 kubelet[1736]: E0723 12:52:11.489940 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:12.490797 kubelet[1736]: E0723 12:52:12.490735 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:13.492109 kubelet[1736]: E0723 12:52:13.491985 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:13.670139 containerd[1480]: time="2026-07-23T12:52:13.670045596Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:13.671084 containerd[1480]: time="2026-07-23T12:52:13.670992562Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039034" Jul 23 12:52:13.672111 containerd[1480]: time="2026-07-23T12:52:13.672054036Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:13.678007 containerd[1480]: time="2026-07-23T12:52:13.677935285Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:13.679112 containerd[1480]: time="2026-07-23T12:52:13.679063338Z" 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 3.652348124s" Jul 23 12:52:13.679112 containerd[1480]: time="2026-07-23T12:52:13.679100668Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jul 23 12:52:13.684582 containerd[1480]: time="2026-07-23T12:52:13.684185828Z" level=info msg="CreateContainer within sandbox \"77871e984a354d71f19b8f009aae42f3f95565248e4e8df747a7f2f11be7cdf5\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jul 23 12:52:13.702489 containerd[1480]: time="2026-07-23T12:52:13.702417877Z" level=info msg="CreateContainer within sandbox \"77871e984a354d71f19b8f009aae42f3f95565248e4e8df747a7f2f11be7cdf5\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"e39219c7438b8fce55de75685f8d208f12efe36deff7a3a19ba5501b448e9a49\"" Jul 23 12:52:13.703187 containerd[1480]: time="2026-07-23T12:52:13.703163413Z" level=info msg="StartContainer for \"e39219c7438b8fce55de75685f8d208f12efe36deff7a3a19ba5501b448e9a49\"" Jul 23 12:52:13.757778 systemd[1]: Started cri-containerd-e39219c7438b8fce55de75685f8d208f12efe36deff7a3a19ba5501b448e9a49.scope - libcontainer container e39219c7438b8fce55de75685f8d208f12efe36deff7a3a19ba5501b448e9a49. Jul 23 12:52:13.797926 containerd[1480]: time="2026-07-23T12:52:13.797851755Z" level=info msg="StartContainer for \"e39219c7438b8fce55de75685f8d208f12efe36deff7a3a19ba5501b448e9a49\" returns successfully" Jul 23 12:52:14.492869 kubelet[1736]: E0723 12:52:14.492770 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:15.493463 kubelet[1736]: E0723 12:52:15.493348 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:16.494322 kubelet[1736]: E0723 12:52:16.494264 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:17.495615 kubelet[1736]: E0723 12:52:17.495221 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:17.854466 update_engine[1460]: I20260723 12:52:17.852003 1460 update_attempter.cc:509] Updating boot flags... Jul 23 12:52:17.901617 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (2738) Jul 23 12:52:17.957000 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 32 scanned by (udev-worker) (2736) Jul 23 12:52:18.496208 kubelet[1736]: E0723 12:52:18.496088 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:19.130748 kubelet[1736]: I0723 12:52:19.130588 1736 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.47551564 podStartE2EDuration="10.130431686s" podCreationTimestamp="2026-07-23 12:52:09 +0000 UTC" firstStartedPulling="2026-07-23 12:52:10.024952539 +0000 UTC m=+29.161335338" lastFinishedPulling="2026-07-23 12:52:13.67986859 +0000 UTC m=+32.816251384" observedRunningTime="2026-07-23 12:52:13.820410578 +0000 UTC m=+32.956793383" watchObservedRunningTime="2026-07-23 12:52:19.130431686 +0000 UTC m=+38.266814483" Jul 23 12:52:19.144116 systemd[1]: Created slice kubepods-besteffort-podb7aa776b_a0ec_46f2_9bc7_8b6ce53745c0.slice - libcontainer container kubepods-besteffort-podb7aa776b_a0ec_46f2_9bc7_8b6ce53745c0.slice. Jul 23 12:52:19.292318 kubelet[1736]: I0723 12:52:19.292189 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-f5f3bd3f-b94b-430c-afd4-ecc833e0e730\" (UniqueName: \"kubernetes.io/nfs/b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0-pvc-f5f3bd3f-b94b-430c-afd4-ecc833e0e730\") pod \"test-pod-1\" (UID: \"b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0\") " pod="default/test-pod-1" Jul 23 12:52:19.292799 kubelet[1736]: I0723 12:52:19.292490 1736 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rdbhk\" (UniqueName: \"kubernetes.io/projected/b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0-kube-api-access-rdbhk\") pod \"test-pod-1\" (UID: \"b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0\") " pod="default/test-pod-1" Jul 23 12:52:19.497625 kernel: FS-Cache: Loaded Jul 23 12:52:19.497732 kubelet[1736]: E0723 12:52:19.496968 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:19.582856 kernel: RPC: Registered named UNIX socket transport module. Jul 23 12:52:19.583035 kernel: RPC: Registered udp transport module. Jul 23 12:52:19.583060 kernel: RPC: Registered tcp transport module. Jul 23 12:52:19.584626 kernel: RPC: Registered tcp-with-tls transport module. Jul 23 12:52:19.584881 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jul 23 12:52:19.992763 kernel: NFS: Registering the id_resolver key type Jul 23 12:52:19.993060 kernel: Key type id_resolver registered Jul 23 12:52:19.993081 kernel: Key type id_legacy registered Jul 23 12:52:20.035272 nfsidmap[2779]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 23 12:52:20.041388 nfsidmap[2782]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 23 12:52:20.353225 containerd[1480]: time="2026-07-23T12:52:20.352925263Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0,Namespace:default,Attempt:0,}" Jul 23 12:52:20.399579 systemd-networkd[1405]: veth20f5d969: Link UP Jul 23 12:52:20.403155 kernel: cni0: port 3(veth20f5d969) entered blocking state Jul 23 12:52:20.403392 kernel: cni0: port 3(veth20f5d969) entered disabled state Jul 23 12:52:20.403433 kernel: veth20f5d969: entered allmulticast mode Jul 23 12:52:20.408722 kernel: veth20f5d969: entered promiscuous mode Jul 23 12:52:20.425316 kernel: cni0: port 3(veth20f5d969) entered blocking state Jul 23 12:52:20.425625 kernel: cni0: port 3(veth20f5d969) entered forwarding state Jul 23 12:52:20.425941 systemd-networkd[1405]: veth20f5d969: Gained carrier Jul 23 12:52:20.437016 containerd[1480]: 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"} Jul 23 12:52:20.437016 containerd[1480]: delegateAdd: netconf sent to delegate plugin: Jul 23 12:52:20.499178 kubelet[1736]: E0723 12:52:20.499126 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:20.573555 containerd[1480]: {"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-07-23T12:52:20.573268356Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 23 12:52:20.573555 containerd[1480]: time="2026-07-23T12:52:20.573395731Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 23 12:52:20.573555 containerd[1480]: time="2026-07-23T12:52:20.573404772Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:52:20.575066 containerd[1480]: time="2026-07-23T12:52:20.574219491Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 23 12:52:20.635851 systemd[1]: Started cri-containerd-01cf5078fdcafb411751f39869474e3500b08eb0b824a0da296cbfdb84bb7934.scope - libcontainer container 01cf5078fdcafb411751f39869474e3500b08eb0b824a0da296cbfdb84bb7934. Jul 23 12:52:20.672251 systemd-resolved[1337]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 23 12:52:20.725940 containerd[1480]: time="2026-07-23T12:52:20.725869099Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:b7aa776b-a0ec-46f2-9bc7-8b6ce53745c0,Namespace:default,Attempt:0,} returns sandbox id \"01cf5078fdcafb411751f39869474e3500b08eb0b824a0da296cbfdb84bb7934\"" Jul 23 12:52:20.728090 containerd[1480]: time="2026-07-23T12:52:20.728045986Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 23 12:52:21.114719 containerd[1480]: time="2026-07-23T12:52:21.114328020Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 23 12:52:21.115676 containerd[1480]: time="2026-07-23T12:52:21.115372306Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jul 23 12:52:21.120783 containerd[1480]: time="2026-07-23T12:52:21.120431938Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f91c43d45520959a835dfeb3d9e62ec52610b983c6c20ea409b2f212b2d38fb0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:70aae0bfcd7c307fa7af235a49ce4b10b331d9bfa3c21a5aa85609bd875e3c10\", size \"64104098\" in 392.319773ms" Jul 23 12:52:21.121121 containerd[1480]: time="2026-07-23T12:52:21.120791139Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f91c43d45520959a835dfeb3d9e62ec52610b983c6c20ea409b2f212b2d38fb0\"" Jul 23 12:52:21.130141 containerd[1480]: time="2026-07-23T12:52:21.130065722Z" level=info msg="CreateContainer within sandbox \"01cf5078fdcafb411751f39869474e3500b08eb0b824a0da296cbfdb84bb7934\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jul 23 12:52:21.171581 containerd[1480]: time="2026-07-23T12:52:21.170896018Z" level=info msg="CreateContainer within sandbox \"01cf5078fdcafb411751f39869474e3500b08eb0b824a0da296cbfdb84bb7934\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"453855f37c83c7b2e005b14a0b87a344ef3748c966703d5e1314d4a6e43dd270\"" Jul 23 12:52:21.180168 containerd[1480]: time="2026-07-23T12:52:21.179954613Z" level=info msg="StartContainer for \"453855f37c83c7b2e005b14a0b87a344ef3748c966703d5e1314d4a6e43dd270\"" Jul 23 12:52:21.302950 systemd[1]: Started cri-containerd-453855f37c83c7b2e005b14a0b87a344ef3748c966703d5e1314d4a6e43dd270.scope - libcontainer container 453855f37c83c7b2e005b14a0b87a344ef3748c966703d5e1314d4a6e43dd270. Jul 23 12:52:21.404029 containerd[1480]: time="2026-07-23T12:52:21.403863484Z" level=info msg="StartContainer for \"453855f37c83c7b2e005b14a0b87a344ef3748c966703d5e1314d4a6e43dd270\" returns successfully" Jul 23 12:52:21.457386 kubelet[1736]: E0723 12:52:21.457309 1736 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:21.499768 kubelet[1736]: E0723 12:52:21.499680 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:21.598890 systemd-networkd[1405]: veth20f5d969: Gained IPv6LL Jul 23 12:52:21.897708 kubelet[1736]: I0723 12:52:21.897376 1736 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=12.502365266 podStartE2EDuration="12.897325625s" podCreationTimestamp="2026-07-23 12:52:09 +0000 UTC" firstStartedPulling="2026-07-23 12:52:20.727461778 +0000 UTC m=+39.863844576" lastFinishedPulling="2026-07-23 12:52:21.122422132 +0000 UTC m=+40.258804935" observedRunningTime="2026-07-23 12:52:21.896974017 +0000 UTC m=+41.033356818" watchObservedRunningTime="2026-07-23 12:52:21.897325625 +0000 UTC m=+41.033708423" Jul 23 12:52:22.500418 kubelet[1736]: E0723 12:52:22.500329 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:23.500889 kubelet[1736]: E0723 12:52:23.500810 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:24.502258 kubelet[1736]: E0723 12:52:24.502000 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:25.502992 kubelet[1736]: E0723 12:52:25.502914 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:26.504044 kubelet[1736]: E0723 12:52:26.503776 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 23 12:52:27.562921 kubelet[1736]: E0723 12:52:27.561419 1736 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"