Sep 4 23:59:31.319113 kernel: Linux version 6.6.156-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Fri Sep 4 22:21:59 -00 2026 Sep 4 23:59:31.319134 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=9215c603110941002c0250d1c5b0629b89b2cc5fa29e7b45d5a5566f7e6b6ee1 Sep 4 23:59:31.319144 kernel: BIOS-provided physical RAM map: Sep 4 23:59:31.319149 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Sep 4 23:59:31.319154 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Sep 4 23:59:31.319159 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Sep 4 23:59:31.319166 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Sep 4 23:59:31.319171 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Sep 4 23:59:31.319176 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Sep 4 23:59:31.319181 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Sep 4 23:59:31.319186 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Sep 4 23:59:31.319193 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Sep 4 23:59:31.319197 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Sep 4 23:59:31.319201 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Sep 4 23:59:31.319207 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Sep 4 23:59:31.319212 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Sep 4 23:59:31.319218 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Sep 4 23:59:31.319222 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Sep 4 23:59:31.319227 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Sep 4 23:59:31.319231 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Sep 4 23:59:31.319236 kernel: NX (Execute Disable) protection: active Sep 4 23:59:31.319240 kernel: APIC: Static calls initialized Sep 4 23:59:31.319245 kernel: efi: EFI v2.7 by EDK II Sep 4 23:59:31.319249 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b675198 Sep 4 23:59:31.319254 kernel: SMBIOS 2.8 present. Sep 4 23:59:31.319258 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Sep 4 23:59:31.319263 kernel: Hypervisor detected: KVM Sep 4 23:59:31.319267 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 4 23:59:31.319273 kernel: kvm-clock: using sched offset of 5409497997 cycles Sep 4 23:59:31.319279 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 4 23:59:31.319283 kernel: tsc: Detected 2793.438 MHz processor Sep 4 23:59:31.319288 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 4 23:59:31.319293 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 4 23:59:31.319298 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x10000000000 Sep 4 23:59:31.319302 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Sep 4 23:59:31.319307 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 4 23:59:31.319313 kernel: Using GB pages for direct mapping Sep 4 23:59:31.319318 kernel: Secure boot disabled Sep 4 23:59:31.319323 kernel: ACPI: Early table checksum verification disabled Sep 4 23:59:31.319328 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Sep 4 23:59:31.319335 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Sep 4 23:59:31.319340 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319345 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319352 kernel: ACPI: FACS 0x000000009CBDD000 000040 Sep 4 23:59:31.319357 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319362 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319367 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319372 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 23:59:31.319377 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Sep 4 23:59:31.319382 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Sep 4 23:59:31.319388 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Sep 4 23:59:31.319393 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Sep 4 23:59:31.319398 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Sep 4 23:59:31.319402 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Sep 4 23:59:31.319407 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Sep 4 23:59:31.319412 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Sep 4 23:59:31.319417 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Sep 4 23:59:31.319422 kernel: No NUMA configuration found Sep 4 23:59:31.319427 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Sep 4 23:59:31.319432 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Sep 4 23:59:31.319438 kernel: Zone ranges: Sep 4 23:59:31.319443 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 4 23:59:31.319448 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Sep 4 23:59:31.319453 kernel: Normal empty Sep 4 23:59:31.319458 kernel: Movable zone start for each node Sep 4 23:59:31.319462 kernel: Early memory node ranges Sep 4 23:59:31.319467 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Sep 4 23:59:31.319472 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Sep 4 23:59:31.319482 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Sep 4 23:59:31.319493 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Sep 4 23:59:31.319503 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Sep 4 23:59:31.319513 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Sep 4 23:59:31.319524 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Sep 4 23:59:31.319534 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 4 23:59:31.319544 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Sep 4 23:59:31.319554 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Sep 4 23:59:31.319564 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 4 23:59:31.319575 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Sep 4 23:59:31.319585 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Sep 4 23:59:31.319598 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Sep 4 23:59:31.319608 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 4 23:59:31.319618 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 4 23:59:31.319629 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 4 23:59:31.319639 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 4 23:59:31.319815 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 4 23:59:31.319831 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 4 23:59:31.319842 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 4 23:59:31.319852 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 4 23:59:31.319865 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 4 23:59:31.319876 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 4 23:59:31.319886 kernel: TSC deadline timer available Sep 4 23:59:31.319896 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Sep 4 23:59:31.319907 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 4 23:59:31.319917 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 4 23:59:31.319927 kernel: kvm-guest: setup PV sched yield Sep 4 23:59:31.319937 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Sep 4 23:59:31.319948 kernel: Booting paravirtualized kernel on KVM Sep 4 23:59:31.319960 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 4 23:59:31.319971 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 4 23:59:31.319981 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u524288 Sep 4 23:59:31.319992 kernel: pcpu-alloc: s196392 r8192 d28888 u524288 alloc=1*2097152 Sep 4 23:59:31.320002 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 4 23:59:31.320012 kernel: kvm-guest: PV spinlocks enabled Sep 4 23:59:31.320023 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 4 23:59:31.320034 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=9215c603110941002c0250d1c5b0629b89b2cc5fa29e7b45d5a5566f7e6b6ee1 Sep 4 23:59:31.320047 kernel: random: crng init done Sep 4 23:59:31.320058 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 23:59:31.320068 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 23:59:31.320078 kernel: Fallback order for Node 0: 0 Sep 4 23:59:31.320089 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Sep 4 23:59:31.320099 kernel: Policy zone: DMA32 Sep 4 23:59:31.320109 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 23:59:31.320120 kernel: Memory: 2397612K/2567000K available (14336K kernel code, 2288K rwdata, 22772K rodata, 42920K init, 2236K bss, 169184K reserved, 0K cma-reserved) Sep 4 23:59:31.320130 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 4 23:59:31.320142 kernel: ftrace: allocating 37502 entries in 148 pages Sep 4 23:59:31.320153 kernel: ftrace: allocated 148 pages with 3 groups Sep 4 23:59:31.320163 kernel: Dynamic Preempt: voluntary Sep 4 23:59:31.320174 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 23:59:31.320193 kernel: rcu: RCU event tracing is enabled. Sep 4 23:59:31.320206 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 4 23:59:31.320217 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 23:59:31.320229 kernel: Rude variant of Tasks RCU enabled. Sep 4 23:59:31.320240 kernel: Tracing variant of Tasks RCU enabled. Sep 4 23:59:31.320250 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 23:59:31.320262 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 4 23:59:31.320273 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 4 23:59:31.320286 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 23:59:31.320297 kernel: Console: colour dummy device 80x25 Sep 4 23:59:31.320308 kernel: printk: console [ttyS0] enabled Sep 4 23:59:31.320319 kernel: ACPI: Core revision 20230628 Sep 4 23:59:31.320331 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 4 23:59:31.320343 kernel: APIC: Switch to symmetric I/O mode setup Sep 4 23:59:31.320354 kernel: x2apic enabled Sep 4 23:59:31.320365 kernel: APIC: Switched APIC routing to: physical x2apic Sep 4 23:59:31.320376 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Sep 4 23:59:31.320387 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Sep 4 23:59:31.320398 kernel: kvm-guest: setup PV IPIs Sep 4 23:59:31.320409 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 4 23:59:31.320420 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Sep 4 23:59:31.320431 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Sep 4 23:59:31.320445 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 4 23:59:31.320456 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Sep 4 23:59:31.320467 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Sep 4 23:59:31.320478 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 4 23:59:31.320489 kernel: Spectre V2 : Mitigation: Retpolines Sep 4 23:59:31.320500 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Sep 4 23:59:31.320511 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Sep 4 23:59:31.320522 kernel: RETBleed: Vulnerable Sep 4 23:59:31.320533 kernel: Speculative Store Bypass: Vulnerable Sep 4 23:59:31.320547 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Sep 4 23:59:31.320558 kernel: GDS: Unknown: Dependent on hypervisor status Sep 4 23:59:31.320569 kernel: active return thunk: its_return_thunk Sep 4 23:59:31.320580 kernel: ITS: Mitigation: Aligned branch/return thunks Sep 4 23:59:31.320591 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 4 23:59:31.320602 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 4 23:59:31.320614 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 4 23:59:31.320625 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Sep 4 23:59:31.320636 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Sep 4 23:59:31.320697 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Sep 4 23:59:31.320706 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 4 23:59:31.320713 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Sep 4 23:59:31.320718 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Sep 4 23:59:31.320724 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Sep 4 23:59:31.320729 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Sep 4 23:59:31.320735 kernel: Freeing SMP alternatives memory: 32K Sep 4 23:59:31.320740 kernel: pid_max: default: 32768 minimum: 301 Sep 4 23:59:31.320746 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 4 23:59:31.320753 kernel: landlock: Up and running. Sep 4 23:59:31.320759 kernel: SELinux: Initializing. Sep 4 23:59:31.320764 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:59:31.320770 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:59:31.320775 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Sep 4 23:59:31.320781 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 23:59:31.320786 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 23:59:31.320792 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 4 23:59:31.320799 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Sep 4 23:59:31.320804 kernel: signal: max sigframe size: 3632 Sep 4 23:59:31.320810 kernel: rcu: Hierarchical SRCU implementation. Sep 4 23:59:31.320816 kernel: rcu: Max phase no-delay instances is 400. Sep 4 23:59:31.320821 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Sep 4 23:59:31.320827 kernel: smp: Bringing up secondary CPUs ... Sep 4 23:59:31.320832 kernel: smpboot: x86: Booting SMP configuration: Sep 4 23:59:31.320838 kernel: .... node #0, CPUs: #1 #2 #3 Sep 4 23:59:31.320843 kernel: smp: Brought up 1 node, 4 CPUs Sep 4 23:59:31.320850 kernel: smpboot: Max logical packages: 1 Sep 4 23:59:31.320855 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Sep 4 23:59:31.320861 kernel: devtmpfs: initialized Sep 4 23:59:31.320866 kernel: x86/mm: Memory block size: 128MB Sep 4 23:59:31.320872 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Sep 4 23:59:31.320877 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Sep 4 23:59:31.320883 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Sep 4 23:59:31.320889 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Sep 4 23:59:31.320894 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Sep 4 23:59:31.320901 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 23:59:31.320907 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 4 23:59:31.320912 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 23:59:31.320918 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 23:59:31.320923 kernel: audit: initializing netlink subsys (disabled) Sep 4 23:59:31.320929 kernel: audit: type=2000 audit(1788566370.136:1): state=initialized audit_enabled=0 res=1 Sep 4 23:59:31.320934 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 23:59:31.320940 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 4 23:59:31.320946 kernel: cpuidle: using governor menu Sep 4 23:59:31.320952 kernel: efi: Freeing EFI boot services memory: 29232K Sep 4 23:59:31.320958 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 23:59:31.320963 kernel: dca service started, version 1.12.1 Sep 4 23:59:31.320969 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Sep 4 23:59:31.320974 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Sep 4 23:59:31.320980 kernel: PCI: Using configuration type 1 for base access Sep 4 23:59:31.320986 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 4 23:59:31.320991 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 23:59:31.320997 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 23:59:31.321004 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 23:59:31.321009 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 23:59:31.321014 kernel: ACPI: Added _OSI(Module Device) Sep 4 23:59:31.321020 kernel: ACPI: Added _OSI(Processor Device) Sep 4 23:59:31.321025 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 23:59:31.321031 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 23:59:31.321036 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Sep 4 23:59:31.321042 kernel: ACPI: Interpreter enabled Sep 4 23:59:31.321047 kernel: ACPI: PM: (supports S0 S3 S5) Sep 4 23:59:31.321054 kernel: ACPI: Using IOAPIC for interrupt routing Sep 4 23:59:31.321060 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 4 23:59:31.321065 kernel: PCI: Using E820 reservations for host bridge windows Sep 4 23:59:31.321071 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Sep 4 23:59:31.321076 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 4 23:59:31.321201 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 23:59:31.321267 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Sep 4 23:59:31.321322 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Sep 4 23:59:31.321331 kernel: PCI host bridge to bus 0000:00 Sep 4 23:59:31.321395 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 4 23:59:31.321446 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 4 23:59:31.321496 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 4 23:59:31.321545 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Sep 4 23:59:31.321594 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Sep 4 23:59:31.321643 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Sep 4 23:59:31.321752 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 4 23:59:31.321822 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Sep 4 23:59:31.321884 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Sep 4 23:59:31.321941 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Sep 4 23:59:31.321997 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Sep 4 23:59:31.322068 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Sep 4 23:59:31.322163 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Sep 4 23:59:31.322256 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 4 23:59:31.322355 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Sep 4 23:59:31.322450 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Sep 4 23:59:31.322543 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Sep 4 23:59:31.322637 kernel: pci 0000:00:02.0: BAR 4 [mem 0x800000000-0x800003fff 64bit pref] Sep 4 23:59:31.322924 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Sep 4 23:59:31.323023 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Sep 4 23:59:31.323112 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Sep 4 23:59:31.323201 kernel: pci 0000:00:03.0: BAR 4 [mem 0x800004000-0x800007fff 64bit pref] Sep 4 23:59:31.323300 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Sep 4 23:59:31.323390 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Sep 4 23:59:31.323481 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Sep 4 23:59:31.323575 kernel: pci 0000:00:04.0: BAR 4 [mem 0x800008000-0x80000bfff 64bit pref] Sep 4 23:59:31.323712 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Sep 4 23:59:31.323812 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Sep 4 23:59:31.323903 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Sep 4 23:59:31.324002 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Sep 4 23:59:31.324095 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Sep 4 23:59:31.324187 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Sep 4 23:59:31.324293 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Sep 4 23:59:31.324383 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Sep 4 23:59:31.324398 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 4 23:59:31.324409 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 4 23:59:31.324421 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 4 23:59:31.324433 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 4 23:59:31.324444 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Sep 4 23:59:31.324455 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Sep 4 23:59:31.324469 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Sep 4 23:59:31.324480 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Sep 4 23:59:31.324491 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Sep 4 23:59:31.324502 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Sep 4 23:59:31.324514 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Sep 4 23:59:31.324525 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Sep 4 23:59:31.324536 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Sep 4 23:59:31.324548 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Sep 4 23:59:31.324559 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Sep 4 23:59:31.324572 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Sep 4 23:59:31.324584 kernel: iommu: Default domain type: Translated Sep 4 23:59:31.324595 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 4 23:59:31.324606 kernel: efivars: Registered efivars operations Sep 4 23:59:31.324617 kernel: PCI: Using ACPI for IRQ routing Sep 4 23:59:31.324628 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 4 23:59:31.324639 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Sep 4 23:59:31.324804 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Sep 4 23:59:31.324820 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Sep 4 23:59:31.324836 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Sep 4 23:59:31.324943 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Sep 4 23:59:31.325033 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Sep 4 23:59:31.325125 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 4 23:59:31.325138 kernel: vgaarb: loaded Sep 4 23:59:31.325151 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 4 23:59:31.325162 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 4 23:59:31.325174 kernel: clocksource: Switched to clocksource kvm-clock Sep 4 23:59:31.325185 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 23:59:31.325200 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 23:59:31.325211 kernel: pnp: PnP ACPI init Sep 4 23:59:31.325307 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Sep 4 23:59:31.325322 kernel: pnp: PnP ACPI: found 6 devices Sep 4 23:59:31.325333 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 4 23:59:31.325344 kernel: NET: Registered PF_INET protocol family Sep 4 23:59:31.325355 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 23:59:31.325367 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 23:59:31.325380 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 23:59:31.325392 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 23:59:31.325403 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 23:59:31.325414 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 23:59:31.325426 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:59:31.325437 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:59:31.325448 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 23:59:31.325459 kernel: NET: Registered PF_XDP protocol family Sep 4 23:59:31.325552 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Sep 4 23:59:31.325711 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Sep 4 23:59:31.325811 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 4 23:59:31.325894 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 4 23:59:31.325980 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 4 23:59:31.326061 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Sep 4 23:59:31.326141 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Sep 4 23:59:31.326192 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Sep 4 23:59:31.326199 kernel: PCI: CLS 0 bytes, default 64 Sep 4 23:59:31.326208 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Sep 4 23:59:31.326214 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Sep 4 23:59:31.326220 kernel: Initialise system trusted keyrings Sep 4 23:59:31.326225 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 23:59:31.326231 kernel: Key type asymmetric registered Sep 4 23:59:31.326236 kernel: Asymmetric key parser 'x509' registered Sep 4 23:59:31.326242 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Sep 4 23:59:31.326248 kernel: io scheduler mq-deadline registered Sep 4 23:59:31.326254 kernel: io scheduler kyber registered Sep 4 23:59:31.326262 kernel: io scheduler bfq registered Sep 4 23:59:31.326267 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 4 23:59:31.326274 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Sep 4 23:59:31.326279 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Sep 4 23:59:31.326285 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Sep 4 23:59:31.326291 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 23:59:31.326297 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 4 23:59:31.326302 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 4 23:59:31.326308 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 4 23:59:31.326316 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 4 23:59:31.326376 kernel: rtc_cmos 00:04: RTC can wake from S4 Sep 4 23:59:31.326442 kernel: rtc_cmos 00:04: registered as rtc0 Sep 4 23:59:31.326458 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 4 23:59:31.326543 kernel: rtc_cmos 00:04: setting system clock to 2026-09-04T23:59:30 UTC (1788566370) Sep 4 23:59:31.326629 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Sep 4 23:59:31.326642 kernel: intel_pstate: CPU model not supported Sep 4 23:59:31.326697 kernel: efifb: probing for efifb Sep 4 23:59:31.326711 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Sep 4 23:59:31.326722 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Sep 4 23:59:31.326733 kernel: efifb: scrolling: redraw Sep 4 23:59:31.326744 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Sep 4 23:59:31.326756 kernel: Console: switching to colour frame buffer device 100x37 Sep 4 23:59:31.326785 kernel: fb0: EFI VGA frame buffer device Sep 4 23:59:31.326799 kernel: pstore: Using crash dump compression: deflate Sep 4 23:59:31.326810 kernel: pstore: Registered efi_pstore as persistent store backend Sep 4 23:59:31.326821 kernel: NET: Registered PF_INET6 protocol family Sep 4 23:59:31.326835 kernel: Segment Routing with IPv6 Sep 4 23:59:31.326846 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 23:59:31.326858 kernel: NET: Registered PF_PACKET protocol family Sep 4 23:59:31.326870 kernel: Key type dns_resolver registered Sep 4 23:59:31.326881 kernel: IPI shorthand broadcast: enabled Sep 4 23:59:31.326893 kernel: sched_clock: Marking stable (1087011066, 265552277)->(1487714324, -135150981) Sep 4 23:59:31.326905 kernel: registered taskstats version 1 Sep 4 23:59:31.326916 kernel: Loading compiled-in X.509 certificates Sep 4 23:59:31.326928 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.156-flatcar: b30541ee20a7c2326c701c18741253f662a6172a' Sep 4 23:59:31.326942 kernel: Key type .fscrypt registered Sep 4 23:59:31.326953 kernel: Key type fscrypt-provisioning registered Sep 4 23:59:31.326965 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 23:59:31.326976 kernel: ima: Allocated hash algorithm: sha1 Sep 4 23:59:31.326988 kernel: ima: No architecture policies found Sep 4 23:59:31.326999 kernel: clk: Disabling unused clocks Sep 4 23:59:31.327011 kernel: Freeing unused kernel image (initmem) memory: 42920K Sep 4 23:59:31.327022 kernel: Write protecting the kernel read-only data: 38912k Sep 4 23:59:31.327033 kernel: Freeing unused kernel image (rodata/data gap) memory: 1804K Sep 4 23:59:31.327047 kernel: Run /init as init process Sep 4 23:59:31.327059 kernel: with arguments: Sep 4 23:59:31.327072 kernel: /init Sep 4 23:59:31.327083 kernel: with environment: Sep 4 23:59:31.327095 kernel: HOME=/ Sep 4 23:59:31.327106 kernel: TERM=linux Sep 4 23:59:31.327124 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) Sep 4 23:59:31.327139 systemd[1]: Detected virtualization kvm. Sep 4 23:59:31.327153 systemd[1]: Detected architecture x86-64. Sep 4 23:59:31.327164 systemd[1]: Running in initrd. Sep 4 23:59:31.327176 systemd[1]: No hostname configured, using default hostname. Sep 4 23:59:31.327188 systemd[1]: Hostname set to . Sep 4 23:59:31.327203 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:59:31.327215 systemd[1]: Queued start job for default target initrd.target. Sep 4 23:59:31.327227 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:59:31.327239 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:59:31.327252 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 23:59:31.327265 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:59:31.327277 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 23:59:31.327290 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 23:59:31.327306 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 23:59:31.327317 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 23:59:31.327327 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:59:31.327333 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:59:31.327339 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:59:31.327347 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:59:31.327353 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:59:31.327359 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:59:31.327366 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:59:31.327372 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:59:31.327378 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 23:59:31.327385 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 23:59:31.327391 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:59:31.327397 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:59:31.327403 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:59:31.327410 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:59:31.327418 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 23:59:31.327424 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:59:31.327430 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 23:59:31.327436 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 23:59:31.327442 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:59:31.327448 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:59:31.327454 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:31.327461 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 23:59:31.327467 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:59:31.327475 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 23:59:31.327501 systemd-journald[193]: Collecting audit messages is disabled. Sep 4 23:59:31.327518 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 23:59:31.327526 systemd-journald[193]: Journal started Sep 4 23:59:31.327541 systemd-journald[193]: Runtime Journal (/run/log/journal/7879c97c89a247e7a8a6501b7b386d80) is 6.0M, max 48.2M, 42.2M free. Sep 4 23:59:31.331999 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:59:31.339880 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:59:31.349379 systemd-modules-load[194]: Inserted module 'overlay' Sep 4 23:59:31.349432 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:31.355132 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:59:31.358320 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:59:31.374249 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:59:31.377640 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:59:31.393992 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:59:31.400071 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:59:31.406299 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 23:59:31.414474 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 23:59:31.416351 systemd-modules-load[194]: Inserted module 'br_netfilter' Sep 4 23:59:31.418807 kernel: Bridge firewalling registered Sep 4 23:59:31.417154 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:59:31.420579 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:59:31.431111 dracut-cmdline[223]: dracut-dracut-053 Sep 4 23:59:31.436475 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=9215c603110941002c0250d1c5b0629b89b2cc5fa29e7b45d5a5566f7e6b6ee1 Sep 4 23:59:31.436318 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:59:31.454315 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:59:31.489982 systemd-resolved[241]: Positive Trust Anchors: Sep 4 23:59:31.490142 systemd-resolved[241]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:59:31.490178 systemd-resolved[241]: 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 Sep 4 23:59:31.493750 systemd-resolved[241]: Defaulting to hostname 'linux'. Sep 4 23:59:31.494975 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:59:31.495472 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:59:31.674934 kernel: SCSI subsystem initialized Sep 4 23:59:31.690792 kernel: Loading iSCSI transport class v2.0-870. Sep 4 23:59:31.721783 kernel: iscsi: registered transport (tcp) Sep 4 23:59:31.754460 kernel: iscsi: registered transport (qla4xxx) Sep 4 23:59:31.754557 kernel: QLogic iSCSI HBA Driver Sep 4 23:59:31.851289 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 23:59:31.860196 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 23:59:31.897537 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 23:59:31.897638 kernel: device-mapper: uevent: version 1.0.3 Sep 4 23:59:31.897681 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 23:59:31.982159 kernel: raid6: avx512x4 gen() 32578 MB/s Sep 4 23:59:31.999822 kernel: raid6: avx512x2 gen() 31606 MB/s Sep 4 23:59:32.016752 kernel: raid6: avx512x1 gen() 34473 MB/s Sep 4 23:59:32.034958 kernel: raid6: avx2x4 gen() 34712 MB/s Sep 4 23:59:32.052781 kernel: raid6: avx2x2 gen() 28497 MB/s Sep 4 23:59:32.071068 kernel: raid6: avx2x1 gen() 19886 MB/s Sep 4 23:59:32.071154 kernel: raid6: using algorithm avx2x4 gen() 34712 MB/s Sep 4 23:59:32.090217 kernel: raid6: .... xor() 7509 MB/s, rmw enabled Sep 4 23:59:32.090306 kernel: raid6: using avx512x2 recovery algorithm Sep 4 23:59:32.155869 kernel: xor: automatically using best checksumming function avx Sep 4 23:59:32.358755 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 23:59:32.373292 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:59:32.384986 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:59:32.400596 systemd-udevd[414]: Using default interface naming scheme 'v255'. Sep 4 23:59:32.405406 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:59:32.418017 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 23:59:32.436446 dracut-pre-trigger[424]: rd.md=0: removing MD RAID activation Sep 4 23:59:32.476116 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:59:32.497977 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:59:32.578720 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:59:32.589899 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 23:59:32.605959 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 23:59:32.610306 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:59:32.615782 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:59:32.618608 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:59:32.634060 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 23:59:32.639446 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Sep 4 23:59:32.645699 kernel: cryptd: max_cpu_qlen set to 1000 Sep 4 23:59:32.644264 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:59:32.644346 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:59:32.647746 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:59:32.652673 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Sep 4 23:59:32.657177 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:59:32.659521 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:32.669930 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 4 23:59:32.670007 kernel: GPT:9289727 != 19775487 Sep 4 23:59:32.670032 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 4 23:59:32.670045 kernel: GPT:9289727 != 19775487 Sep 4 23:59:32.670057 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 4 23:59:32.670070 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 23:59:32.670357 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:32.677827 kernel: libata version 3.00 loaded. Sep 4 23:59:32.683358 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:32.687784 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:59:32.704633 kernel: ahci 0000:00:1f.2: version 3.0 Sep 4 23:59:32.705044 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Sep 4 23:59:32.705055 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Sep 4 23:59:32.705131 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Sep 4 23:59:32.705199 kernel: AVX2 version of gcm_enc/dec engaged. Sep 4 23:59:32.705207 kernel: AES CTR mode by8 optimization enabled Sep 4 23:59:32.722872 kernel: scsi host0: ahci Sep 4 23:59:32.723317 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:59:32.750152 kernel: scsi host1: ahci Sep 4 23:59:32.752962 kernel: scsi host2: ahci Sep 4 23:59:32.753047 kernel: scsi host3: ahci Sep 4 23:59:32.723456 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:32.757035 kernel: scsi host4: ahci Sep 4 23:59:32.757150 kernel: scsi host5: ahci Sep 4 23:59:32.757227 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 31 Sep 4 23:59:32.760920 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 31 Sep 4 23:59:32.760955 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 31 Sep 4 23:59:32.760963 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 31 Sep 4 23:59:32.760971 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 31 Sep 4 23:59:32.760978 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 31 Sep 4 23:59:32.761006 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:32.770996 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (473) Sep 4 23:59:32.778108 kernel: BTRFS: device fsid 7334055a-467a-40fa-9177-3daf8468e49a devid 1 transid 31 /dev/vda3 scanned by (udev-worker) (468) Sep 4 23:59:32.779844 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 4 23:59:32.785488 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 4 23:59:32.794099 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 23:59:32.795329 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:32.803007 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 4 23:59:32.804043 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 4 23:59:32.833057 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 23:59:32.835394 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:59:32.842935 disk-uuid[566]: Primary Header is updated. Sep 4 23:59:32.842935 disk-uuid[566]: Secondary Entries is updated. Sep 4 23:59:32.842935 disk-uuid[566]: Secondary Header is updated. Sep 4 23:59:32.848289 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 23:59:32.850799 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 23:59:32.851711 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:59:32.857726 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 23:59:33.067739 kernel: ata2: SATA link down (SStatus 0 SControl 300) Sep 4 23:59:33.067840 kernel: ata1: SATA link down (SStatus 0 SControl 300) Sep 4 23:59:33.076738 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Sep 4 23:59:33.076833 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 4 23:59:33.076847 kernel: ata3.00: applying bridge limits Sep 4 23:59:33.077697 kernel: ata5: SATA link down (SStatus 0 SControl 300) Sep 4 23:59:33.080745 kernel: ata4: SATA link down (SStatus 0 SControl 300) Sep 4 23:59:33.080794 kernel: ata6: SATA link down (SStatus 0 SControl 300) Sep 4 23:59:33.081728 kernel: ata3.00: configured for UDMA/100 Sep 4 23:59:33.084675 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 4 23:59:33.135764 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 4 23:59:33.162823 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 4 23:59:33.174726 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Sep 4 23:59:33.855727 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 23:59:33.855777 disk-uuid[568]: The operation has completed successfully. Sep 4 23:59:33.882126 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 23:59:33.882224 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 23:59:33.900881 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 23:59:33.904872 sh[604]: Success Sep 4 23:59:33.916747 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Sep 4 23:59:33.948390 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 23:59:33.962945 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 23:59:33.965310 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 23:59:33.973675 kernel: BTRFS info (device dm-0): first mount of filesystem 7334055a-467a-40fa-9177-3daf8468e49a Sep 4 23:59:33.973717 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 4 23:59:33.976625 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 23:59:33.976666 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 23:59:33.979049 kernel: BTRFS info (device dm-0): using free space tree Sep 4 23:59:33.983143 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 23:59:33.984713 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 23:59:33.994949 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 23:59:33.996629 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 23:59:34.005999 kernel: BTRFS info (device vda6): first mount of filesystem 40ce7b63-c029-41bb-9ac2-b503fd73bd4d Sep 4 23:59:34.006029 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 23:59:34.006037 kernel: BTRFS info (device vda6): using free space tree Sep 4 23:59:34.008677 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 23:59:34.015637 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 4 23:59:34.017906 kernel: BTRFS info (device vda6): last unmount of filesystem 40ce7b63-c029-41bb-9ac2-b503fd73bd4d Sep 4 23:59:34.023715 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 23:59:34.029810 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 23:59:34.069631 ignition[704]: Ignition 2.19.0 Sep 4 23:59:34.069719 ignition[704]: Stage: fetch-offline Sep 4 23:59:34.069763 ignition[704]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:34.069777 ignition[704]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:34.069846 ignition[704]: parsed url from cmdline: "" Sep 4 23:59:34.069849 ignition[704]: no config URL provided Sep 4 23:59:34.069852 ignition[704]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 23:59:34.069857 ignition[704]: no config at "/usr/lib/ignition/user.ign" Sep 4 23:59:34.069878 ignition[704]: op(1): [started] loading QEMU firmware config module Sep 4 23:59:34.069881 ignition[704]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 4 23:59:34.077838 ignition[704]: op(1): [finished] loading QEMU firmware config module Sep 4 23:59:34.077851 ignition[704]: QEMU firmware config was not found. Ignoring... Sep 4 23:59:34.080913 unknown[704]: fetched base config from "system" Sep 4 23:59:34.078881 ignition[704]: parsing config with SHA512: 52e3ae822fc198b970fc29110cde62cee5253926828dc8ad63cf761ee99a6f08a8007e420541cd2be4979a7babe0d945f4a6b7c6e501e9ddaac6bba785c1de65 Sep 4 23:59:34.080920 unknown[704]: fetched user config from "qemu" Sep 4 23:59:34.081122 ignition[704]: fetch-offline: fetch-offline passed Sep 4 23:59:34.082440 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:59:34.081167 ignition[704]: Ignition finished successfully Sep 4 23:59:34.087401 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:59:34.101008 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:59:34.117105 systemd-networkd[794]: lo: Link UP Sep 4 23:59:34.117123 systemd-networkd[794]: lo: Gained carrier Sep 4 23:59:34.118036 systemd-networkd[794]: Enumeration completed Sep 4 23:59:34.118128 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:59:34.118544 systemd-networkd[794]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:59:34.118547 systemd-networkd[794]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:59:34.119169 systemd-networkd[794]: eth0: Link UP Sep 4 23:59:34.119172 systemd-networkd[794]: eth0: Gained carrier Sep 4 23:59:34.119177 systemd-networkd[794]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:59:34.120263 systemd[1]: Reached target network.target - Network. Sep 4 23:59:34.122768 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 4 23:59:34.133993 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 23:59:34.139748 systemd-networkd[794]: eth0: DHCPv4 address 10.0.0.32/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 23:59:34.145777 ignition[798]: Ignition 2.19.0 Sep 4 23:59:34.145792 ignition[798]: Stage: kargs Sep 4 23:59:34.145927 ignition[798]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:34.145934 ignition[798]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:34.146405 ignition[798]: kargs: kargs passed Sep 4 23:59:34.146430 ignition[798]: Ignition finished successfully Sep 4 23:59:34.153394 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 23:59:34.160863 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 23:59:34.172544 ignition[807]: Ignition 2.19.0 Sep 4 23:59:34.172560 ignition[807]: Stage: disks Sep 4 23:59:34.172771 ignition[807]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:34.172778 ignition[807]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:34.173233 ignition[807]: disks: disks passed Sep 4 23:59:34.175995 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 23:59:34.173263 ignition[807]: Ignition finished successfully Sep 4 23:59:34.176365 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 23:59:34.179012 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 23:59:34.181405 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:59:34.183962 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:59:34.186236 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:59:34.197911 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 23:59:34.206177 systemd-fsck[817]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 4 23:59:34.209463 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 23:59:34.211999 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 23:59:34.290413 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 23:59:34.292451 kernel: EXT4-fs (vda9): mounted filesystem 8c18da49-3eb0-4eeb-934e-6ac91f8051aa r/w with ordered data mode. Quota mode: none. Sep 4 23:59:34.291366 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 23:59:34.304818 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:59:34.307012 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 23:59:34.310751 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 23:59:34.310786 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 23:59:34.310803 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:59:34.361210 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (825) Sep 4 23:59:34.318586 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 23:59:34.360502 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 23:59:34.368839 kernel: BTRFS info (device vda6): first mount of filesystem 40ce7b63-c029-41bb-9ac2-b503fd73bd4d Sep 4 23:59:34.368861 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 23:59:34.368870 kernel: BTRFS info (device vda6): using free space tree Sep 4 23:59:34.372722 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 23:59:34.373813 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:59:34.398291 initrd-setup-root[849]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 23:59:34.403429 initrd-setup-root[856]: cut: /sysroot/etc/group: No such file or directory Sep 4 23:59:34.406826 initrd-setup-root[863]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 23:59:34.411212 initrd-setup-root[870]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 23:59:34.477218 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 23:59:34.497857 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 23:59:34.499042 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 23:59:34.509723 kernel: BTRFS info (device vda6): last unmount of filesystem 40ce7b63-c029-41bb-9ac2-b503fd73bd4d Sep 4 23:59:34.519589 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 23:59:34.530046 ignition[938]: INFO : Ignition 2.19.0 Sep 4 23:59:34.530046 ignition[938]: INFO : Stage: mount Sep 4 23:59:34.532065 ignition[938]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:34.532065 ignition[938]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:34.532065 ignition[938]: INFO : mount: mount passed Sep 4 23:59:34.532065 ignition[938]: INFO : Ignition finished successfully Sep 4 23:59:34.537730 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 23:59:34.546895 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 23:59:34.973496 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 23:59:34.984956 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:59:34.992690 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (952) Sep 4 23:59:34.995388 kernel: BTRFS info (device vda6): first mount of filesystem 40ce7b63-c029-41bb-9ac2-b503fd73bd4d Sep 4 23:59:34.995412 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 23:59:34.995428 kernel: BTRFS info (device vda6): using free space tree Sep 4 23:59:34.999905 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 23:59:35.000494 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:59:35.027084 ignition[969]: INFO : Ignition 2.19.0 Sep 4 23:59:35.027084 ignition[969]: INFO : Stage: files Sep 4 23:59:35.029281 ignition[969]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:35.029281 ignition[969]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:35.029281 ignition[969]: DEBUG : files: compiled without relabeling support, skipping Sep 4 23:59:35.029281 ignition[969]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 23:59:35.029281 ignition[969]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 23:59:35.037933 ignition[969]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 23:59:35.037933 ignition[969]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 23:59:35.037933 ignition[969]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Sep 4 23:59:35.037933 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.36.1-x86-64.raw: attempt #1 Sep 4 23:59:35.031354 unknown[969]: wrote ssh authorized keys file for user: core Sep 4 23:59:35.323026 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Sep 4 23:59:35.482533 ignition[969]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Sep 4 23:59:35.482533 ignition[969]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Sep 4 23:59:35.487734 ignition[969]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 23:59:35.487734 ignition[969]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 23:59:35.487734 ignition[969]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Sep 4 23:59:35.487734 ignition[969]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Sep 4 23:59:35.500854 ignition[969]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 23:59:35.504199 ignition[969]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 23:59:35.506269 ignition[969]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Sep 4 23:59:35.506269 ignition[969]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:59:35.506269 ignition[969]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:59:35.506269 ignition[969]: INFO : files: files passed Sep 4 23:59:35.506269 ignition[969]: INFO : Ignition finished successfully Sep 4 23:59:35.505787 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 23:59:35.519908 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 23:59:35.521950 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 23:59:35.524182 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 23:59:35.524243 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 23:59:35.531029 initrd-setup-root-after-ignition[997]: grep: /sysroot/oem/oem-release: No such file or directory Sep 4 23:59:35.535107 initrd-setup-root-after-ignition[999]: grep: Sep 4 23:59:35.536173 initrd-setup-root-after-ignition[1003]: grep: /sysroot/etc/flatcar/enabled-sysext.conf Sep 4 23:59:35.537914 initrd-setup-root-after-ignition[999]: /sysroot/etc/flatcar/enabled-sysext.conf Sep 4 23:59:35.539623 initrd-setup-root-after-ignition[1003]: : No such file or directory Sep 4 23:59:35.541338 initrd-setup-root-after-ignition[999]: : No such file or directory Sep 4 23:59:35.543028 initrd-setup-root-after-ignition[999]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:59:35.546446 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:59:35.548871 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 23:59:35.562893 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 23:59:35.582464 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 23:59:35.582587 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 23:59:35.585591 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 23:59:35.591313 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 23:59:35.592017 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 23:59:35.601814 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 23:59:35.616178 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:59:35.618358 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 23:59:35.632592 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:59:35.636337 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:59:35.637248 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 23:59:35.640096 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 23:59:35.640192 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:59:35.645530 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 23:59:35.646121 systemd[1]: Stopped target basic.target - Basic System. Sep 4 23:59:35.649064 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 23:59:35.651447 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:59:35.654863 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 23:59:35.655476 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 23:59:35.660157 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:59:35.663188 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 23:59:35.667797 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 23:59:35.671062 systemd[1]: Stopped target swap.target - Swaps. Sep 4 23:59:35.673381 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 23:59:35.673475 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:59:35.676333 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:59:35.679726 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:59:35.683411 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 23:59:35.683525 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:59:35.686997 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 23:59:35.687095 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 23:59:35.690412 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 23:59:35.690504 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:59:35.693796 systemd[1]: Stopped target paths.target - Path Units. Sep 4 23:59:35.696259 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 23:59:35.702820 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:59:35.704445 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 23:59:35.706970 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 23:59:35.708979 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 23:59:35.709067 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:59:35.711088 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 23:59:35.711179 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:59:35.713128 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 23:59:35.713223 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:59:35.715165 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 23:59:35.715240 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 23:59:35.736481 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 23:59:35.738806 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 23:59:35.741556 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 23:59:35.741751 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:59:35.744026 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 23:59:35.744113 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:59:35.750589 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 23:59:35.757917 ignition[1023]: INFO : Ignition 2.19.0 Sep 4 23:59:35.757917 ignition[1023]: INFO : Stage: umount Sep 4 23:59:35.757917 ignition[1023]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:59:35.757917 ignition[1023]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 23:59:35.757917 ignition[1023]: INFO : umount: umount passed Sep 4 23:59:35.757917 ignition[1023]: INFO : Ignition finished successfully Sep 4 23:59:35.750738 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 23:59:35.757568 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 23:59:35.757713 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 23:59:35.758781 systemd[1]: Stopped target network.target - Network. Sep 4 23:59:35.758933 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 23:59:35.758977 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 23:59:35.761744 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 23:59:35.761776 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 23:59:35.764787 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 23:59:35.764823 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 23:59:35.768031 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 23:59:35.768067 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 23:59:35.773144 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 23:59:35.775206 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 23:59:35.779471 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 23:59:35.784797 systemd-networkd[794]: eth0: DHCPv6 lease lost Sep 4 23:59:35.787605 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 23:59:35.787763 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 23:59:35.789722 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 23:59:35.789756 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:59:35.805994 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 23:59:35.806292 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 23:59:35.806333 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:59:35.808816 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:59:35.845023 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 23:59:35.845105 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 23:59:35.848444 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 23:59:35.848509 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 23:59:35.849609 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 23:59:35.849712 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 23:59:35.857026 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 23:59:35.857063 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:59:35.857945 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 23:59:35.857975 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 23:59:35.861085 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 23:59:35.861114 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:59:35.864082 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 23:59:35.864141 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 23:59:35.878954 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 23:59:35.880203 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:59:35.883163 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 23:59:35.883232 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 23:59:35.883900 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 23:59:35.883921 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:59:35.887151 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 23:59:35.887183 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:59:35.891408 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 23:59:35.891448 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 23:59:35.893613 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:59:35.893737 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:59:35.905872 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 23:59:35.906388 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 23:59:35.906434 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:59:35.909065 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 23:59:35.909098 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:59:35.911733 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 23:59:35.911768 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:59:35.916810 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:59:35.916858 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:35.920012 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 23:59:35.920089 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 23:59:35.923511 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 23:59:35.924780 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 23:59:35.935960 systemd[1]: Switching root. Sep 4 23:59:35.957063 systemd-journald[193]: Journal stopped Sep 4 23:59:36.694492 systemd-journald[193]: Received SIGTERM from PID 1 (systemd). Sep 4 23:59:36.694535 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 23:59:36.694551 kernel: SELinux: policy capability open_perms=1 Sep 4 23:59:36.694562 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 23:59:36.694574 kernel: SELinux: policy capability always_check_network=0 Sep 4 23:59:36.694582 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 23:59:36.694589 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 23:59:36.694596 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 23:59:36.694604 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 23:59:36.694611 kernel: audit: type=1403 audit(1788566376.064:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 23:59:36.694624 systemd[1]: Successfully loaded SELinux policy in 30.581ms. Sep 4 23:59:36.694639 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.793ms. Sep 4 23:59:36.694682 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) Sep 4 23:59:36.694694 systemd[1]: Detected virtualization kvm. Sep 4 23:59:36.694727 systemd[1]: Detected architecture x86-64. Sep 4 23:59:36.694740 systemd[1]: Detected first boot. Sep 4 23:59:36.694758 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:59:36.694769 zram_generator::config[1068]: No configuration found. Sep 4 23:59:36.694779 systemd[1]: Populated /etc with preset unit settings. Sep 4 23:59:36.694788 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 23:59:36.694795 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 23:59:36.694804 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 23:59:36.694811 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 23:59:36.694819 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 23:59:36.694829 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 23:59:36.694836 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 23:59:36.694844 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 23:59:36.694851 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 23:59:36.694859 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 23:59:36.694868 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 23:59:36.694876 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:59:36.694884 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:59:36.694892 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 23:59:36.694902 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 23:59:36.694909 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 23:59:36.694917 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:59:36.694924 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 23:59:36.694932 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:59:36.694940 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 23:59:36.694948 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 23:59:36.694957 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 23:59:36.694966 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 23:59:36.694974 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:59:36.694982 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:59:36.694990 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:59:36.694997 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:59:36.695004 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 23:59:36.695011 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 23:59:36.695019 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:59:36.695026 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:59:36.695035 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:59:36.695043 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 23:59:36.695050 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 23:59:36.695058 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 23:59:36.695065 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 23:59:36.695073 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:36.695081 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 23:59:36.695088 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 23:59:36.695095 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 23:59:36.695105 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). Sep 4 23:59:36.695113 systemd[1]: Reached target machines.target - Containers. Sep 4 23:59:36.695122 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 23:59:36.695130 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:59:36.695137 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:59:36.695145 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 23:59:36.695152 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:59:36.695160 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:59:36.695169 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:59:36.695176 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 23:59:36.695183 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:59:36.695191 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 23:59:36.695199 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 23:59:36.695206 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 23:59:36.695213 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 23:59:36.695221 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 23:59:36.695228 kernel: fuse: init (API version 7.39) Sep 4 23:59:36.695237 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:59:36.695245 kernel: ACPI: bus type drm_connector registered Sep 4 23:59:36.695252 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:59:36.695259 kernel: loop: module loaded Sep 4 23:59:36.695266 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 23:59:36.695274 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 23:59:36.695282 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:59:36.695304 systemd-journald[1142]: Collecting audit messages is disabled. Sep 4 23:59:36.695322 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 23:59:36.695330 systemd-journald[1142]: Journal started Sep 4 23:59:36.695346 systemd-journald[1142]: Runtime Journal (/run/log/journal/7879c97c89a247e7a8a6501b7b386d80) is 6.0M, max 48.2M, 42.2M free. Sep 4 23:59:36.448193 systemd[1]: Queued start job for default target multi-user.target. Sep 4 23:59:36.466945 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 4 23:59:36.467292 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 23:59:36.697037 systemd[1]: Stopped verity-setup.service. Sep 4 23:59:36.701696 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:36.704845 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:59:36.705821 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 23:59:36.707288 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 23:59:36.708856 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 23:59:36.710310 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 23:59:36.711789 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 23:59:36.713341 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 23:59:36.714999 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 23:59:36.717132 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:59:36.719035 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 23:59:36.719220 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 23:59:36.721063 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:59:36.721231 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:59:36.723109 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:59:36.723271 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:59:36.724885 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:59:36.725176 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:59:36.726988 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 23:59:36.727158 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 23:59:36.728877 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:59:36.729039 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:59:36.730955 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:59:36.732727 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 23:59:36.734545 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 23:59:36.742045 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:59:36.748366 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 23:59:36.757799 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 23:59:36.760203 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 23:59:36.761599 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 23:59:36.761636 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:59:36.763786 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 23:59:36.766606 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 23:59:36.769451 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 23:59:36.771475 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:59:36.772480 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 23:59:36.776531 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 23:59:36.778891 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:59:36.780489 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 23:59:36.781270 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:59:36.784891 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:59:36.787817 systemd-journald[1142]: Time spent on flushing to /var/log/journal/7879c97c89a247e7a8a6501b7b386d80 is 53.951ms for 984 entries. Sep 4 23:59:36.787817 systemd-journald[1142]: System Journal (/var/log/journal/7879c97c89a247e7a8a6501b7b386d80) is 8.0M, max 195.6M, 187.6M free. Sep 4 23:59:36.854972 systemd-journald[1142]: Received client request to flush runtime journal. Sep 4 23:59:36.855022 kernel: loop0: detected capacity change from 0 to 142488 Sep 4 23:59:36.789447 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 23:59:36.795390 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 23:59:36.823569 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 23:59:36.852877 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 23:59:36.855958 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 23:59:36.858792 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 23:59:36.862108 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 23:59:36.865462 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 23:59:36.874147 udevadm[1188]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 4 23:59:36.875515 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 23:59:36.883888 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 23:59:36.887289 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Sep 4 23:59:36.887313 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Sep 4 23:59:36.894901 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 4 23:59:36.897014 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:59:36.899091 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:59:36.904876 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 23:59:36.913307 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 23:59:36.914148 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 4 23:59:36.917785 kernel: loop1: detected capacity change from 0 to 219840 Sep 4 23:59:36.950049 kernel: loop2: detected capacity change from 0 to 140768 Sep 4 23:59:36.962999 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 23:59:36.971968 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:59:36.987697 kernel: loop3: detected capacity change from 0 to 142488 Sep 4 23:59:36.990697 systemd-tmpfiles[1212]: ACLs are not supported, ignoring. Sep 4 23:59:36.990732 systemd-tmpfiles[1212]: ACLs are not supported, ignoring. Sep 4 23:59:36.995837 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:59:37.002671 kernel: loop4: detected capacity change from 0 to 219840 Sep 4 23:59:37.014677 kernel: loop5: detected capacity change from 0 to 140768 Sep 4 23:59:37.025476 (sd-merge)[1214]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Sep 4 23:59:37.026543 (sd-merge)[1214]: Merged extensions into '/usr'. Sep 4 23:59:37.030638 systemd[1]: Reloading requested from client PID 1185 ('systemd-sysext') (unit systemd-sysext.service)... Sep 4 23:59:37.030887 systemd[1]: Reloading... Sep 4 23:59:37.093745 zram_generator::config[1241]: No configuration found. Sep 4 23:59:37.143349 ldconfig[1180]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 23:59:37.178296 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. Sep 4 23:59:37.214247 systemd[1]: Reloading finished in 182 ms. Sep 4 23:59:37.239434 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 23:59:37.241290 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 23:59:37.258084 systemd[1]: Starting ensure-sysext.service... Sep 4 23:59:37.260539 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:59:37.265400 systemd[1]: Reloading requested from client PID 1278 ('systemctl') (unit ensure-sysext.service)... Sep 4 23:59:37.265408 systemd[1]: Reloading... Sep 4 23:59:37.283713 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 23:59:37.287102 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 23:59:37.288166 systemd-tmpfiles[1280]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 23:59:37.288525 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Sep 4 23:59:37.288733 systemd-tmpfiles[1280]: ACLs are not supported, ignoring. Sep 4 23:59:37.291999 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:59:37.292095 systemd-tmpfiles[1280]: Skipping /boot Sep 4 23:59:37.303601 systemd-tmpfiles[1280]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:59:37.303845 systemd-tmpfiles[1280]: Skipping /boot Sep 4 23:59:37.348035 zram_generator::config[1305]: No configuration found. Sep 4 23:59:37.433689 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. Sep 4 23:59:37.464980 systemd[1]: Reloading finished in 199 ms. Sep 4 23:59:37.477261 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 23:59:37.489431 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:59:37.498482 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 23:59:37.502199 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 23:59:37.505446 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 23:59:37.510570 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:59:37.515465 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:59:37.519796 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 23:59:37.526546 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 23:59:37.537615 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:37.538967 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:59:37.544919 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:59:37.548031 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:59:37.555260 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:59:37.555644 systemd-udevd[1350]: Using default interface naming scheme 'v255'. Sep 4 23:59:37.558844 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:59:37.559408 augenrules[1370]: No rules Sep 4 23:59:37.560339 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 23:59:37.565149 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 23:59:37.567370 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:37.569837 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 23:59:37.573117 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 23:59:37.576733 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 23:59:37.580202 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:59:37.580353 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:59:37.583896 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:59:37.584158 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:59:37.587532 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:59:37.587722 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:59:37.590831 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 23:59:37.600821 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:59:37.603719 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 23:59:37.607169 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:37.607380 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:59:37.613812 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:59:37.616642 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:59:37.621948 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:59:37.627969 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:59:37.630941 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:59:37.632384 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:59:37.634411 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). Sep 4 23:59:37.634525 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 23:59:37.635382 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:59:37.635512 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:59:37.636603 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:59:37.636767 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:59:37.640281 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:59:37.640395 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:59:37.643313 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:59:37.643405 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:59:37.652071 systemd[1]: Finished ensure-sysext.service. Sep 4 23:59:37.663939 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 23:59:37.664422 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:59:37.664477 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:59:37.665789 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1389) Sep 4 23:59:37.666111 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 4 23:59:37.708430 systemd-resolved[1349]: Positive Trust Anchors: Sep 4 23:59:37.709215 systemd-resolved[1349]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:59:37.709244 systemd-resolved[1349]: 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 Sep 4 23:59:37.715984 systemd-resolved[1349]: Defaulting to hostname 'linux'. Sep 4 23:59:37.717544 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 23:59:37.719501 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:59:37.721387 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:59:37.725861 systemd-networkd[1409]: lo: Link UP Sep 4 23:59:37.725880 systemd-networkd[1409]: lo: Gained carrier Sep 4 23:59:37.726764 systemd-networkd[1409]: Enumeration completed Sep 4 23:59:37.727891 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 23:59:37.729340 systemd-networkd[1409]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:59:37.729343 systemd-networkd[1409]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:59:37.729760 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 4 23:59:37.730490 systemd-networkd[1409]: eth0: Link UP Sep 4 23:59:37.730492 systemd-networkd[1409]: eth0: Gained carrier Sep 4 23:59:37.730502 systemd-networkd[1409]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:59:37.731616 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:59:37.732314 systemd[1]: Reached target network.target - Network. Sep 4 23:59:37.736396 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 23:59:37.744724 systemd-networkd[1409]: eth0: DHCPv4 address 10.0.0.32/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 23:59:38.691574 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Sep 4 23:59:37.745507 systemd-timesyncd[1421]: Network configuration changed, trying to establish connection. Sep 4 23:59:38.691479 systemd-timesyncd[1421]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 4 23:59:38.691514 systemd-timesyncd[1421]: Initial clock synchronization to Fri 2026-09-04 23:59:38.691411 UTC. Sep 4 23:59:38.691520 systemd-resolved[1349]: Clock change detected. Flushing caches. Sep 4 23:59:38.692616 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 23:59:38.701166 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Sep 4 23:59:38.703201 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Sep 4 23:59:38.706682 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 23:59:38.710748 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Sep 4 23:59:38.711080 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Sep 4 23:59:38.714400 kernel: ACPI: button: Power Button [PWRF] Sep 4 23:59:38.724157 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Sep 4 23:59:38.740668 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:38.791924 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:59:38.792123 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:38.798031 kernel: mousedev: PS/2 mouse device common for all mice Sep 4 23:59:38.812231 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:59:38.866361 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:59:38.918909 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 23:59:38.929203 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 23:59:38.937434 lvm[1445]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:59:38.965740 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 23:59:38.967716 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:59:38.969205 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:59:38.970684 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 23:59:38.972450 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 23:59:38.975191 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 23:59:38.977157 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 23:59:38.979214 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 23:59:38.981154 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 23:59:38.981199 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:59:38.982772 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:59:38.984761 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 23:59:38.988201 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 23:59:38.997141 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 23:59:39.001258 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 23:59:39.003799 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 23:59:39.005731 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:59:39.007228 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:59:39.008505 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:59:39.008535 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:59:39.009361 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 23:59:39.011194 lvm[1449]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:59:39.011688 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 23:59:39.016152 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 23:59:39.019671 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 23:59:39.020938 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). Sep 4 23:59:39.021772 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 23:59:39.022744 jq[1452]: false Sep 4 23:59:39.023197 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 23:59:39.028528 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 23:59:39.032914 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 23:59:39.034763 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 23:59:39.035119 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 23:59:39.036287 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 23:59:39.039081 extend-filesystems[1453]: Found loop3 Sep 4 23:59:39.039081 extend-filesystems[1453]: Found loop4 Sep 4 23:59:39.039081 extend-filesystems[1453]: Found loop5 Sep 4 23:59:39.039081 extend-filesystems[1453]: Found sr0 Sep 4 23:59:39.039081 extend-filesystems[1453]: Found vda Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda1 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda2 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda3 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found usr Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda4 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda6 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda7 Sep 4 23:59:39.054730 extend-filesystems[1453]: Found vda9 Sep 4 23:59:39.054730 extend-filesystems[1453]: Checking size of /dev/vda9 Sep 4 23:59:39.054730 extend-filesystems[1453]: Resized partition /dev/vda9 Sep 4 23:59:39.093565 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (1390) Sep 4 23:59:39.093598 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Sep 4 23:59:39.040301 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 23:59:39.042820 dbus-daemon[1451]: [system] SELinux support is enabled Sep 4 23:59:39.110371 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Sep 4 23:59:39.110406 extend-filesystems[1470]: resize2fs 1.47.1 (20-May-2024) Sep 4 23:59:39.051343 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 23:59:39.113673 extend-filesystems[1470]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Sep 4 23:59:39.113673 extend-filesystems[1470]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 4 23:59:39.113673 extend-filesystems[1470]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Sep 4 23:59:39.120429 update_engine[1461]: I20260904 23:59:39.071147 1461 main.cc:92] Flatcar Update Engine starting Sep 4 23:59:39.120429 update_engine[1461]: I20260904 23:59:39.078660 1461 update_check_scheduler.cc:74] Next update check in 8m25s Sep 4 23:59:39.066279 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 23:59:39.120659 extend-filesystems[1453]: Resized filesystem in /dev/vda9 Sep 4 23:59:39.085465 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 23:59:39.120708 dbus-daemon[1451]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 4 23:59:39.122174 jq[1463]: true Sep 4 23:59:39.085693 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 23:59:39.086086 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 23:59:39.122364 jq[1476]: true Sep 4 23:59:39.086247 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 23:59:39.089496 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 23:59:39.089652 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 23:59:39.089767 systemd-logind[1459]: Watching system buttons on /dev/input/event1 (Power Button) Sep 4 23:59:39.089778 systemd-logind[1459]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 4 23:59:39.090017 systemd-logind[1459]: New seat seat0. Sep 4 23:59:39.103790 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 23:59:39.111647 (ntainerd)[1477]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 23:59:39.113508 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 23:59:39.113653 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 23:59:39.127441 systemd[1]: Started update-engine.service - Update Engine. Sep 4 23:59:39.129535 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). Sep 4 23:59:39.131220 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 23:59:39.132909 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). Sep 4 23:59:39.132987 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 23:59:39.145234 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 23:59:39.159245 bash[1502]: Updated "/home/core/.ssh/authorized_keys" Sep 4 23:59:39.161273 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 23:59:39.163526 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 4 23:59:39.170852 locksmithd[1498]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 23:59:39.317790 containerd[1477]: time="2026-09-04T23:59:39.317675824Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 4 23:59:39.337256 containerd[1477]: time="2026-09-04T23:59:39.337198539Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339073 containerd[1477]: time="2026-09-04T23:59:39.338978438Z" 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.156-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339073 containerd[1477]: time="2026-09-04T23:59:39.339066324Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 23:59:39.339133 containerd[1477]: time="2026-09-04T23:59:39.339089283Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 23:59:39.339160 sshd_keygen[1475]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 23:59:39.339309 containerd[1477]: time="2026-09-04T23:59:39.339233829Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 23:59:39.339309 containerd[1477]: time="2026-09-04T23:59:39.339252136Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339336 containerd[1477]: time="2026-09-04T23:59:39.339304831Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339336 containerd[1477]: time="2026-09-04T23:59:39.339318283Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339560 containerd[1477]: time="2026-09-04T23:59:39.339514970Z" 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 Sep 4 23:59:39.339560 containerd[1477]: time="2026-09-04T23:59:39.339551615Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339591 containerd[1477]: time="2026-09-04T23:59:39.339568060Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339591 containerd[1477]: time="2026-09-04T23:59:39.339580226Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339682 containerd[1477]: time="2026-09-04T23:59:39.339661261Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.339896 containerd[1477]: time="2026-09-04T23:59:39.339854695Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:59:39.340071 containerd[1477]: time="2026-09-04T23:59:39.340026321Z" 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 Sep 4 23:59:39.340178 containerd[1477]: time="2026-09-04T23:59:39.340154760Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 23:59:39.340280 containerd[1477]: time="2026-09-04T23:59:39.340258425Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 23:59:39.340322 containerd[1477]: time="2026-09-04T23:59:39.340314291Z" level=info msg="metadata content store policy set" policy=shared Sep 4 23:59:39.345567 containerd[1477]: time="2026-09-04T23:59:39.345519727Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 23:59:39.345567 containerd[1477]: time="2026-09-04T23:59:39.345571183Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 23:59:39.345656 containerd[1477]: time="2026-09-04T23:59:39.345585261Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 23:59:39.345656 containerd[1477]: time="2026-09-04T23:59:39.345598420Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 23:59:39.345656 containerd[1477]: time="2026-09-04T23:59:39.345610654Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 23:59:39.345725 containerd[1477]: time="2026-09-04T23:59:39.345706450Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 23:59:39.345904 containerd[1477]: time="2026-09-04T23:59:39.345874432Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 23:59:39.345985 containerd[1477]: time="2026-09-04T23:59:39.345959169Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 23:59:39.345985 containerd[1477]: time="2026-09-04T23:59:39.345982527Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 23:59:39.346088 containerd[1477]: time="2026-09-04T23:59:39.346069087Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 23:59:39.346108 containerd[1477]: time="2026-09-04T23:59:39.346095750Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346121 containerd[1477]: time="2026-09-04T23:59:39.346110923Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346134 containerd[1477]: time="2026-09-04T23:59:39.346125941Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346150 containerd[1477]: time="2026-09-04T23:59:39.346144166Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346163 containerd[1477]: time="2026-09-04T23:59:39.346157288Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346176 containerd[1477]: time="2026-09-04T23:59:39.346166845Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346193 containerd[1477]: time="2026-09-04T23:59:39.346175930Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346193 containerd[1477]: time="2026-09-04T23:59:39.346185601Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 23:59:39.346217 containerd[1477]: time="2026-09-04T23:59:39.346200979Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346217 containerd[1477]: time="2026-09-04T23:59:39.346210467Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346245 containerd[1477]: time="2026-09-04T23:59:39.346224504Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346245 containerd[1477]: time="2026-09-04T23:59:39.346233393Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346245 containerd[1477]: time="2026-09-04T23:59:39.346241765Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346285 containerd[1477]: time="2026-09-04T23:59:39.346251506Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346285 containerd[1477]: time="2026-09-04T23:59:39.346260432Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346285 containerd[1477]: time="2026-09-04T23:59:39.346269812Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346285 containerd[1477]: time="2026-09-04T23:59:39.346278311Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346337 containerd[1477]: time="2026-09-04T23:59:39.346288299Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346337 containerd[1477]: time="2026-09-04T23:59:39.346297587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346337 containerd[1477]: time="2026-09-04T23:59:39.346306418Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346337 containerd[1477]: time="2026-09-04T23:59:39.346316568Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346337 containerd[1477]: time="2026-09-04T23:59:39.346333058Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 23:59:39.346397 containerd[1477]: time="2026-09-04T23:59:39.346348047Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346397 containerd[1477]: time="2026-09-04T23:59:39.346356736Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346397 containerd[1477]: time="2026-09-04T23:59:39.346364179Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 23:59:39.346435 containerd[1477]: time="2026-09-04T23:59:39.346411457Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 23:59:39.346435 containerd[1477]: time="2026-09-04T23:59:39.346427104Z" 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 Sep 4 23:59:39.346461 containerd[1477]: time="2026-09-04T23:59:39.346434895Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 23:59:39.346461 containerd[1477]: time="2026-09-04T23:59:39.346443250Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 23:59:39.346461 containerd[1477]: time="2026-09-04T23:59:39.346449667Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346461 containerd[1477]: time="2026-09-04T23:59:39.346457887Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 23:59:39.346539 containerd[1477]: time="2026-09-04T23:59:39.346464924Z" level=info msg="NRI interface is disabled by configuration." Sep 4 23:59:39.346539 containerd[1477]: time="2026-09-04T23:59:39.346471872Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 23:59:39.346714 containerd[1477]: time="2026-09-04T23:59:39.346661960Z" 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}" Sep 4 23:59:39.346714 containerd[1477]: time="2026-09-04T23:59:39.346712538Z" level=info msg="Connect containerd service" Sep 4 23:59:39.346832 containerd[1477]: time="2026-09-04T23:59:39.346736222Z" level=info msg="using legacy CRI server" Sep 4 23:59:39.346832 containerd[1477]: time="2026-09-04T23:59:39.346740917Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 23:59:39.346832 containerd[1477]: time="2026-09-04T23:59:39.346806706Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 23:59:39.347274 containerd[1477]: time="2026-09-04T23:59:39.347249375Z" 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" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347395954Z" level=info msg="Start subscribing containerd event" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347439864Z" level=info msg="Start recovering state" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347487200Z" level=info msg="Start event monitor" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347491272Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347500380Z" level=info msg="Start snapshots syncer" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347507875Z" level=info msg="Start cni network conf syncer for default" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347513144Z" level=info msg="Start streaming server" Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347520804Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 23:59:39.347687 containerd[1477]: time="2026-09-04T23:59:39.347584786Z" level=info msg="containerd successfully booted in 0.030747s" Sep 4 23:59:39.348124 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 23:59:39.363330 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 23:59:39.378341 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 23:59:39.385511 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 23:59:39.385675 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 23:59:39.388945 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 23:59:39.399704 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 23:59:39.402947 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 23:59:39.405116 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 23:59:39.406811 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 23:59:40.459408 systemd-networkd[1409]: eth0: Gained IPv6LL Sep 4 23:59:40.461507 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 23:59:40.463946 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 23:59:40.474374 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 23:59:40.477097 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:59:40.479661 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 23:59:40.492736 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 23:59:40.492960 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 23:59:40.495228 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 23:59:40.497194 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 23:59:41.163446 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:59:41.165753 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 23:59:41.166825 (kubelet)[1556]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Sep 4 23:59:41.167728 systemd[1]: Startup finished in 1.321s (kernel) + 5.244s (initrd) + 4.187s (userspace) = 10.753s. Sep 4 23:59:41.528628 kubelet[1556]: E0904 23:59:41.528443 1556 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" Sep 4 23:59:41.530817 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Sep 4 23:59:41.531085 systemd[1]: kubelet.service: Failed with result 'exit-code'. Sep 4 23:59:45.861934 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 23:59:45.862888 systemd[1]: Started sshd@0-10.0.0.32:22-10.0.0.1:42134.service - OpenSSH per-connection server daemon (10.0.0.1:42134). Sep 4 23:59:45.904187 sshd[1570]: Accepted publickey for core from 10.0.0.1 port 42134 ssh2: RSA SHA256:vBP/QiE5BHLKInLouGxnlgPQzzw5kcI7zSBTWQ7Q9QU Sep 4 23:59:45.905896 sshd[1570]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:59:45.913093 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 23:59:45.926352 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 23:59:45.928112 systemd-logind[1459]: New session 1 of user core. Sep 4 23:59:45.935766 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 23:59:45.938307 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 23:59:45.943881 (systemd)[1574]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 23:59:46.042897 systemd[1574]: Queued start job for default target default.target. Sep 4 23:59:46.055858 systemd[1574]: Created slice app.slice - User Application Slice. Sep 4 23:59:46.055894 systemd[1574]: Reached target paths.target - Paths. Sep 4 23:59:46.055903 systemd[1574]: Reached target timers.target - Timers. Sep 4 23:59:46.057438 systemd[1574]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 23:59:46.066313 systemd[1574]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 23:59:46.066374 systemd[1574]: Reached target sockets.target - Sockets. Sep 4 23:59:46.066383 systemd[1574]: Reached target basic.target - Basic System. Sep 4 23:59:46.066408 systemd[1574]: Reached target default.target - Main User Target. Sep 4 23:59:46.066427 systemd[1574]: Startup finished in 117ms. Sep 4 23:59:46.066912 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 23:59:46.068130 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 23:59:46.126729 systemd[1]: Started sshd@1-10.0.0.32:22-10.0.0.1:42138.service - OpenSSH per-connection server daemon (10.0.0.1:42138). Sep 4 23:59:46.159385 sshd[1585]: Accepted publickey for core from 10.0.0.1 port 42138 ssh2: RSA SHA256:vBP/QiE5BHLKInLouGxnlgPQzzw5kcI7zSBTWQ7Q9QU Sep 4 23:59:46.160439 sshd[1585]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:59:46.165314 systemd-logind[1459]: New session 2 of user core. Sep 4 23:59:46.180277 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 23:59:46.235320 sshd[1585]: pam_unix(sshd:session): session closed for user core Sep 4 23:59:46.249709 systemd[1]: sshd@1-10.0.0.32:22-10.0.0.1:42138.service: Deactivated successfully. Sep 4 23:59:46.250918 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 23:59:46.252319 systemd-logind[1459]: Session 2 logged out. Waiting for processes to exit. Sep 4 23:59:46.279605 systemd[1]: Started sshd@2-10.0.0.32:22-10.0.0.1:42144.service - OpenSSH per-connection server daemon (10.0.0.1:42144). Sep 4 23:59:46.281297 systemd-logind[1459]: Removed session 2. Sep 4 23:59:46.307645 sshd[1592]: Accepted publickey for core from 10.0.0.1 port 42144 ssh2: RSA SHA256:vBP/QiE5BHLKInLouGxnlgPQzzw5kcI7zSBTWQ7Q9QU Sep 4 23:59:46.308802 sshd[1592]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:59:46.313143 systemd-logind[1459]: New session 3 of user core. Sep 4 23:59:46.323277 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 23:59:46.371162 sshd[1592]: pam_unix(sshd:session): session closed for user core Sep 4 23:59:46.377776 systemd[1]: sshd@2-10.0.0.32:22-10.0.0.1:42144.service: Deactivated successfully. Sep 4 23:59:46.379187 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 23:59:46.380153 systemd-logind[1459]: Session 3 logged out. Waiting for processes to exit. Sep 4 23:59:46.381039 systemd[1]: Started sshd@3-10.0.0.32:22-10.0.0.1:42148.service - OpenSSH per-connection server daemon (10.0.0.1:42148). Sep 4 23:59:46.381733 systemd-logind[1459]: Removed session 3. Sep 4 23:59:46.412814 sshd[1599]: Accepted publickey for core from 10.0.0.1 port 42148 ssh2: RSA SHA256:vBP/QiE5BHLKInLouGxnlgPQzzw5kcI7zSBTWQ7Q9QU Sep 4 23:59:46.414128 sshd[1599]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:59:46.418775 systemd-logind[1459]: New session 4 of user core. Sep 4 23:59:46.432308 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 23:59:46.487174 sshd[1599]: pam_unix(sshd:session): session closed for user core Sep 4 23:59:46.495239 systemd[1]: sshd@3-10.0.0.32:22-10.0.0.1:42148.service: Deactivated successfully. Sep 4 23:59:46.496402 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 23:59:46.497535 systemd-logind[1459]: Session 4 logged out. Waiting for processes to exit. Sep 4 23:59:46.498767 systemd[1]: Started sshd@4-10.0.0.32:22-10.0.0.1:42156.service - OpenSSH per-connection server daemon (10.0.0.1:42156). Sep 4 23:59:46.500230 systemd-logind[1459]: Removed session 4. Sep 4 23:59:46.528701 sshd[1606]: Accepted publickey for core from 10.0.0.1 port 42156 ssh2: RSA SHA256:vBP/QiE5BHLKInLouGxnlgPQzzw5kcI7zSBTWQ7Q9QU Sep 4 23:59:46.529839 sshd[1606]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:59:46.534259 systemd-logind[1459]: New session 5 of user core. Sep 4 23:59:46.548283 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 23:59:46.605346 sudo[1609]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Sep 4 23:59:46.605660 sudo[1609]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 23:59:46.625356 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 23:59:46.639508 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 23:59:46.639811 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 23:59:46.826020 kernel: hrtimer: interrupt took 31639982 ns Sep 4 23:59:47.215744 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:59:47.230420 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:59:47.263718 systemd[1]: Reloading requested from client PID 1659 ('systemctl') (unit session-5.scope)... Sep 4 23:59:47.263768 systemd[1]: Reloading... Sep 4 23:59:47.369093 zram_generator::config[1700]: No configuration found. Sep 4 23:59:47.487721 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. Sep 4 23:59:47.535594 systemd[1]: Reloading finished in 271 ms. Sep 4 23:59:47.572010 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:59:47.574250 systemd[1]: kubelet.service: Deactivated successfully. Sep 4 23:59:47.574411 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:59:47.575533 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:59:47.683645 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:59:47.687624 (kubelet)[1747]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Sep 4 23:59:47.726459 kubelet[1747]: 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. Sep 4 23:59:47.866923 kubelet[1747]: I0904 23:59:47.866563 1747 server.go:545] "Kubelet version" kubeletVersion="v1.36.1" Sep 4 23:59:47.866923 kubelet[1747]: I0904 23:59:47.866779 1747 server.go:547] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Sep 4 23:59:47.866923 kubelet[1747]: I0904 23:59:47.866815 1747 watchdog_linux.go:94] "Systemd watchdog is not enabled" Sep 4 23:59:47.866923 kubelet[1747]: I0904 23:59:47.866822 1747 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Sep 4 23:59:47.868180 kubelet[1747]: I0904 23:59:47.868121 1747 server.go:985] "Client rotation is on, will bootstrap in background" Sep 4 23:59:47.872067 kubelet[1747]: I0904 23:59:47.872017 1747 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Sep 4 23:59:47.878276 kubelet[1747]: E0904 23:59:47.878177 1747 remote_runtime.go:1177] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Sep 4 23:59:47.878443 kubelet[1747]: I0904 23:59:47.878346 1747 server.go:1425] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Sep 4 23:59:47.885089 kubelet[1747]: I0904 23:59:47.884970 1747 server.go:808] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Sep 4 23:59:47.887043 kubelet[1747]: I0904 23:59:47.886894 1747 container_manager_linux.go:273] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Sep 4 23:59:47.887273 kubelet[1747]: I0904 23:59:47.887098 1747 container_manager_linux.go:278] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.32","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"MemoryReservationPolicy":"None","PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Sep 4 23:59:47.887273 kubelet[1747]: I0904 23:59:47.887267 1747 topology_manager.go:172] "Creating topology manager with none policy" Sep 4 23:59:47.887273 kubelet[1747]: I0904 23:59:47.887278 1747 container_manager_linux.go:309] "Creating device plugin manager" Sep 4 23:59:47.887472 kubelet[1747]: I0904 23:59:47.887399 1747 container_manager_linux.go:318] "Creating Dynamic Resource Allocation (DRA) manager" Sep 4 23:59:47.929933 kubelet[1747]: I0904 23:59:47.929767 1747 state_mem.go:45] "Initialized" logger="CPUManager state memory" Sep 4 23:59:47.930191 kubelet[1747]: I0904 23:59:47.930165 1747 kubelet.go:485] "Attempting to sync node with API server" Sep 4 23:59:47.930191 kubelet[1747]: I0904 23:59:47.930186 1747 kubelet.go:386] "Adding static pod path" path="/etc/kubernetes/manifests" Sep 4 23:59:47.930191 kubelet[1747]: I0904 23:59:47.930201 1747 kubelet.go:397] "Adding apiserver pod source" Sep 4 23:59:47.930250 kubelet[1747]: I0904 23:59:47.930212 1747 apiserver.go:41] "Waiting for node sync before watching apiserver pods" Sep 4 23:59:47.931985 kubelet[1747]: E0904 23:59:47.931908 1747 file.go:97] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:47.931985 kubelet[1747]: I0904 23:59:47.931974 1747 kuberuntime_manager.go:308] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Sep 4 23:59:47.932125 kubelet[1747]: E0904 23:59:47.932015 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:47.932909 kubelet[1747]: I0904 23:59:47.932873 1747 kubelet.go:1002] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Sep 4 23:59:47.932909 kubelet[1747]: I0904 23:59:47.932912 1747 kubelet.go:1029] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Sep 4 23:59:47.932986 kubelet[1747]: W0904 23:59:47.932971 1747 probe.go:275] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Sep 4 23:59:47.936976 kubelet[1747]: I0904 23:59:47.936954 1747 server.go:1285] "Started kubelet" Sep 4 23:59:47.937165 kubelet[1747]: I0904 23:59:47.937131 1747 server.go:193] "Starting to listen" address="0.0.0.0" port=10250 Sep 4 23:59:47.937290 kubelet[1747]: I0904 23:59:47.937256 1747 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Sep 4 23:59:47.937358 kubelet[1747]: I0904 23:59:47.937341 1747 server_v1.go:49] "podresources" method="list" useActivePods=true Sep 4 23:59:47.937621 kubelet[1747]: I0904 23:59:47.937579 1747 server.go:264] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Sep 4 23:59:47.940821 kubelet[1747]: I0904 23:59:47.940774 1747 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Sep 4 23:59:47.941661 kubelet[1747]: I0904 23:59:47.941629 1747 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Sep 4 23:59:47.941785 kubelet[1747]: I0904 23:59:47.941716 1747 tlsconfig.go:243] "Starting DynamicServingCertificateController" Sep 4 23:59:47.942217 kubelet[1747]: I0904 23:59:47.942155 1747 server.go:354] "Adding debug handlers to kubelet server" Sep 4 23:59:47.942890 kubelet[1747]: I0904 23:59:47.942867 1747 volume_manager.go:310] "Starting Kubelet Volume Manager" Sep 4 23:59:47.945354 kubelet[1747]: E0904 23:59:47.945306 1747 kubelet_node_status.go:396] "Error getting the current node from lister" err="node \"10.0.0.32\" not found" Sep 4 23:59:47.946170 kubelet[1747]: E0904 23:59:47.945522 1747 kubelet.go:3516] "Unable to register mirror pod because node is not registered yet" err="node \"10.0.0.32\" not found" node="10.0.0.32" Sep 4 23:59:47.946170 kubelet[1747]: I0904 23:59:47.946149 1747 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Sep 4 23:59:47.946836 kubelet[1747]: I0904 23:59:47.946240 1747 reconciler.go:29] "Reconciler: start to sync state" Sep 4 23:59:47.948116 kubelet[1747]: I0904 23:59:47.947149 1747 factory.go:222] Registration of the systemd container factory successfully Sep 4 23:59:47.948116 kubelet[1747]: I0904 23:59:47.947599 1747 factory.go:220] 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 Sep 4 23:59:47.948463 kubelet[1747]: E0904 23:59:47.948290 1747 kubelet.go:1725] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Sep 4 23:59:47.951357 kubelet[1747]: I0904 23:59:47.949224 1747 factory.go:222] Registration of the containerd container factory successfully Sep 4 23:59:47.952930 kubelet[1747]: E0904 23:59:47.952885 1747 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.32\" not found" node="10.0.0.32" Sep 4 23:59:47.957540 kubelet[1747]: I0904 23:59:47.957503 1747 cpu_manager.go:235] "Starting" policy="none" Sep 4 23:59:47.957540 kubelet[1747]: I0904 23:59:47.957527 1747 cpu_manager.go:236] "Reconciling" reconcilePeriod="10s" Sep 4 23:59:47.957540 kubelet[1747]: I0904 23:59:47.957545 1747 state_mem.go:45] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Sep 4 23:59:47.959475 kubelet[1747]: I0904 23:59:47.959450 1747 policy_none.go:50] "Start" Sep 4 23:59:47.959475 kubelet[1747]: I0904 23:59:47.959468 1747 memory_manager.go:190] "Starting memorymanager" policy="None" Sep 4 23:59:47.959475 kubelet[1747]: I0904 23:59:47.959477 1747 state_mem.go:40] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Sep 4 23:59:47.960813 kubelet[1747]: I0904 23:59:47.960628 1747 policy_none.go:44] "Start" Sep 4 23:59:47.965527 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Sep 4 23:59:47.977063 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Sep 4 23:59:47.980221 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Sep 4 23:59:47.988268 kubelet[1747]: E0904 23:59:47.988226 1747 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Sep 4 23:59:47.988856 kubelet[1747]: I0904 23:59:47.988506 1747 eviction_manager.go:194] "Eviction manager: starting control loop" Sep 4 23:59:47.988856 kubelet[1747]: I0904 23:59:47.988606 1747 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Sep 4 23:59:47.988856 kubelet[1747]: I0904 23:59:47.988772 1747 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Sep 4 23:59:47.989953 kubelet[1747]: E0904 23:59:47.989921 1747 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Sep 4 23:59:47.990018 kubelet[1747]: E0904 23:59:47.989960 1747 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.32\" not found" Sep 4 23:59:48.007878 kubelet[1747]: I0904 23:59:48.007813 1747 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv4" Sep 4 23:59:48.009126 kubelet[1747]: I0904 23:59:48.009094 1747 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv6" Sep 4 23:59:48.009126 kubelet[1747]: I0904 23:59:48.009139 1747 status_manager.go:277] "Starting to sync pod status with apiserver" Sep 4 23:59:48.009126 kubelet[1747]: I0904 23:59:48.009165 1747 kubelet.go:2622] "Starting kubelet main sync loop" Sep 4 23:59:48.009126 kubelet[1747]: E0904 23:59:48.009207 1747 kubelet.go:2646] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Sep 4 23:59:48.046220 kubelet[1747]: E0904 23:59:48.046105 1747 kubelet.go:3516] "Unable to register mirror pod because node is not registered yet" err="node \"10.0.0.32\" not found" node="10.0.0.32" Sep 4 23:59:48.100179 kubelet[1747]: I0904 23:59:48.100118 1747 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.32" Sep 4 23:59:48.109318 kubelet[1747]: I0904 23:59:48.109247 1747 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.32" Sep 4 23:59:48.109318 kubelet[1747]: E0904 23:59:48.109298 1747 kubelet_node_status.go:479] "Error updating node status, will retry" err="error getting node \"10.0.0.32\": node \"10.0.0.32\" not found" Sep 4 23:59:48.129813 kubelet[1747]: I0904 23:59:48.129669 1747 kuberuntime_manager.go:2146] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Sep 4 23:59:48.130140 containerd[1477]: time="2026-09-04T23:59:48.130069024Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Sep 4 23:59:48.130428 kubelet[1747]: I0904 23:59:48.130343 1747 kubelet_network.go:48] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Sep 4 23:59:48.195513 sudo[1609]: pam_unix(sudo:session): session closed for user root Sep 4 23:59:48.197122 sshd[1606]: pam_unix(sshd:session): session closed for user core Sep 4 23:59:48.200254 systemd[1]: sshd@4-10.0.0.32:22-10.0.0.1:42156.service: Deactivated successfully. Sep 4 23:59:48.201637 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 23:59:48.202156 systemd-logind[1459]: Session 5 logged out. Waiting for processes to exit. Sep 4 23:59:48.202916 systemd-logind[1459]: Removed session 5. Sep 4 23:59:48.870360 kubelet[1747]: I0904 23:59:48.870237 1747 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Sep 4 23:59:48.870953 kubelet[1747]: I0904 23:59:48.870570 1747 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:59:48.870953 kubelet[1747]: I0904 23:59:48.870570 1747 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:59:48.870953 kubelet[1747]: I0904 23:59:48.870621 1747 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:59:48.931419 kubelet[1747]: I0904 23:59:48.931311 1747 apiserver.go:51] "Watching apiserver" Sep 4 23:59:48.932477 kubelet[1747]: E0904 23:59:48.932419 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:48.946354 kubelet[1747]: I0904 23:59:48.946329 1747 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Sep 4 23:59:48.947568 systemd[1]: Created slice kubepods-besteffort-podf480b8fa_daca_43ad_a0f6_f352fd107531.slice - libcontainer container kubepods-besteffort-podf480b8fa_daca_43ad_a0f6_f352fd107531.slice. Sep 4 23:59:48.954490 kubelet[1747]: I0904 23:59:48.954454 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-flannel-cfg\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.954490 kubelet[1747]: I0904 23:59:48.954486 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-ppnrq\" (UniqueName: \"kubernetes.io/projected/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-kube-api-access-ppnrq\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.954490 kubelet[1747]: I0904 23:59:48.954500 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/f480b8fa-daca-43ad-a0f6-f352fd107531-lib-modules\") pod \"kube-proxy-7dfxz\" (UID: \"f480b8fa-daca-43ad-a0f6-f352fd107531\") " pod="kube-system/kube-proxy-7dfxz" Sep 4 23:59:48.954490 kubelet[1747]: I0904 23:59:48.954511 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-nt9gr\" (UniqueName: \"kubernetes.io/projected/f480b8fa-daca-43ad-a0f6-f352fd107531-kube-api-access-nt9gr\") pod \"kube-proxy-7dfxz\" (UID: \"f480b8fa-daca-43ad-a0f6-f352fd107531\") " pod="kube-system/kube-proxy-7dfxz" Sep 4 23:59:48.954490 kubelet[1747]: I0904 23:59:48.954523 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-cni-plugin\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.954788 kubelet[1747]: I0904 23:59:48.954533 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-xtables-lock\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.954788 kubelet[1747]: I0904 23:59:48.954551 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/f480b8fa-daca-43ad-a0f6-f352fd107531-kube-proxy\") pod \"kube-proxy-7dfxz\" (UID: \"f480b8fa-daca-43ad-a0f6-f352fd107531\") " pod="kube-system/kube-proxy-7dfxz" Sep 4 23:59:48.954788 kubelet[1747]: I0904 23:59:48.954598 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/f480b8fa-daca-43ad-a0f6-f352fd107531-xtables-lock\") pod \"kube-proxy-7dfxz\" (UID: \"f480b8fa-daca-43ad-a0f6-f352fd107531\") " pod="kube-system/kube-proxy-7dfxz" Sep 4 23:59:48.954788 kubelet[1747]: I0904 23:59:48.954634 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-run\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.954788 kubelet[1747]: I0904 23:59:48.954645 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/4729047e-0861-4f5d-8c55-f1c2bb6fe55a-cni\") pod \"kube-flannel-ds-5sb6n\" (UID: \"4729047e-0861-4f5d-8c55-f1c2bb6fe55a\") " pod="kube-flannel/kube-flannel-ds-5sb6n" Sep 4 23:59:48.958929 systemd[1]: Created slice kubepods-burstable-pod4729047e_0861_4f5d_8c55_f1c2bb6fe55a.slice - libcontainer container kubepods-burstable-pod4729047e_0861_4f5d_8c55_f1c2bb6fe55a.slice. Sep 4 23:59:49.266959 kubelet[1747]: E0904 23:59:49.264379 1747 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" Sep 4 23:59:49.269859 containerd[1477]: time="2026-09-04T23:59:49.269734845Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-7dfxz,Uid:f480b8fa-daca-43ad-a0f6-f352fd107531,Namespace:kube-system,Attempt:0,}" Sep 4 23:59:49.320467 kubelet[1747]: E0904 23:59:49.320394 1747 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" Sep 4 23:59:49.322022 containerd[1477]: time="2026-09-04T23:59:49.320951709Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5sb6n,Uid:4729047e-0861-4f5d-8c55-f1c2bb6fe55a,Namespace:kube-flannel,Attempt:0,}" Sep 4 23:59:49.772886 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3975896727.mount: Deactivated successfully. Sep 4 23:59:49.780256 containerd[1477]: time="2026-09-04T23:59:49.780209234Z" 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\"}" Sep 4 23:59:49.780897 containerd[1477]: time="2026-09-04T23:59:49.780860192Z" 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\"}" Sep 4 23:59:49.781518 containerd[1477]: time="2026-09-04T23:59:49.781440339Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Sep 4 23:59:49.782238 containerd[1477]: time="2026-09-04T23:59:49.782155651Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312116" Sep 4 23:59:49.782722 containerd[1477]: time="2026-09-04T23:59:49.782665865Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:59:49.786219 containerd[1477]: time="2026-09-04T23:59:49.786181336Z" 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\"}" Sep 4 23:59:49.787334 containerd[1477]: time="2026-09-04T23:59:49.787290271Z" 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 466.236312ms" Sep 4 23:59:49.788141 containerd[1477]: time="2026-09-04T23:59:49.788100334Z" 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 518.182023ms" Sep 4 23:59:49.853732 containerd[1477]: time="2026-09-04T23:59:49.853611544Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:59:49.854483 containerd[1477]: time="2026-09-04T23:59:49.854347901Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:59:49.854483 containerd[1477]: time="2026-09-04T23:59:49.854371193Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:59:49.854624 containerd[1477]: time="2026-09-04T23:59:49.854585214Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:59:49.857055 containerd[1477]: time="2026-09-04T23:59:49.856562724Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:59:49.857055 containerd[1477]: time="2026-09-04T23:59:49.856603255Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:59:49.857055 containerd[1477]: time="2026-09-04T23:59:49.856618611Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:59:49.857055 containerd[1477]: time="2026-09-04T23:59:49.856700686Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:59:49.897200 systemd[1]: Started cri-containerd-40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f.scope - libcontainer container 40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f. Sep 4 23:59:49.900341 systemd[1]: Started cri-containerd-9a3264c30b4a75eecadc68a32f5295826682c3a41a03648c70a61e2d905f0ea1.scope - libcontainer container 9a3264c30b4a75eecadc68a32f5295826682c3a41a03648c70a61e2d905f0ea1. Sep 4 23:59:49.920504 containerd[1477]: time="2026-09-04T23:59:49.920351900Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-7dfxz,Uid:f480b8fa-daca-43ad-a0f6-f352fd107531,Namespace:kube-system,Attempt:0,} returns sandbox id \"9a3264c30b4a75eecadc68a32f5295826682c3a41a03648c70a61e2d905f0ea1\"" Sep 4 23:59:49.921887 kubelet[1747]: E0904 23:59:49.921751 1747 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" Sep 4 23:59:49.923507 containerd[1477]: time="2026-09-04T23:59:49.923281030Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.36.4\"" Sep 4 23:59:49.930444 containerd[1477]: time="2026-09-04T23:59:49.930419970Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5sb6n,Uid:4729047e-0861-4f5d-8c55-f1c2bb6fe55a,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\"" Sep 4 23:59:49.931308 kubelet[1747]: E0904 23:59:49.931249 1747 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" Sep 4 23:59:49.933316 kubelet[1747]: E0904 23:59:49.933273 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:50.580127 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2511523076.mount: Deactivated successfully. Sep 4 23:59:50.859842 containerd[1477]: time="2026-09-04T23:59:50.859709546Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.36.4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:50.860425 containerd[1477]: time="2026-09-04T23:59:50.860367303Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.36.4: active requests=0, bytes read=30055997" Sep 4 23:59:50.861296 containerd[1477]: time="2026-09-04T23:59:50.861242288Z" level=info msg="ImageCreate event name:\"sha256:a5280d36e1aa3602794efd60dc157d55bbd1bed8f755b5c12e0a6ca5dce9d3bd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:50.862754 containerd[1477]: time="2026-09-04T23:59:50.862718314Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:b33fcdd8319290736e566f5fc2225ca07d3c2dfc025fb006342791aa31be4603\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:50.863317 containerd[1477]: time="2026-09-04T23:59:50.863287217Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.36.4\" with image id \"sha256:a5280d36e1aa3602794efd60dc157d55bbd1bed8f755b5c12e0a6ca5dce9d3bd\", repo tag \"registry.k8s.io/kube-proxy:v1.36.4\", repo digest \"registry.k8s.io/kube-proxy@sha256:b33fcdd8319290736e566f5fc2225ca07d3c2dfc025fb006342791aa31be4603\", size \"30054777\" in 939.980295ms" Sep 4 23:59:50.863317 containerd[1477]: time="2026-09-04T23:59:50.863316621Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.36.4\" returns image reference \"sha256:a5280d36e1aa3602794efd60dc157d55bbd1bed8f755b5c12e0a6ca5dce9d3bd\"" Sep 4 23:59:50.864278 containerd[1477]: time="2026-09-04T23:59:50.864256276Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Sep 4 23:59:50.867425 containerd[1477]: time="2026-09-04T23:59:50.867388984Z" level=info msg="CreateContainer within sandbox \"9a3264c30b4a75eecadc68a32f5295826682c3a41a03648c70a61e2d905f0ea1\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Sep 4 23:59:50.877373 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1562517553.mount: Deactivated successfully. Sep 4 23:59:50.879311 containerd[1477]: time="2026-09-04T23:59:50.879252479Z" level=info msg="CreateContainer within sandbox \"9a3264c30b4a75eecadc68a32f5295826682c3a41a03648c70a61e2d905f0ea1\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"76c9770b0f98a09f20651b757c766b43439f202d08905eba1e363110e9992291\"" Sep 4 23:59:50.879912 containerd[1477]: time="2026-09-04T23:59:50.879882964Z" level=info msg="StartContainer for \"76c9770b0f98a09f20651b757c766b43439f202d08905eba1e363110e9992291\"" Sep 4 23:59:50.909415 systemd[1]: Started cri-containerd-76c9770b0f98a09f20651b757c766b43439f202d08905eba1e363110e9992291.scope - libcontainer container 76c9770b0f98a09f20651b757c766b43439f202d08905eba1e363110e9992291. Sep 4 23:59:50.933462 kubelet[1747]: E0904 23:59:50.933411 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:50.934880 containerd[1477]: time="2026-09-04T23:59:50.934828873Z" level=info msg="StartContainer for \"76c9770b0f98a09f20651b757c766b43439f202d08905eba1e363110e9992291\" returns successfully" Sep 4 23:59:50.939534 kubelet[1747]: E0904 23:59:50.939482 1747 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" Sep 4 23:59:51.016787 kubelet[1747]: E0904 23:59:51.016696 1747 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" Sep 4 23:59:51.934027 kubelet[1747]: E0904 23:59:51.933924 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:52.293911 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1213997500.mount: Deactivated successfully. Sep 4 23:59:52.332212 containerd[1477]: time="2026-09-04T23:59:52.332149852Z" 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\"}" Sep 4 23:59:52.332801 containerd[1477]: time="2026-09-04T23:59:52.332749624Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Sep 4 23:59:52.333958 containerd[1477]: time="2026-09-04T23:59:52.333900529Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:52.336761 containerd[1477]: time="2026-09-04T23:59:52.336701548Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:52.338299 containerd[1477]: time="2026-09-04T23:59:52.338246313Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"4856838\" in 1.473955658s" Sep 4 23:59:52.338396 containerd[1477]: time="2026-09-04T23:59:52.338303812Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Sep 4 23:59:52.342554 containerd[1477]: time="2026-09-04T23:59:52.342513166Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Sep 4 23:59:52.362006 containerd[1477]: time="2026-09-04T23:59:52.361786516Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3\"" Sep 4 23:59:52.361936 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount651711402.mount: Deactivated successfully. Sep 4 23:59:52.363207 containerd[1477]: time="2026-09-04T23:59:52.363180787Z" level=info msg="StartContainer for \"68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3\"" Sep 4 23:59:52.390400 systemd[1]: Started cri-containerd-68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3.scope - libcontainer container 68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3. Sep 4 23:59:52.415892 systemd[1]: cri-containerd-68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3.scope: Deactivated successfully. Sep 4 23:59:52.418401 containerd[1477]: time="2026-09-04T23:59:52.418315717Z" level=info msg="StartContainer for \"68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3\" returns successfully" Sep 4 23:59:52.421050 kubelet[1747]: E0904 23:59:52.420977 1747 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" Sep 4 23:59:52.459773 kubelet[1747]: I0904 23:59:52.459511 1747 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="kube-system/kube-proxy-7dfxz" podStartSLOduration=3.518311184 podStartE2EDuration="4.459483003s" totalImagesPullingTime="941.171819ms" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-09-04 23:59:48 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-09-04 23:59:50.955069975 +0000 UTC m=+3.263854575" watchObservedRunningTime="2026-09-04 23:59:52.459483003 +0000 UTC m=+4.768267597" Sep 4 23:59:52.562918 containerd[1477]: time="2026-09-04T23:59:52.562745928Z" level=info msg="shim disconnected" id=68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3 namespace=k8s.io Sep 4 23:59:52.562918 containerd[1477]: time="2026-09-04T23:59:52.562791051Z" level=warning msg="cleaning up after shim disconnected" id=68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3 namespace=k8s.io Sep 4 23:59:52.562918 containerd[1477]: time="2026-09-04T23:59:52.562797740Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:59:52.935401 kubelet[1747]: E0904 23:59:52.935189 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:53.020152 kubelet[1747]: E0904 23:59:53.020117 1747 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" Sep 4 23:59:53.021046 containerd[1477]: time="2026-09-04T23:59:53.020972705Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Sep 4 23:59:53.175671 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-68edb6017cc57fc26a0781d247a96d06c61f9f835c23438a3c5e617b8bb202e3-rootfs.mount: Deactivated successfully. Sep 4 23:59:53.936422 kubelet[1747]: E0904 23:59:53.936346 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:54.937523 kubelet[1747]: E0904 23:59:54.937443 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:54.944823 containerd[1477]: time="2026-09-04T23:59:54.944771573Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:54.945630 containerd[1477]: time="2026-09-04T23:59:54.945379374Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Sep 4 23:59:54.946400 containerd[1477]: time="2026-09-04T23:59:54.946364994Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:54.949580 containerd[1477]: time="2026-09-04T23:59:54.949535820Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:59:54.950599 containerd[1477]: time="2026-09-04T23:59:54.950566467Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32996046\" in 1.929530164s" Sep 4 23:59:54.950632 containerd[1477]: time="2026-09-04T23:59:54.950597967Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Sep 4 23:59:54.955266 containerd[1477]: time="2026-09-04T23:59:54.955223647Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Sep 4 23:59:54.965687 containerd[1477]: time="2026-09-04T23:59:54.965642195Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd\"" Sep 4 23:59:54.966183 containerd[1477]: time="2026-09-04T23:59:54.966155602Z" level=info msg="StartContainer for \"dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd\"" Sep 4 23:59:54.992203 systemd[1]: Started cri-containerd-dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd.scope - libcontainer container dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd. Sep 4 23:59:55.010461 systemd[1]: cri-containerd-dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd.scope: Deactivated successfully. Sep 4 23:59:55.012744 containerd[1477]: time="2026-09-04T23:59:55.012677137Z" level=info msg="StartContainer for \"dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd\" returns successfully" Sep 4 23:59:55.017250 kubelet[1747]: E0904 23:59:55.017205 1747 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" Sep 4 23:59:55.024470 kubelet[1747]: E0904 23:59:55.024427 1747 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" Sep 4 23:59:55.028974 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd-rootfs.mount: Deactivated successfully. Sep 4 23:59:55.032003 kubelet[1747]: I0904 23:59:55.031938 1747 kubelet_node_status.go:431] "Fast updating node status as it just became ready" Sep 4 23:59:55.106027 containerd[1477]: time="2026-09-04T23:59:55.105916516Z" level=info msg="shim disconnected" id=dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd namespace=k8s.io Sep 4 23:59:55.106027 containerd[1477]: time="2026-09-04T23:59:55.105969861Z" level=warning msg="cleaning up after shim disconnected" id=dac3373645602b0c825f59658625bceae1c042701aff877bede47800b55218dd namespace=k8s.io Sep 4 23:59:55.106027 containerd[1477]: time="2026-09-04T23:59:55.105979859Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:59:55.938355 kubelet[1747]: E0904 23:59:55.938193 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:56.027831 kubelet[1747]: E0904 23:59:56.027705 1747 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" Sep 4 23:59:56.033392 containerd[1477]: time="2026-09-04T23:59:56.033345256Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Sep 4 23:59:56.047178 containerd[1477]: time="2026-09-04T23:59:56.047130755Z" level=info msg="CreateContainer within sandbox \"40c8bff0601903571e331909923074d808296dc9bbe0725d2f512fc11bacb06f\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"8c416317728a6d7be560a044684c37942cdf69f62ad2c96b01d1bb740aecf106\"" Sep 4 23:59:56.047873 containerd[1477]: time="2026-09-04T23:59:56.047826249Z" level=info msg="StartContainer for \"8c416317728a6d7be560a044684c37942cdf69f62ad2c96b01d1bb740aecf106\"" Sep 4 23:59:56.076363 systemd[1]: Started cri-containerd-8c416317728a6d7be560a044684c37942cdf69f62ad2c96b01d1bb740aecf106.scope - libcontainer container 8c416317728a6d7be560a044684c37942cdf69f62ad2c96b01d1bb740aecf106. Sep 4 23:59:56.098045 containerd[1477]: time="2026-09-04T23:59:56.096834111Z" level=info msg="StartContainer for \"8c416317728a6d7be560a044684c37942cdf69f62ad2c96b01d1bb740aecf106\" returns successfully" Sep 4 23:59:56.105591 kubelet[1747]: E0904 23:59:56.105543 1747 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" Sep 4 23:59:56.938976 kubelet[1747]: E0904 23:59:56.938842 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:57.168906 systemd-networkd[1409]: flannel.1: Link UP Sep 4 23:59:57.168913 systemd-networkd[1409]: flannel.1: Gained carrier Sep 4 23:59:57.939461 kubelet[1747]: E0904 23:59:57.939304 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:58.940387 kubelet[1747]: E0904 23:59:58.940222 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:59.019493 systemd-networkd[1409]: flannel.1: Gained IPv6LL Sep 4 23:59:59.641825 kubelet[1747]: I0904 23:59:59.641717 1747 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-5sb6n" podStartSLOduration=7.303386359 podStartE2EDuration="11.641685561s" totalImagesPullingTime="4.338299202s" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-09-04 23:59:48 +0000 UTC" imagePullSessionsCount=2 imagePullSessionsStartsCount=0 observedRunningTime="2026-09-04 23:59:56.121688396 +0000 UTC m=+8.430472979" watchObservedRunningTime="2026-09-04 23:59:59.641685561 +0000 UTC m=+11.950470145" Sep 4 23:59:59.651868 systemd[1]: Created slice kubepods-besteffort-podf4d5d863_4aca_45f2_b92d_0da772e67091.slice - libcontainer container kubepods-besteffort-podf4d5d863_4aca_45f2_b92d_0da772e67091.slice. Sep 4 23:59:59.657817 kubelet[1747]: E0904 23:59:59.657572 1747 status_manager.go:1164] "Failed to get status for pod" err="pods \"nginx-deployment-85fb466b-7cddd\" is forbidden: User \"system:node:10.0.0.32\" cannot get resource \"pods\" in API group \"\" in the namespace \"default\": no relationship found between node '10.0.0.32' and this object" podUID="f4d5d863-4aca-45f2-b92d-0da772e67091" pod="default/nginx-deployment-85fb466b-7cddd" Sep 4 23:59:59.767367 kubelet[1747]: I0904 23:59:59.767249 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-jlq65\" (UniqueName: \"kubernetes.io/projected/f4d5d863-4aca-45f2-b92d-0da772e67091-kube-api-access-jlq65\") pod \"nginx-deployment-85fb466b-7cddd\" (UID: \"f4d5d863-4aca-45f2-b92d-0da772e67091\") " pod="default/nginx-deployment-85fb466b-7cddd" Sep 4 23:59:59.940820 kubelet[1747]: E0904 23:59:59.940598 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:59:59.959370 containerd[1477]: time="2026-09-04T23:59:59.959318588Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85fb466b-7cddd,Uid:f4d5d863-4aca-45f2-b92d-0da772e67091,Namespace:default,Attempt:0,}" Sep 4 23:59:59.984392 systemd-networkd[1409]: cni0: Link UP Sep 4 23:59:59.984397 systemd-networkd[1409]: cni0: Gained carrier Sep 4 23:59:59.985661 systemd-networkd[1409]: cni0: Lost carrier Sep 4 23:59:59.992634 systemd-networkd[1409]: veth9f694f39: Link UP Sep 4 23:59:59.994788 kernel: cni0: port 1(veth9f694f39) entered blocking state Sep 4 23:59:59.994870 kernel: cni0: port 1(veth9f694f39) entered disabled state Sep 4 23:59:59.994886 kernel: veth9f694f39: entered allmulticast mode Sep 4 23:59:59.996555 kernel: veth9f694f39: entered promiscuous mode Sep 4 23:59:59.997643 kernel: cni0: port 1(veth9f694f39) entered blocking state Sep 4 23:59:59.997688 kernel: cni0: port 1(veth9f694f39) entered forwarding state Sep 4 23:59:59.999854 kernel: cni0: port 1(veth9f694f39) entered disabled state Sep 5 00:00:00.008954 systemd-networkd[1409]: veth9f694f39: Gained carrier Sep 5 00:00:00.009301 kernel: cni0: port 1(veth9f694f39) entered blocking state Sep 5 00:00:00.009349 kernel: cni0: port 1(veth9f694f39) entered forwarding state Sep 5 00:00:00.009537 systemd-networkd[1409]: cni0: Gained carrier Sep 5 00:00:00.010177 systemd[1]: Started logrotate.service - Rotate and Compress System Logs. Sep 5 00:00:00.013875 containerd[1477]: 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)(0xc00008a950), "name":"cbr0", "type":"bridge"} Sep 5 00:00:00.013875 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Sep 5 00:00:00.016817 systemd[1]: logrotate.service: Deactivated successfully. Sep 5 00:00:00.045715 containerd[1477]: {"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-09-05T00:00:00.045417665Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 5 00:00:00.045715 containerd[1477]: time="2026-09-05T00:00:00.045597057Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 5 00:00:00.045715 containerd[1477]: time="2026-09-05T00:00:00.045611495Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:00.045715 containerd[1477]: time="2026-09-05T00:00:00.045710175Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:00.081065 systemd[1]: Started cri-containerd-8523da0b16b5d46e48253881c26ecd8e7d13ccacacb485f520ccd15c068de9e5.scope - libcontainer container 8523da0b16b5d46e48253881c26ecd8e7d13ccacacb485f520ccd15c068de9e5. Sep 5 00:00:00.123860 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 00:00:00.149383 containerd[1477]: time="2026-09-05T00:00:00.149330198Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85fb466b-7cddd,Uid:f4d5d863-4aca-45f2-b92d-0da772e67091,Namespace:default,Attempt:0,} returns sandbox id \"8523da0b16b5d46e48253881c26ecd8e7d13ccacacb485f520ccd15c068de9e5\"" Sep 5 00:00:00.150790 containerd[1477]: time="2026-09-05T00:00:00.150754836Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 5 00:00:00.941962 kubelet[1747]: E0905 00:00:00.941685 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:01.326339 systemd-networkd[1409]: cni0: Gained IPv6LL Sep 5 00:00:01.836355 systemd-networkd[1409]: veth9f694f39: Gained IPv6LL Sep 5 00:00:01.942823 kubelet[1747]: E0905 00:00:01.942661 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:02.943672 kubelet[1747]: E0905 00:00:02.943585 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:03.944833 kubelet[1747]: E0905 00:00:03.944639 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:04.945051 kubelet[1747]: E0905 00:00:04.944974 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:05.945619 kubelet[1747]: E0905 00:00:05.945556 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:06.019827 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3961698490.mount: Deactivated successfully. Sep 5 00:00:06.946653 kubelet[1747]: E0905 00:00:06.946606 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:07.933250 kubelet[1747]: E0905 00:00:07.932323 1747 file.go:103] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:07.950716 kubelet[1747]: E0905 00:00:07.950558 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:08.537070 containerd[1477]: time="2026-09-05T00:00:08.535783118Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:08.543582 containerd[1477]: time="2026-09-05T00:00:08.543332683Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=64128731" Sep 5 00:00:08.547352 containerd[1477]: time="2026-09-05T00:00:08.547118583Z" level=info msg="ImageCreate event name:\"sha256:ba5b7c1c189a2f9add5350a57010cc38faaeeb3bb3aed5c2bcfb96a37bd5f773\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:08.554015 containerd[1477]: time="2026-09-05T00:00:08.553894197Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:08.555313 containerd[1477]: time="2026-09-05T00:00:08.555213306Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:ba5b7c1c189a2f9add5350a57010cc38faaeeb3bb3aed5c2bcfb96a37bd5f773\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"64128609\" in 8.404415942s" Sep 5 00:00:08.555313 containerd[1477]: time="2026-09-05T00:00:08.555266896Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:ba5b7c1c189a2f9add5350a57010cc38faaeeb3bb3aed5c2bcfb96a37bd5f773\"" Sep 5 00:00:08.584226 containerd[1477]: time="2026-09-05T00:00:08.582262234Z" level=info msg="CreateContainer within sandbox \"8523da0b16b5d46e48253881c26ecd8e7d13ccacacb485f520ccd15c068de9e5\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Sep 5 00:00:08.622696 containerd[1477]: time="2026-09-05T00:00:08.622607719Z" level=info msg="CreateContainer within sandbox \"8523da0b16b5d46e48253881c26ecd8e7d13ccacacb485f520ccd15c068de9e5\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"ba683d4cdb25b7d134aeeeeca7af1508aa4067d43b81a7552715ba020134af33\"" Sep 5 00:00:08.624474 containerd[1477]: time="2026-09-05T00:00:08.624439993Z" level=info msg="StartContainer for \"ba683d4cdb25b7d134aeeeeca7af1508aa4067d43b81a7552715ba020134af33\"" Sep 5 00:00:08.854395 systemd[1]: Started cri-containerd-ba683d4cdb25b7d134aeeeeca7af1508aa4067d43b81a7552715ba020134af33.scope - libcontainer container ba683d4cdb25b7d134aeeeeca7af1508aa4067d43b81a7552715ba020134af33. Sep 5 00:00:08.945573 containerd[1477]: time="2026-09-05T00:00:08.945400014Z" level=info msg="StartContainer for \"ba683d4cdb25b7d134aeeeeca7af1508aa4067d43b81a7552715ba020134af33\" returns successfully" Sep 5 00:00:08.955186 kubelet[1747]: E0905 00:00:08.954379 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:09.957206 kubelet[1747]: E0905 00:00:09.955975 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:10.957689 kubelet[1747]: E0905 00:00:10.957391 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:11.958500 kubelet[1747]: E0905 00:00:11.958396 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:12.960695 kubelet[1747]: E0905 00:00:12.960452 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:13.961329 kubelet[1747]: E0905 00:00:13.961211 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:14.483710 kubelet[1747]: I0905 00:00:14.483630 1747 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="default/nginx-deployment-85fb466b-7cddd" podStartSLOduration=7.072703058 podStartE2EDuration="15.483613302s" totalImagesPullingTime="8.410910244s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-09-04 23:59:59 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-09-05 00:00:09.018430481 +0000 UTC m=+21.327215077" watchObservedRunningTime="2026-09-05 00:00:14.483613302 +0000 UTC m=+26.792397895" Sep 5 00:00:14.493124 systemd[1]: Created slice kubepods-besteffort-poda98a2480_a0c3_4f48_b115_913129757cc3.slice - libcontainer container kubepods-besteffort-poda98a2480_a0c3_4f48_b115_913129757cc3.slice. Sep 5 00:00:14.644632 kubelet[1747]: I0905 00:00:14.644577 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-tpm97\" (UniqueName: \"kubernetes.io/projected/a98a2480-a0c3-4f48-b115-913129757cc3-kube-api-access-tpm97\") pod \"nfs-server-provisioner-0\" (UID: \"a98a2480-a0c3-4f48-b115-913129757cc3\") " pod="default/nfs-server-provisioner-0" Sep 5 00:00:14.644632 kubelet[1747]: I0905 00:00:14.644632 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/a98a2480-a0c3-4f48-b115-913129757cc3-data\") pod \"nfs-server-provisioner-0\" (UID: \"a98a2480-a0c3-4f48-b115-913129757cc3\") " pod="default/nfs-server-provisioner-0" Sep 5 00:00:14.800195 containerd[1477]: time="2026-09-05T00:00:14.799888579Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a98a2480-a0c3-4f48-b115-913129757cc3,Namespace:default,Attempt:0,}" Sep 5 00:00:14.831599 systemd-networkd[1409]: veth4015a57c: Link UP Sep 5 00:00:14.834808 kernel: cni0: port 2(veth4015a57c) entered blocking state Sep 5 00:00:14.834942 kernel: cni0: port 2(veth4015a57c) entered disabled state Sep 5 00:00:14.834977 kernel: veth4015a57c: entered allmulticast mode Sep 5 00:00:14.837294 kernel: veth4015a57c: entered promiscuous mode Sep 5 00:00:14.850843 kernel: cni0: port 2(veth4015a57c) entered blocking state Sep 5 00:00:14.851157 kernel: cni0: port 2(veth4015a57c) entered forwarding state Sep 5 00:00:14.850979 systemd-networkd[1409]: veth4015a57c: Gained carrier Sep 5 00:00:14.892613 containerd[1477]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Sep 5 00:00:14.892613 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Sep 5 00:00:14.961646 containerd[1477]: {"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-09-05T00:00:14.961366299Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 5 00:00:14.961646 containerd[1477]: time="2026-09-05T00:00:14.961467803Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 5 00:00:14.961646 containerd[1477]: time="2026-09-05T00:00:14.961484664Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:14.961646 containerd[1477]: time="2026-09-05T00:00:14.961596749Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:14.961908 kubelet[1747]: E0905 00:00:14.961730 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:14.997043 systemd[1]: Started cri-containerd-2419f743dbb43c163bb06afe587986d6fbbf305154197194c0f5c2abc24f3871.scope - libcontainer container 2419f743dbb43c163bb06afe587986d6fbbf305154197194c0f5c2abc24f3871. Sep 5 00:00:15.020442 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 00:00:15.093591 containerd[1477]: time="2026-09-05T00:00:15.093451012Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a98a2480-a0c3-4f48-b115-913129757cc3,Namespace:default,Attempt:0,} returns sandbox id \"2419f743dbb43c163bb06afe587986d6fbbf305154197194c0f5c2abc24f3871\"" Sep 5 00:00:15.096107 containerd[1477]: time="2026-09-05T00:00:15.095958260Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Sep 5 00:00:15.996021 kubelet[1747]: E0905 00:00:15.995905 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:16.107562 systemd-networkd[1409]: veth4015a57c: Gained IPv6LL Sep 5 00:00:16.996668 kubelet[1747]: E0905 00:00:16.996541 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:17.083200 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1309485677.mount: Deactivated successfully. Sep 5 00:00:18.010129 kubelet[1747]: E0905 00:00:18.010065 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:19.010354 kubelet[1747]: E0905 00:00:19.010268 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:19.630361 containerd[1477]: time="2026-09-05T00:00:19.630280457Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:19.631094 containerd[1477]: time="2026-09-05T00:00:19.631048604Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039378" Sep 5 00:00:19.631865 containerd[1477]: time="2026-09-05T00:00:19.631833487Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:19.634881 containerd[1477]: time="2026-09-05T00:00:19.634828169Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:19.635922 containerd[1477]: time="2026-09-05T00:00:19.635884147Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 4.539849568s" Sep 5 00:00:19.636017 containerd[1477]: time="2026-09-05T00:00:19.635927838Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Sep 5 00:00:19.644048 containerd[1477]: time="2026-09-05T00:00:19.643703750Z" level=info msg="CreateContainer within sandbox \"2419f743dbb43c163bb06afe587986d6fbbf305154197194c0f5c2abc24f3871\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Sep 5 00:00:19.663733 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount199505510.mount: Deactivated successfully. Sep 5 00:00:19.669785 containerd[1477]: time="2026-09-05T00:00:19.669709856Z" level=info msg="CreateContainer within sandbox \"2419f743dbb43c163bb06afe587986d6fbbf305154197194c0f5c2abc24f3871\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"d3d1ee5167d4f256bba475de669832f9c12010355f0435ad20d56a2f78bdc4c1\"" Sep 5 00:00:19.672045 containerd[1477]: time="2026-09-05T00:00:19.670884110Z" level=info msg="StartContainer for \"d3d1ee5167d4f256bba475de669832f9c12010355f0435ad20d56a2f78bdc4c1\"" Sep 5 00:00:19.760628 systemd[1]: Started cri-containerd-d3d1ee5167d4f256bba475de669832f9c12010355f0435ad20d56a2f78bdc4c1.scope - libcontainer container d3d1ee5167d4f256bba475de669832f9c12010355f0435ad20d56a2f78bdc4c1. Sep 5 00:00:19.804220 containerd[1477]: time="2026-09-05T00:00:19.804173324Z" level=info msg="StartContainer for \"d3d1ee5167d4f256bba475de669832f9c12010355f0435ad20d56a2f78bdc4c1\" returns successfully" Sep 5 00:00:20.012068 kubelet[1747]: E0905 00:00:20.011875 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:21.012321 kubelet[1747]: E0905 00:00:21.012224 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:22.021932 kubelet[1747]: E0905 00:00:22.021859 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:23.022684 kubelet[1747]: E0905 00:00:23.022587 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:24.025051 kubelet[1747]: E0905 00:00:24.023971 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:24.419556 update_engine[1461]: I20260905 00:00:24.419095 1461 update_attempter.cc:509] Updating boot flags... Sep 5 00:00:24.573190 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (2803) Sep 5 00:00:24.737637 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (2805) Sep 5 00:00:24.765935 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 31 scanned by (udev-worker) (2805) Sep 5 00:00:25.029687 kubelet[1747]: E0905 00:00:25.028852 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:25.315261 kubelet[1747]: I0905 00:00:25.315046 1747 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.772762386 podStartE2EDuration="11.315025088s" totalImagesPullingTime="4.542262702s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-09-05 00:00:14 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-09-05 00:00:19.824780355 +0000 UTC m=+32.133564945" watchObservedRunningTime="2026-09-05 00:00:25.315025088 +0000 UTC m=+37.623809687" Sep 5 00:00:25.356198 systemd[1]: Created slice kubepods-besteffort-podb3266814_3c6c_4501_9498_eed4b45316f2.slice - libcontainer container kubepods-besteffort-podb3266814_3c6c_4501_9498_eed4b45316f2.slice. Sep 5 00:00:25.501600 kubelet[1747]: I0905 00:00:25.499783 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-tt6tx\" (UniqueName: \"kubernetes.io/projected/b3266814-3c6c-4501-9498-eed4b45316f2-kube-api-access-tt6tx\") pod \"test-pod-1\" (UID: \"b3266814-3c6c-4501-9498-eed4b45316f2\") " pod="default/test-pod-1" Sep 5 00:00:25.506530 kubelet[1747]: I0905 00:00:25.505628 1747 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-58a125dd-94a7-4625-9b4b-6db939e1f04e\" (UniqueName: \"kubernetes.io/nfs/b3266814-3c6c-4501-9498-eed4b45316f2-pvc-58a125dd-94a7-4625-9b4b-6db939e1f04e\") pod \"test-pod-1\" (UID: \"b3266814-3c6c-4501-9498-eed4b45316f2\") " pod="default/test-pod-1" Sep 5 00:00:25.763797 kernel: FS-Cache: Loaded Sep 5 00:00:25.902436 kernel: RPC: Registered named UNIX socket transport module. Sep 5 00:00:25.902628 kernel: RPC: Registered udp transport module. Sep 5 00:00:25.906574 kernel: RPC: Registered tcp transport module. Sep 5 00:00:25.906645 kernel: RPC: Registered tcp-with-tls transport module. Sep 5 00:00:25.907412 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 5 00:00:26.031073 kubelet[1747]: E0905 00:00:26.030662 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:26.396753 kernel: NFS: Registering the id_resolver key type Sep 5 00:00:26.397101 kernel: Key type id_resolver registered Sep 5 00:00:26.397132 kernel: Key type id_legacy registered Sep 5 00:00:26.505951 nfsidmap[2825]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Sep 5 00:00:26.521374 nfsidmap[2828]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Sep 5 00:00:26.583321 containerd[1477]: time="2026-09-05T00:00:26.583210295Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:b3266814-3c6c-4501-9498-eed4b45316f2,Namespace:default,Attempt:0,}" Sep 5 00:00:26.693408 systemd-networkd[1409]: veth36ed9c04: Link UP Sep 5 00:00:26.702622 kernel: cni0: port 3(veth36ed9c04) entered blocking state Sep 5 00:00:26.702735 kernel: cni0: port 3(veth36ed9c04) entered disabled state Sep 5 00:00:26.702760 kernel: veth36ed9c04: entered allmulticast mode Sep 5 00:00:26.702780 kernel: veth36ed9c04: entered promiscuous mode Sep 5 00:00:26.747316 kernel: cni0: port 3(veth36ed9c04) entered blocking state Sep 5 00:00:26.747444 kernel: cni0: port 3(veth36ed9c04) entered forwarding state Sep 5 00:00:26.744405 systemd-networkd[1409]: veth36ed9c04: Gained carrier Sep 5 00:00:26.790231 containerd[1477]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Sep 5 00:00:26.790231 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Sep 5 00:00:26.920629 containerd[1477]: {"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-09-05T00:00:26.918356317Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 5 00:00:26.920629 containerd[1477]: time="2026-09-05T00:00:26.918459160Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 5 00:00:26.920629 containerd[1477]: time="2026-09-05T00:00:26.918478765Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:26.920629 containerd[1477]: time="2026-09-05T00:00:26.918718006Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 5 00:00:27.008367 systemd[1]: Started cri-containerd-93a679dd62c68ef814d4dbb48f4bc7bf22744a8a7996bea92ce364a99faf928c.scope - libcontainer container 93a679dd62c68ef814d4dbb48f4bc7bf22744a8a7996bea92ce364a99faf928c. Sep 5 00:00:27.031781 kubelet[1747]: E0905 00:00:27.031718 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:27.051223 systemd-resolved[1349]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 00:00:27.128285 containerd[1477]: time="2026-09-05T00:00:27.124858370Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:b3266814-3c6c-4501-9498-eed4b45316f2,Namespace:default,Attempt:0,} returns sandbox id \"93a679dd62c68ef814d4dbb48f4bc7bf22744a8a7996bea92ce364a99faf928c\"" Sep 5 00:00:27.132396 containerd[1477]: time="2026-09-05T00:00:27.131072761Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 5 00:00:27.931473 kubelet[1747]: E0905 00:00:27.931340 1747 file.go:103] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:28.032162 kubelet[1747]: E0905 00:00:28.032091 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:28.139587 systemd-networkd[1409]: veth36ed9c04: Gained IPv6LL Sep 5 00:00:29.033647 kubelet[1747]: E0905 00:00:29.033393 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:30.035197 kubelet[1747]: E0905 00:00:30.034943 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:30.074354 containerd[1477]: time="2026-09-05T00:00:30.074256360Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 5 00:00:30.075078 containerd[1477]: time="2026-09-05T00:00:30.074866077Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Sep 5 00:00:30.080739 containerd[1477]: time="2026-09-05T00:00:30.080507060Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:ba5b7c1c189a2f9add5350a57010cc38faaeeb3bb3aed5c2bcfb96a37bd5f773\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"64128609\" in 2.949293737s" Sep 5 00:00:30.080739 containerd[1477]: time="2026-09-05T00:00:30.080750704Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:ba5b7c1c189a2f9add5350a57010cc38faaeeb3bb3aed5c2bcfb96a37bd5f773\"" Sep 5 00:00:30.088454 containerd[1477]: time="2026-09-05T00:00:30.088362520Z" level=info msg="CreateContainer within sandbox \"93a679dd62c68ef814d4dbb48f4bc7bf22744a8a7996bea92ce364a99faf928c\" for container &ContainerMetadata{Name:test,Attempt:0,}" Sep 5 00:00:30.110621 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2936884398.mount: Deactivated successfully. Sep 5 00:00:30.124566 containerd[1477]: time="2026-09-05T00:00:30.124317298Z" level=info msg="CreateContainer within sandbox \"93a679dd62c68ef814d4dbb48f4bc7bf22744a8a7996bea92ce364a99faf928c\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"c439ce3c3434cc6c94378d164e70b698f7346d7cccdc1efbf4add47fe5854c51\"" Sep 5 00:00:30.125817 containerd[1477]: time="2026-09-05T00:00:30.125776683Z" level=info msg="StartContainer for \"c439ce3c3434cc6c94378d164e70b698f7346d7cccdc1efbf4add47fe5854c51\"" Sep 5 00:00:30.342370 systemd[1]: Started cri-containerd-c439ce3c3434cc6c94378d164e70b698f7346d7cccdc1efbf4add47fe5854c51.scope - libcontainer container c439ce3c3434cc6c94378d164e70b698f7346d7cccdc1efbf4add47fe5854c51. Sep 5 00:00:30.637312 containerd[1477]: time="2026-09-05T00:00:30.636778733Z" level=info msg="StartContainer for \"c439ce3c3434cc6c94378d164e70b698f7346d7cccdc1efbf4add47fe5854c51\" returns successfully" Sep 5 00:00:31.036520 kubelet[1747]: E0905 00:00:31.036305 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:32.036957 kubelet[1747]: E0905 00:00:32.036863 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:33.037532 kubelet[1747]: E0905 00:00:33.037320 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:34.043605 kubelet[1747]: E0905 00:00:34.043346 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 5 00:00:35.045072 kubelet[1747]: E0905 00:00:35.044924 1747 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"