Oct 16 23:41:06.853714 kernel: Linux version 6.6.157-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 Oct 16 22:12:49 -00 2026 Oct 16 23:41:06.853732 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=e6f976cfb3863fee9fd1f1addd18d31ce811d92bc04253d21ae5d2ad4890c977 Oct 16 23:41:06.853741 kernel: BIOS-provided physical RAM map: Oct 16 23:41:06.853775 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Oct 16 23:41:06.853780 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Oct 16 23:41:06.853785 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Oct 16 23:41:06.853791 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Oct 16 23:41:06.853796 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Oct 16 23:41:06.853801 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Oct 16 23:41:06.853806 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Oct 16 23:41:06.853812 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Oct 16 23:41:06.853819 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Oct 16 23:41:06.853824 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Oct 16 23:41:06.853829 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Oct 16 23:41:06.853836 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Oct 16 23:41:06.853841 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Oct 16 23:41:06.853848 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Oct 16 23:41:06.853854 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Oct 16 23:41:06.853859 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Oct 16 23:41:06.853864 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Oct 16 23:41:06.853870 kernel: NX (Execute Disable) protection: active Oct 16 23:41:06.853875 kernel: APIC: Static calls initialized Oct 16 23:41:06.853880 kernel: efi: EFI v2.7 by EDK II Oct 16 23:41:06.853886 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b675198 Oct 16 23:41:06.853891 kernel: SMBIOS 2.8 present. Oct 16 23:41:06.853897 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Oct 16 23:41:06.853902 kernel: Hypervisor detected: KVM Oct 16 23:41:06.853908 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 16 23:41:06.853914 kernel: kvm-clock: using sched offset of 4430583294 cycles Oct 16 23:41:06.853920 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 16 23:41:06.853926 kernel: tsc: Detected 2793.438 MHz processor Oct 16 23:41:06.853932 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 16 23:41:06.853938 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 16 23:41:06.853944 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x10000000000 Oct 16 23:41:06.853949 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Oct 16 23:41:06.853955 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 16 23:41:06.853961 kernel: Using GB pages for direct mapping Oct 16 23:41:06.853968 kernel: Secure boot disabled Oct 16 23:41:06.853973 kernel: ACPI: Early table checksum verification disabled Oct 16 23:41:06.853979 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Oct 16 23:41:06.853988 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Oct 16 23:41:06.853994 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854000 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854006 kernel: ACPI: FACS 0x000000009CBDD000 000040 Oct 16 23:41:06.854011 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854016 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854021 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854026 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 16 23:41:06.854031 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Oct 16 23:41:06.854035 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Oct 16 23:41:06.854040 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Oct 16 23:41:06.854046 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Oct 16 23:41:06.854051 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Oct 16 23:41:06.854056 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Oct 16 23:41:06.854061 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Oct 16 23:41:06.854066 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Oct 16 23:41:06.854071 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Oct 16 23:41:06.854076 kernel: No NUMA configuration found Oct 16 23:41:06.854081 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Oct 16 23:41:06.854086 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Oct 16 23:41:06.854092 kernel: Zone ranges: Oct 16 23:41:06.854097 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 16 23:41:06.854101 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Oct 16 23:41:06.854106 kernel: Normal empty Oct 16 23:41:06.854111 kernel: Movable zone start for each node Oct 16 23:41:06.854116 kernel: Early memory node ranges Oct 16 23:41:06.854121 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Oct 16 23:41:06.854126 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Oct 16 23:41:06.854131 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Oct 16 23:41:06.854136 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Oct 16 23:41:06.854142 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Oct 16 23:41:06.854166 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Oct 16 23:41:06.854171 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Oct 16 23:41:06.854176 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 16 23:41:06.854180 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 16 23:41:06.854185 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Oct 16 23:41:06.854190 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 16 23:41:06.854195 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Oct 16 23:41:06.854200 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Oct 16 23:41:06.854207 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Oct 16 23:41:06.854212 kernel: ACPI: PM-Timer IO Port: 0x608 Oct 16 23:41:06.854217 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 16 23:41:06.854221 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 16 23:41:06.854226 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 16 23:41:06.854231 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 16 23:41:06.854236 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 16 23:41:06.854241 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 16 23:41:06.854246 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 16 23:41:06.854252 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 16 23:41:06.854257 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 16 23:41:06.854262 kernel: TSC deadline timer available Oct 16 23:41:06.854267 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Oct 16 23:41:06.854272 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Oct 16 23:41:06.854276 kernel: kvm-guest: KVM setup pv remote TLB flush Oct 16 23:41:06.854281 kernel: kvm-guest: setup PV sched yield Oct 16 23:41:06.854286 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Oct 16 23:41:06.854291 kernel: Booting paravirtualized kernel on KVM Oct 16 23:41:06.854297 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 16 23:41:06.854302 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Oct 16 23:41:06.854307 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u524288 Oct 16 23:41:06.854312 kernel: pcpu-alloc: s196392 r8192 d28888 u524288 alloc=1*2097152 Oct 16 23:41:06.854317 kernel: pcpu-alloc: [0] 0 1 2 3 Oct 16 23:41:06.854322 kernel: kvm-guest: PV spinlocks enabled Oct 16 23:41:06.854327 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 16 23:41:06.854332 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=e6f976cfb3863fee9fd1f1addd18d31ce811d92bc04253d21ae5d2ad4890c977 Oct 16 23:41:06.854338 kernel: random: crng init done Oct 16 23:41:06.854344 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 16 23:41:06.854349 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 16 23:41:06.854354 kernel: Fallback order for Node 0: 0 Oct 16 23:41:06.854359 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Oct 16 23:41:06.854363 kernel: Policy zone: DMA32 Oct 16 23:41:06.854368 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 16 23:41:06.854374 kernel: Memory: 2397612K/2567000K available (14336K kernel code, 2288K rwdata, 22772K rodata, 42928K init, 2228K bss, 169184K reserved, 0K cma-reserved) Oct 16 23:41:06.854379 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 16 23:41:06.854385 kernel: ftrace: allocating 37511 entries in 148 pages Oct 16 23:41:06.854390 kernel: ftrace: allocated 148 pages with 3 groups Oct 16 23:41:06.854395 kernel: Dynamic Preempt: voluntary Oct 16 23:41:06.854400 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 16 23:41:06.854410 kernel: rcu: RCU event tracing is enabled. Oct 16 23:41:06.854417 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 16 23:41:06.854423 kernel: Trampoline variant of Tasks RCU enabled. Oct 16 23:41:06.854428 kernel: Rude variant of Tasks RCU enabled. Oct 16 23:41:06.854433 kernel: Tracing variant of Tasks RCU enabled. Oct 16 23:41:06.854439 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 16 23:41:06.854444 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 16 23:41:06.854450 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Oct 16 23:41:06.854457 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 16 23:41:06.854462 kernel: Console: colour dummy device 80x25 Oct 16 23:41:06.854467 kernel: printk: console [ttyS0] enabled Oct 16 23:41:06.854473 kernel: ACPI: Core revision 20230628 Oct 16 23:41:06.854478 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Oct 16 23:41:06.854485 kernel: APIC: Switch to symmetric I/O mode setup Oct 16 23:41:06.854491 kernel: x2apic enabled Oct 16 23:41:06.854496 kernel: APIC: Switched APIC routing to: physical x2apic Oct 16 23:41:06.854501 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Oct 16 23:41:06.854507 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Oct 16 23:41:06.854512 kernel: kvm-guest: setup PV IPIs Oct 16 23:41:06.854518 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 16 23:41:06.854523 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Oct 16 23:41:06.854528 kernel: Calibrating delay loop (skipped) preset value.. 5586.87 BogoMIPS (lpj=2793438) Oct 16 23:41:06.854536 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 16 23:41:06.854541 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Oct 16 23:41:06.854546 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Oct 16 23:41:06.854552 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 16 23:41:06.854558 kernel: Spectre V2 : Mitigation: Retpolines Oct 16 23:41:06.854570 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Oct 16 23:41:06.854579 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Oct 16 23:41:06.854588 kernel: RETBleed: Vulnerable Oct 16 23:41:06.854599 kernel: Speculative Store Bypass: Vulnerable Oct 16 23:41:06.854610 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Oct 16 23:41:06.854618 kernel: GDS: Unknown: Dependent on hypervisor status Oct 16 23:41:06.854623 kernel: active return thunk: its_return_thunk Oct 16 23:41:06.854628 kernel: ITS: Mitigation: Aligned branch/return thunks Oct 16 23:41:06.854634 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 16 23:41:06.854648 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 16 23:41:06.854654 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 16 23:41:06.854659 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Oct 16 23:41:06.854665 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Oct 16 23:41:06.854672 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Oct 16 23:41:06.854677 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 16 23:41:06.854683 kernel: x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64 Oct 16 23:41:06.854688 kernel: x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512 Oct 16 23:41:06.854694 kernel: x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024 Oct 16 23:41:06.854699 kernel: x86/fpu: Enabled xstate features 0xe7, context size is 2432 bytes, using 'compacted' format. Oct 16 23:41:06.854704 kernel: Freeing SMP alternatives memory: 32K Oct 16 23:41:06.854710 kernel: pid_max: default: 32768 minimum: 301 Oct 16 23:41:06.854715 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Oct 16 23:41:06.854722 kernel: landlock: Up and running. Oct 16 23:41:06.854728 kernel: SELinux: Initializing. Oct 16 23:41:06.854733 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:41:06.854739 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 16 23:41:06.854762 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8370C CPU @ 2.80GHz (family: 0x6, model: 0x6a, stepping: 0x6) Oct 16 23:41:06.854768 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 16 23:41:06.854774 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 16 23:41:06.854779 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 16 23:41:06.854785 kernel: Performance Events: unsupported p6 CPU model 106 no PMU driver, software events only. Oct 16 23:41:06.854792 kernel: signal: max sigframe size: 3632 Oct 16 23:41:06.854798 kernel: rcu: Hierarchical SRCU implementation. Oct 16 23:41:06.854813 kernel: rcu: Max phase no-delay instances is 400. Oct 16 23:41:06.854819 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Oct 16 23:41:06.854824 kernel: smp: Bringing up secondary CPUs ... Oct 16 23:41:06.854830 kernel: smpboot: x86: Booting SMP configuration: Oct 16 23:41:06.854835 kernel: .... node #0, CPUs: #1 #2 #3 Oct 16 23:41:06.854841 kernel: smp: Brought up 1 node, 4 CPUs Oct 16 23:41:06.854846 kernel: smpboot: Max logical packages: 1 Oct 16 23:41:06.854853 kernel: smpboot: Total of 4 processors activated (22347.50 BogoMIPS) Oct 16 23:41:06.854859 kernel: devtmpfs: initialized Oct 16 23:41:06.854864 kernel: x86/mm: Memory block size: 128MB Oct 16 23:41:06.854870 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Oct 16 23:41:06.854876 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Oct 16 23:41:06.854881 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Oct 16 23:41:06.854887 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Oct 16 23:41:06.854892 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Oct 16 23:41:06.854898 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 16 23:41:06.854905 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 16 23:41:06.854910 kernel: pinctrl core: initialized pinctrl subsystem Oct 16 23:41:06.854916 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 16 23:41:06.854921 kernel: audit: initializing netlink subsys (disabled) Oct 16 23:41:06.854927 kernel: audit: type=2000 audit(1792194066.203:1): state=initialized audit_enabled=0 res=1 Oct 16 23:41:06.854932 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 16 23:41:06.854938 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 16 23:41:06.854943 kernel: cpuidle: using governor menu Oct 16 23:41:06.854949 kernel: efi: Freeing EFI boot services memory: 29232K Oct 16 23:41:06.854955 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 16 23:41:06.854961 kernel: dca service started, version 1.12.1 Oct 16 23:41:06.854966 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Oct 16 23:41:06.854972 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Oct 16 23:41:06.854978 kernel: PCI: Using configuration type 1 for base access Oct 16 23:41:06.854983 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 16 23:41:06.854989 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 16 23:41:06.854994 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 16 23:41:06.855001 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 16 23:41:06.855007 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 16 23:41:06.855012 kernel: ACPI: Added _OSI(Module Device) Oct 16 23:41:06.855018 kernel: ACPI: Added _OSI(Processor Device) Oct 16 23:41:06.855023 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 16 23:41:06.855052 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 16 23:41:06.855058 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Oct 16 23:41:06.855064 kernel: ACPI: Interpreter enabled Oct 16 23:41:06.855069 kernel: ACPI: PM: (supports S0 S3 S5) Oct 16 23:41:06.855075 kernel: ACPI: Using IOAPIC for interrupt routing Oct 16 23:41:06.855082 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 16 23:41:06.855088 kernel: PCI: Using E820 reservations for host bridge windows Oct 16 23:41:06.855093 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Oct 16 23:41:06.855099 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 16 23:41:06.855253 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 16 23:41:06.855330 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Oct 16 23:41:06.855387 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Oct 16 23:41:06.855396 kernel: PCI host bridge to bus 0000:00 Oct 16 23:41:06.855454 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 16 23:41:06.855504 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 16 23:41:06.855552 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 16 23:41:06.855624 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Oct 16 23:41:06.855674 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Oct 16 23:41:06.855721 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Oct 16 23:41:06.855801 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 16 23:41:06.855874 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Oct 16 23:41:06.855934 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Oct 16 23:41:06.855990 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Oct 16 23:41:06.856044 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Oct 16 23:41:06.856130 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Oct 16 23:41:06.856286 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Oct 16 23:41:06.856373 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 16 23:41:06.856439 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Oct 16 23:41:06.856507 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Oct 16 23:41:06.856572 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Oct 16 23:41:06.856649 kernel: pci 0000:00:02.0: BAR 4 [mem 0x800000000-0x800003fff 64bit pref] Oct 16 23:41:06.856709 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Oct 16 23:41:06.856794 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Oct 16 23:41:06.856851 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Oct 16 23:41:06.856905 kernel: pci 0000:00:03.0: BAR 4 [mem 0x800004000-0x800007fff 64bit pref] Oct 16 23:41:06.856964 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Oct 16 23:41:06.857019 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Oct 16 23:41:06.857073 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Oct 16 23:41:06.857136 kernel: pci 0000:00:04.0: BAR 4 [mem 0x800008000-0x80000bfff 64bit pref] Oct 16 23:41:06.857394 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Oct 16 23:41:06.857519 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Oct 16 23:41:06.857677 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Oct 16 23:41:06.859234 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Oct 16 23:41:06.859329 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Oct 16 23:41:06.859390 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Oct 16 23:41:06.859453 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Oct 16 23:41:06.859515 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Oct 16 23:41:06.859523 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 16 23:41:06.859529 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 16 23:41:06.859535 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 16 23:41:06.859540 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 16 23:41:06.859546 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Oct 16 23:41:06.859552 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Oct 16 23:41:06.859557 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Oct 16 23:41:06.859564 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Oct 16 23:41:06.859570 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Oct 16 23:41:06.859575 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Oct 16 23:41:06.859581 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Oct 16 23:41:06.859586 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Oct 16 23:41:06.859592 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Oct 16 23:41:06.859597 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Oct 16 23:41:06.859614 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Oct 16 23:41:06.859619 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Oct 16 23:41:06.859635 kernel: iommu: Default domain type: Translated Oct 16 23:41:06.859641 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 16 23:41:06.859646 kernel: efivars: Registered efivars operations Oct 16 23:41:06.859652 kernel: PCI: Using ACPI for IRQ routing Oct 16 23:41:06.859657 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 16 23:41:06.859663 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Oct 16 23:41:06.859668 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Oct 16 23:41:06.859674 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Oct 16 23:41:06.859679 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Oct 16 23:41:06.859742 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Oct 16 23:41:06.859819 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Oct 16 23:41:06.859875 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 16 23:41:06.859882 kernel: vgaarb: loaded Oct 16 23:41:06.859888 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 16 23:41:06.859893 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Oct 16 23:41:06.859899 kernel: clocksource: Switched to clocksource kvm-clock Oct 16 23:41:06.859904 kernel: VFS: Disk quotas dquot_6.6.0 Oct 16 23:41:06.859910 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 16 23:41:06.859918 kernel: pnp: PnP ACPI init Oct 16 23:41:06.859980 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Oct 16 23:41:06.859988 kernel: pnp: PnP ACPI: found 6 devices Oct 16 23:41:06.859994 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 16 23:41:06.859999 kernel: NET: Registered PF_INET protocol family Oct 16 23:41:06.860005 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 16 23:41:06.860011 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 16 23:41:06.860017 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 16 23:41:06.860024 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 16 23:41:06.860029 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 16 23:41:06.860035 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 16 23:41:06.860041 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:41:06.860046 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 16 23:41:06.860051 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 16 23:41:06.860057 kernel: NET: Registered PF_XDP protocol family Oct 16 23:41:06.860113 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Oct 16 23:41:06.860197 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Oct 16 23:41:06.860254 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 16 23:41:06.860305 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 16 23:41:06.860355 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 16 23:41:06.860403 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Oct 16 23:41:06.860452 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Oct 16 23:41:06.860501 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Oct 16 23:41:06.860508 kernel: PCI: CLS 0 bytes, default 64 Oct 16 23:41:06.860516 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Oct 16 23:41:06.860521 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x284409db922, max_idle_ns: 440795228871 ns Oct 16 23:41:06.860537 kernel: Initialise system trusted keyrings Oct 16 23:41:06.860543 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 16 23:41:06.860549 kernel: Key type asymmetric registered Oct 16 23:41:06.860554 kernel: Asymmetric key parser 'x509' registered Oct 16 23:41:06.860560 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 16 23:41:06.860565 kernel: io scheduler mq-deadline registered Oct 16 23:41:06.860571 kernel: io scheduler kyber registered Oct 16 23:41:06.860578 kernel: io scheduler bfq registered Oct 16 23:41:06.860583 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 16 23:41:06.860589 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Oct 16 23:41:06.860595 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Oct 16 23:41:06.860600 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Oct 16 23:41:06.860606 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 16 23:41:06.860612 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 16 23:41:06.860617 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 16 23:41:06.860623 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 16 23:41:06.860629 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 16 23:41:06.860691 kernel: rtc_cmos 00:04: RTC can wake from S4 Oct 16 23:41:06.860699 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Oct 16 23:41:06.860767 kernel: rtc_cmos 00:04: registered as rtc0 Oct 16 23:41:06.860821 kernel: rtc_cmos 00:04: setting system clock to 2026-10-16T23:41:06 UTC (1792194066) Oct 16 23:41:06.860872 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Oct 16 23:41:06.860879 kernel: intel_pstate: CPU model not supported Oct 16 23:41:06.860884 kernel: efifb: probing for efifb Oct 16 23:41:06.860892 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Oct 16 23:41:06.860897 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Oct 16 23:41:06.860903 kernel: efifb: scrolling: redraw Oct 16 23:41:06.860908 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Oct 16 23:41:06.860914 kernel: Console: switching to colour frame buffer device 100x37 Oct 16 23:41:06.860929 kernel: fb0: EFI VGA frame buffer device Oct 16 23:41:06.860936 kernel: pstore: Using crash dump compression: deflate Oct 16 23:41:06.860942 kernel: pstore: Registered efi_pstore as persistent store backend Oct 16 23:41:06.860947 kernel: NET: Registered PF_INET6 protocol family Oct 16 23:41:06.860954 kernel: Segment Routing with IPv6 Oct 16 23:41:06.860960 kernel: In-situ OAM (IOAM) with IPv6 Oct 16 23:41:06.860965 kernel: NET: Registered PF_PACKET protocol family Oct 16 23:41:06.860971 kernel: Key type dns_resolver registered Oct 16 23:41:06.860976 kernel: IPI shorthand broadcast: enabled Oct 16 23:41:06.860982 kernel: sched_clock: Marking stable (686150128, 194865374)->(929210271, -48194769) Oct 16 23:41:06.860988 kernel: registered taskstats version 1 Oct 16 23:41:06.860995 kernel: Loading compiled-in X.509 certificates Oct 16 23:41:06.861000 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.157-flatcar: 36b75ce1b227d9b3c384e550ebf5739bdec2813e' Oct 16 23:41:06.861007 kernel: Key type .fscrypt registered Oct 16 23:41:06.861013 kernel: Key type fscrypt-provisioning registered Oct 16 23:41:06.861018 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 16 23:41:06.861024 kernel: ima: Allocated hash algorithm: sha1 Oct 16 23:41:06.861029 kernel: ima: No architecture policies found Oct 16 23:41:06.861035 kernel: clk: Disabling unused clocks Oct 16 23:41:06.861041 kernel: Freeing unused kernel image (initmem) memory: 42928K Oct 16 23:41:06.861046 kernel: Write protecting the kernel read-only data: 38912k Oct 16 23:41:06.861052 kernel: Freeing unused kernel image (rodata/data gap) memory: 1804K Oct 16 23:41:06.861059 kernel: Run /init as init process Oct 16 23:41:06.861065 kernel: with arguments: Oct 16 23:41:06.861072 kernel: /init Oct 16 23:41:06.861077 kernel: with environment: Oct 16 23:41:06.861083 kernel: HOME=/ Oct 16 23:41:06.861088 kernel: TERM=linux Oct 16 23:41:06.861097 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) Oct 16 23:41:06.861105 systemd[1]: Detected virtualization kvm. Oct 16 23:41:06.861111 systemd[1]: Detected architecture x86-64. Oct 16 23:41:06.861117 systemd[1]: Running in initrd. Oct 16 23:41:06.861122 systemd[1]: No hostname configured, using default hostname. Oct 16 23:41:06.861138 systemd[1]: Hostname set to . Oct 16 23:41:06.861203 systemd[1]: Initializing machine ID from VM UUID. Oct 16 23:41:06.861220 systemd[1]: Queued start job for default target initrd.target. Oct 16 23:41:06.861227 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:41:06.861241 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:41:06.861247 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 16 23:41:06.861253 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 16 23:41:06.861259 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 16 23:41:06.861265 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 16 23:41:06.861274 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 16 23:41:06.861280 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 16 23:41:06.861286 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:41:06.861292 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:41:06.861307 systemd[1]: Reached target paths.target - Path Units. Oct 16 23:41:06.861313 systemd[1]: Reached target slices.target - Slice Units. Oct 16 23:41:06.861319 systemd[1]: Reached target swap.target - Swaps. Oct 16 23:41:06.861325 systemd[1]: Reached target timers.target - Timer Units. Oct 16 23:41:06.861332 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:41:06.861338 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:41:06.861344 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 16 23:41:06.861350 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 16 23:41:06.861356 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:41:06.861362 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 16 23:41:06.861368 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:41:06.861374 systemd[1]: Reached target sockets.target - Socket Units. Oct 16 23:41:06.861380 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 16 23:41:06.861387 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 16 23:41:06.861393 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 16 23:41:06.861399 systemd[1]: Starting systemd-fsck-usr.service... Oct 16 23:41:06.861405 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 16 23:41:06.861410 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 16 23:41:06.861416 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:41:06.861422 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 16 23:41:06.861428 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:41:06.861449 systemd-journald[194]: Collecting audit messages is disabled. Oct 16 23:41:06.861464 systemd[1]: Finished systemd-fsck-usr.service. Oct 16 23:41:06.861473 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 16 23:41:06.861481 systemd-journald[194]: Journal started Oct 16 23:41:06.861496 systemd-journald[194]: Runtime Journal (/run/log/journal/5d4d635518cf46d98b7fbc98724c2232) is 6.0M, max 48.2M, 42.2M free. Oct 16 23:41:06.859647 systemd-modules-load[195]: Inserted module 'overlay' Oct 16 23:41:06.865243 systemd[1]: Started systemd-journald.service - Journal Service. Oct 16 23:41:06.864916 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:41:06.868317 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 16 23:41:06.869561 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 16 23:41:06.876499 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:41:06.879873 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:41:06.881588 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:41:06.894177 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 16 23:41:06.896199 kernel: Bridge firewalling registered Oct 16 23:41:06.896185 systemd-modules-load[195]: Inserted module 'br_netfilter' Oct 16 23:41:06.896316 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:41:06.898825 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 16 23:41:06.902431 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 16 23:41:06.910003 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:41:06.921263 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 16 23:41:06.921941 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:41:06.925061 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 16 23:41:06.937607 dracut-cmdline[233]: dracut-dracut-053 Oct 16 23:41:06.940881 dracut-cmdline[233]: 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=e6f976cfb3863fee9fd1f1addd18d31ce811d92bc04253d21ae5d2ad4890c977 Oct 16 23:41:06.954486 systemd-resolved[227]: Positive Trust Anchors: Oct 16 23:41:06.954516 systemd-resolved[227]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 16 23:41:06.954540 systemd-resolved[227]: 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 Oct 16 23:41:06.956494 systemd-resolved[227]: Defaulting to hostname 'linux'. Oct 16 23:41:06.957219 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 16 23:41:06.958033 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:41:07.019194 kernel: SCSI subsystem initialized Oct 16 23:41:07.028184 kernel: Loading iSCSI transport class v2.0-870. Oct 16 23:41:07.038202 kernel: iscsi: registered transport (tcp) Oct 16 23:41:07.057193 kernel: iscsi: registered transport (qla4xxx) Oct 16 23:41:07.057250 kernel: QLogic iSCSI HBA Driver Oct 16 23:41:07.089408 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 16 23:41:07.102329 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 16 23:41:07.126481 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 16 23:41:07.126573 kernel: device-mapper: uevent: version 1.0.3 Oct 16 23:41:07.127933 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 16 23:41:07.166247 kernel: raid6: avx512x4 gen() 42068 MB/s Oct 16 23:41:07.184238 kernel: raid6: avx512x2 gen() 36725 MB/s Oct 16 23:41:07.201214 kernel: raid6: avx512x1 gen() 34256 MB/s Oct 16 23:41:07.219205 kernel: raid6: avx2x4 gen() 25646 MB/s Oct 16 23:41:07.237212 kernel: raid6: avx2x2 gen() 23197 MB/s Oct 16 23:41:07.254775 kernel: raid6: avx2x1 gen() 18922 MB/s Oct 16 23:41:07.254834 kernel: raid6: using algorithm avx512x4 gen() 42068 MB/s Oct 16 23:41:07.272692 kernel: raid6: .... xor() 9697 MB/s, rmw enabled Oct 16 23:41:07.272788 kernel: raid6: using avx512x2 recovery algorithm Oct 16 23:41:07.290191 kernel: xor: automatically using best checksumming function avx Oct 16 23:41:07.410192 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 16 23:41:07.417942 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:41:07.428277 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:41:07.437737 systemd-udevd[415]: Using default interface naming scheme 'v255'. Oct 16 23:41:07.440794 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:41:07.444334 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 16 23:41:07.456568 dracut-pre-trigger[420]: rd.md=0: removing MD RAID activation Oct 16 23:41:07.479500 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:41:07.489337 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 16 23:41:07.518047 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:41:07.530306 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 16 23:41:07.540953 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 16 23:41:07.545518 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Oct 16 23:41:07.546488 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:41:07.554697 kernel: cryptd: max_cpu_qlen set to 1000 Oct 16 23:41:07.547575 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:41:07.547901 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 16 23:41:07.565363 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Oct 16 23:41:07.568142 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 16 23:41:07.572377 kernel: AVX2 version of gcm_enc/dec engaged. Oct 16 23:41:07.574196 kernel: AES CTR mode by8 optimization enabled Oct 16 23:41:07.577380 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Oct 16 23:41:07.577405 kernel: GPT:9289727 != 19775487 Oct 16 23:41:07.577414 kernel: GPT:Alternate GPT header not at the end of the disk. Oct 16 23:41:07.577421 kernel: GPT:9289727 != 19775487 Oct 16 23:41:07.577435 kernel: GPT: Use GNU Parted to correct GPT errors. Oct 16 23:41:07.577443 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 16 23:41:07.576946 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:41:07.577080 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:41:07.582401 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:41:07.582614 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:41:07.586845 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:41:07.587293 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:41:07.594408 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:41:07.602027 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:41:07.606171 kernel: libata version 3.00 loaded. Oct 16 23:41:07.611845 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:41:07.616625 kernel: ahci 0000:00:1f.2: version 3.0 Oct 16 23:41:07.616801 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Oct 16 23:41:07.621771 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Oct 16 23:41:07.621904 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Oct 16 23:41:07.624213 kernel: BTRFS: device fsid 9c98ddf1-5877-4958-82de-0d39127d9d38 devid 1 transid 29 /dev/vda3 scanned by (udev-worker) (459) Oct 16 23:41:07.628366 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 16 23:41:07.633602 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (469) Oct 16 23:41:07.636244 kernel: scsi host0: ahci Oct 16 23:41:07.636374 kernel: scsi host1: ahci Oct 16 23:41:07.638488 kernel: scsi host2: ahci Oct 16 23:41:07.638599 kernel: scsi host3: ahci Oct 16 23:41:07.639014 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 16 23:41:07.640726 kernel: scsi host4: ahci Oct 16 23:41:07.640842 kernel: scsi host5: ahci Oct 16 23:41:07.640909 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Oct 16 23:41:07.643174 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Oct 16 23:41:07.644577 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Oct 16 23:41:07.645706 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 16 23:41:07.649572 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Oct 16 23:41:07.649587 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Oct 16 23:41:07.649595 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Oct 16 23:41:07.652076 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 16 23:41:07.652622 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 16 23:41:07.658476 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:41:07.661855 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 16 23:41:07.680383 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 16 23:41:07.687967 disk-uuid[574]: Primary Header is updated. Oct 16 23:41:07.687967 disk-uuid[574]: Secondary Entries is updated. Oct 16 23:41:07.687967 disk-uuid[574]: Secondary Header is updated. Oct 16 23:41:07.692048 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 16 23:41:07.957197 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 16 23:41:07.957264 kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 16 23:41:07.959383 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Oct 16 23:41:07.960167 kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 16 23:41:07.961169 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Oct 16 23:41:07.962170 kernel: ata3.00: applying bridge limits Oct 16 23:41:07.962185 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 16 23:41:07.963169 kernel: ata3.00: configured for UDMA/100 Oct 16 23:41:07.966171 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Oct 16 23:41:07.966207 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 16 23:41:08.007185 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Oct 16 23:41:08.034194 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 16 23:41:08.046178 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Oct 16 23:41:08.698852 disk-uuid[575]: The operation has completed successfully. Oct 16 23:41:08.700886 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 16 23:41:08.720061 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 16 23:41:08.720173 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 16 23:41:08.743618 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 16 23:41:08.752068 sh[595]: Success Oct 16 23:41:08.764180 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Oct 16 23:41:08.791001 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 16 23:41:08.799351 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 16 23:41:08.801037 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 16 23:41:08.817232 kernel: BTRFS info (device dm-0): first mount of filesystem 9c98ddf1-5877-4958-82de-0d39127d9d38 Oct 16 23:41:08.817277 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 16 23:41:08.817295 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 16 23:41:08.819686 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 16 23:41:08.819712 kernel: BTRFS info (device dm-0): using free space tree Oct 16 23:41:08.824566 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 16 23:41:08.826032 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 16 23:41:08.838324 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 16 23:41:08.839413 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 16 23:41:08.852808 kernel: BTRFS info (device vda6): first mount of filesystem b68cb5ed-e0a7-4edf-ad04-bb5772eb7ffc Oct 16 23:41:08.852839 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 16 23:41:08.852848 kernel: BTRFS info (device vda6): using free space tree Oct 16 23:41:08.856180 kernel: BTRFS info (device vda6): auto enabling async discard Oct 16 23:41:08.862572 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 16 23:41:08.865448 kernel: BTRFS info (device vda6): last unmount of filesystem b68cb5ed-e0a7-4edf-ad04-bb5772eb7ffc Oct 16 23:41:08.870089 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 16 23:41:08.875308 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 16 23:41:08.923018 ignition[694]: Ignition 2.19.0 Oct 16 23:41:08.923803 ignition[694]: Stage: fetch-offline Oct 16 23:41:08.923830 ignition[694]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:08.923837 ignition[694]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:08.923916 ignition[694]: parsed url from cmdline: "" Oct 16 23:41:08.923920 ignition[694]: no config URL provided Oct 16 23:41:08.923923 ignition[694]: reading system config file "/usr/lib/ignition/user.ign" Oct 16 23:41:08.923928 ignition[694]: no config at "/usr/lib/ignition/user.ign" Oct 16 23:41:08.923946 ignition[694]: op(1): [started] loading QEMU firmware config module Oct 16 23:41:08.923950 ignition[694]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 16 23:41:08.933003 unknown[694]: fetched base config from "system" Oct 16 23:41:08.930084 ignition[694]: op(1): [finished] loading QEMU firmware config module Oct 16 23:41:08.933008 unknown[694]: fetched user config from "qemu" Oct 16 23:41:08.931029 ignition[694]: parsing config with SHA512: d4864877f94c4590d22890a6c373b28af372f69560f78cad4d8697c16616e919f5e4a5d86c1ed7335047f30ab012245b1828f75240d6fcc06c17b2e792e7d331 Oct 16 23:41:08.934048 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:41:08.933217 ignition[694]: fetch-offline: fetch-offline passed Oct 16 23:41:08.933262 ignition[694]: Ignition finished successfully Oct 16 23:41:08.951012 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:41:08.960313 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 16 23:41:08.975868 systemd-networkd[784]: lo: Link UP Oct 16 23:41:08.975883 systemd-networkd[784]: lo: Gained carrier Oct 16 23:41:08.976728 systemd-networkd[784]: Enumeration completed Oct 16 23:41:08.976952 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 16 23:41:08.977342 systemd-networkd[784]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:41:08.977345 systemd-networkd[784]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:41:08.978293 systemd-networkd[784]: eth0: Link UP Oct 16 23:41:08.978296 systemd-networkd[784]: eth0: Gained carrier Oct 16 23:41:08.978301 systemd-networkd[784]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:41:08.980256 systemd[1]: Reached target network.target - Network. Oct 16 23:41:08.985579 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 16 23:41:08.992202 systemd-networkd[784]: eth0: DHCPv4 address 10.0.0.37/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 16 23:41:08.997288 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 16 23:41:09.009206 ignition[788]: Ignition 2.19.0 Oct 16 23:41:09.009217 ignition[788]: Stage: kargs Oct 16 23:41:09.009347 ignition[788]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:09.009354 ignition[788]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:09.009890 ignition[788]: kargs: kargs passed Oct 16 23:41:09.009919 ignition[788]: Ignition finished successfully Oct 16 23:41:09.013807 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 16 23:41:09.022338 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 16 23:41:09.036110 ignition[796]: Ignition 2.19.0 Oct 16 23:41:09.036120 ignition[796]: Stage: disks Oct 16 23:41:09.036282 ignition[796]: no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:09.036289 ignition[796]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:09.036832 ignition[796]: disks: disks passed Oct 16 23:41:09.039839 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 16 23:41:09.036865 ignition[796]: Ignition finished successfully Oct 16 23:41:09.041201 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 16 23:41:09.045050 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 16 23:41:09.045723 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 16 23:41:09.049441 systemd[1]: Reached target sysinit.target - System Initialization. Oct 16 23:41:09.051878 systemd[1]: Reached target basic.target - Basic System. Oct 16 23:41:09.068343 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 16 23:41:09.080341 systemd-fsck[807]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 16 23:41:09.083539 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 16 23:41:09.093293 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 16 23:41:09.171084 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 16 23:41:09.173120 kernel: EXT4-fs (vda9): mounted filesystem 22c9db06-419a-4610-8021-33f9316f26bd r/w with ordered data mode. Quota mode: none. Oct 16 23:41:09.172028 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 16 23:41:09.180252 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:41:09.182662 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 16 23:41:09.183602 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 16 23:41:09.183631 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 16 23:41:09.193292 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (815) Oct 16 23:41:09.183647 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:41:09.199535 kernel: BTRFS info (device vda6): first mount of filesystem b68cb5ed-e0a7-4edf-ad04-bb5772eb7ffc Oct 16 23:41:09.199562 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 16 23:41:09.199577 kernel: BTRFS info (device vda6): using free space tree Oct 16 23:41:09.199590 kernel: BTRFS info (device vda6): auto enabling async discard Oct 16 23:41:09.191681 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 16 23:41:09.197447 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 16 23:41:09.205405 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:41:09.229864 initrd-setup-root[840]: cut: /sysroot/etc/passwd: No such file or directory Oct 16 23:41:09.233672 initrd-setup-root[847]: cut: /sysroot/etc/group: No such file or directory Oct 16 23:41:09.238049 initrd-setup-root[854]: cut: /sysroot/etc/shadow: No such file or directory Oct 16 23:41:09.242036 initrd-setup-root[861]: cut: /sysroot/etc/gshadow: No such file or directory Oct 16 23:41:09.315085 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 16 23:41:09.329350 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 16 23:41:09.333215 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 16 23:41:09.338207 kernel: BTRFS info (device vda6): last unmount of filesystem b68cb5ed-e0a7-4edf-ad04-bb5772eb7ffc Oct 16 23:41:09.350314 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 16 23:41:09.356939 ignition[932]: INFO : Ignition 2.19.0 Oct 16 23:41:09.356939 ignition[932]: INFO : Stage: mount Oct 16 23:41:09.359682 ignition[932]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:09.359682 ignition[932]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:09.363060 ignition[932]: INFO : mount: mount passed Oct 16 23:41:09.364251 ignition[932]: INFO : Ignition finished successfully Oct 16 23:41:09.364529 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 16 23:41:09.378376 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 16 23:41:09.816823 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 16 23:41:09.829533 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 16 23:41:09.847434 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (944) Oct 16 23:41:09.847473 kernel: BTRFS info (device vda6): first mount of filesystem b68cb5ed-e0a7-4edf-ad04-bb5772eb7ffc Oct 16 23:41:09.847483 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 16 23:41:09.847491 kernel: BTRFS info (device vda6): using free space tree Oct 16 23:41:09.862181 kernel: BTRFS info (device vda6): auto enabling async discard Oct 16 23:41:09.864046 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 16 23:41:09.895416 ignition[961]: INFO : Ignition 2.19.0 Oct 16 23:41:09.895416 ignition[961]: INFO : Stage: files Oct 16 23:41:09.897650 ignition[961]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:09.897650 ignition[961]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:09.897650 ignition[961]: DEBUG : files: compiled without relabeling support, skipping Oct 16 23:41:09.897650 ignition[961]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 16 23:41:09.897650 ignition[961]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 16 23:41:09.906753 ignition[961]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 16 23:41:09.906753 ignition[961]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 16 23:41:09.906753 ignition[961]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.37.0-x86-64.raw" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.37.0-x86-64.raw" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.37.0-x86-64.raw" Oct 16 23:41:09.906753 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.37.0-x86-64.raw: attempt #1 Oct 16 23:41:09.899484 unknown[961]: wrote ssh authorized keys file for user: core Oct 16 23:41:10.025492 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Oct 16 23:41:10.181722 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.37.0-x86-64.raw" Oct 16 23:41:10.181722 ignition[961]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Oct 16 23:41:10.186424 ignition[961]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 16 23:41:10.188943 ignition[961]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 16 23:41:10.188943 ignition[961]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Oct 16 23:41:10.188943 ignition[961]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Oct 16 23:41:10.211973 ignition[961]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 16 23:41:10.217461 ignition[961]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 16 23:41:10.219548 ignition[961]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Oct 16 23:41:10.219548 ignition[961]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:41:10.219548 ignition[961]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 16 23:41:10.219548 ignition[961]: INFO : files: files passed Oct 16 23:41:10.219548 ignition[961]: INFO : Ignition finished successfully Oct 16 23:41:10.224306 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 16 23:41:10.236395 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 16 23:41:10.237641 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 16 23:41:10.239017 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 16 23:41:10.239100 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 16 23:41:10.249078 initrd-setup-root-after-ignition[989]: grep: /sysroot/oem/oem-release: No such file or directory Oct 16 23:41:10.253095 initrd-setup-root-after-ignition[991]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:41:10.253095 initrd-setup-root-after-ignition[991]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:41:10.257304 initrd-setup-root-after-ignition[995]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 16 23:41:10.260878 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:41:10.262781 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 16 23:41:10.276330 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 16 23:41:10.295455 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 16 23:41:10.295550 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 16 23:41:10.298371 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 16 23:41:10.301002 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 16 23:41:10.303395 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 16 23:41:10.304053 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 16 23:41:10.318373 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:41:10.321450 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 16 23:41:10.334902 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:41:10.335526 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:41:10.339134 systemd[1]: Stopped target timers.target - Timer Units. Oct 16 23:41:10.339820 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 16 23:41:10.339904 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 16 23:41:10.345139 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 16 23:41:10.345796 systemd[1]: Stopped target basic.target - Basic System. Oct 16 23:41:10.349478 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 16 23:41:10.351576 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 16 23:41:10.353943 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 16 23:41:10.356787 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 16 23:41:10.359561 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 16 23:41:10.361932 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 16 23:41:10.365630 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 16 23:41:10.367801 systemd[1]: Stopped target swap.target - Swaps. Oct 16 23:41:10.370161 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 16 23:41:10.370263 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 16 23:41:10.374100 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:41:10.374783 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:41:10.378419 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 16 23:41:10.378521 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:41:10.381004 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 16 23:41:10.381093 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 16 23:41:10.386031 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 16 23:41:10.386127 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 16 23:41:10.386740 systemd[1]: Stopped target paths.target - Path Units. Oct 16 23:41:10.390116 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 16 23:41:10.394246 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:41:10.394884 systemd[1]: Stopped target slices.target - Slice Units. Oct 16 23:41:10.397575 systemd[1]: Stopped target sockets.target - Socket Units. Oct 16 23:41:10.400584 systemd[1]: iscsid.socket: Deactivated successfully. Oct 16 23:41:10.400654 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 16 23:41:10.402511 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 16 23:41:10.402572 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 16 23:41:10.404738 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 16 23:41:10.404834 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 16 23:41:10.406918 systemd[1]: ignition-files.service: Deactivated successfully. Oct 16 23:41:10.406995 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 16 23:41:10.422300 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 16 23:41:10.424001 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 16 23:41:10.426045 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 16 23:41:10.426211 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:41:10.427953 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 16 23:41:10.428019 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 16 23:41:10.436709 ignition[1015]: INFO : Ignition 2.19.0 Oct 16 23:41:10.436709 ignition[1015]: INFO : Stage: umount Oct 16 23:41:10.436709 ignition[1015]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 16 23:41:10.436709 ignition[1015]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 16 23:41:10.436709 ignition[1015]: INFO : umount: umount passed Oct 16 23:41:10.436709 ignition[1015]: INFO : Ignition finished successfully Oct 16 23:41:10.431821 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 16 23:41:10.431924 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 16 23:41:10.436388 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 16 23:41:10.436489 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 16 23:41:10.437820 systemd[1]: Stopped target network.target - Network. Oct 16 23:41:10.437890 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 16 23:41:10.437929 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 16 23:41:10.440987 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 16 23:41:10.441018 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 16 23:41:10.441685 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 16 23:41:10.441727 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 16 23:41:10.446925 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 16 23:41:10.446973 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 16 23:41:10.449277 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 16 23:41:10.449902 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 16 23:41:10.456366 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 16 23:41:10.456446 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 16 23:41:10.457626 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 16 23:41:10.457666 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:41:10.459999 systemd-networkd[784]: eth0: DHCPv6 lease lost Oct 16 23:41:10.461947 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 16 23:41:10.465602 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 16 23:41:10.465709 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 16 23:41:10.467428 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 16 23:41:10.467486 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:41:10.484327 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 16 23:41:10.485116 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 16 23:41:10.485214 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 16 23:41:10.487597 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 16 23:41:10.487646 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:41:10.490994 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 16 23:41:10.491028 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 16 23:41:10.491744 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:41:10.502140 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 16 23:41:10.502268 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 16 23:41:10.508023 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 16 23:41:10.508087 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 16 23:41:10.509241 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 16 23:41:10.509297 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 16 23:41:10.530898 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 16 23:41:10.531013 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:41:10.531821 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 16 23:41:10.531846 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 16 23:41:10.535530 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 16 23:41:10.535552 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:41:10.538001 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 16 23:41:10.538033 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 16 23:41:10.541436 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 16 23:41:10.541466 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 16 23:41:10.544005 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 16 23:41:10.544045 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 16 23:41:10.556664 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 16 23:41:10.557464 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 16 23:41:10.557503 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:41:10.559902 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 16 23:41:10.559933 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:41:10.562614 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 16 23:41:10.562642 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:41:10.566756 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 16 23:41:10.566798 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:41:10.569677 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 16 23:41:10.569746 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 16 23:41:10.574085 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 16 23:41:10.585271 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 16 23:41:10.589947 systemd[1]: Switching root. Oct 16 23:41:10.617802 systemd-journald[194]: Journal stopped Oct 16 23:41:11.209669 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). Oct 16 23:41:11.209715 kernel: SELinux: policy capability network_peer_controls=1 Oct 16 23:41:11.209732 kernel: SELinux: policy capability open_perms=1 Oct 16 23:41:11.209745 kernel: SELinux: policy capability extended_socket_class=1 Oct 16 23:41:11.209756 kernel: SELinux: policy capability always_check_network=0 Oct 16 23:41:11.209791 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 16 23:41:11.209805 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 16 23:41:11.209824 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 16 23:41:11.209841 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 16 23:41:11.209850 kernel: audit: type=1403 audit(1792194070.701:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 16 23:41:11.209859 systemd[1]: Successfully loaded SELinux policy in 31.724ms. Oct 16 23:41:11.209874 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.813ms. Oct 16 23:41:11.209882 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) Oct 16 23:41:11.209891 systemd[1]: Detected virtualization kvm. Oct 16 23:41:11.209898 systemd[1]: Detected architecture x86-64. Oct 16 23:41:11.209906 systemd[1]: Detected first boot. Oct 16 23:41:11.209915 systemd[1]: Initializing machine ID from VM UUID. Oct 16 23:41:11.209926 zram_generator::config[1060]: No configuration found. Oct 16 23:41:11.209936 systemd[1]: Populated /etc with preset unit settings. Oct 16 23:41:11.209944 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 16 23:41:11.209953 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 16 23:41:11.209963 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 16 23:41:11.209971 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 16 23:41:11.209978 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 16 23:41:11.209986 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 16 23:41:11.209993 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 16 23:41:11.210001 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 16 23:41:11.210008 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 16 23:41:11.210016 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 16 23:41:11.210024 systemd[1]: Created slice user.slice - User and Session Slice. Oct 16 23:41:11.210032 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 16 23:41:11.210040 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 16 23:41:11.210048 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 16 23:41:11.210056 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 16 23:41:11.210064 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 16 23:41:11.210072 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 16 23:41:11.210080 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 16 23:41:11.210087 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 16 23:41:11.210096 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 16 23:41:11.210104 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 16 23:41:11.210112 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 16 23:41:11.210119 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 16 23:41:11.210126 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 16 23:41:11.210136 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 16 23:41:11.210165 systemd[1]: Reached target slices.target - Slice Units. Oct 16 23:41:11.210175 systemd[1]: Reached target swap.target - Swaps. Oct 16 23:41:11.210185 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 16 23:41:11.210193 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 16 23:41:11.210200 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 16 23:41:11.210208 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 16 23:41:11.210215 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 16 23:41:11.210224 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 16 23:41:11.210231 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 16 23:41:11.210240 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 16 23:41:11.210247 systemd[1]: Mounting media.mount - External Media Directory... Oct 16 23:41:11.210257 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 16 23:41:11.210264 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 16 23:41:11.210272 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 16 23:41:11.210280 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 16 23:41:11.210289 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). Oct 16 23:41:11.210297 systemd[1]: Reached target machines.target - Containers. Oct 16 23:41:11.210305 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 16 23:41:11.210312 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 16 23:41:11.210322 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 16 23:41:11.210329 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 16 23:41:11.210337 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 16 23:41:11.210344 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 16 23:41:11.210352 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 16 23:41:11.210360 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 16 23:41:11.210367 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 16 23:41:11.210375 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 16 23:41:11.210383 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 16 23:41:11.210393 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 16 23:41:11.210401 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 16 23:41:11.210408 systemd[1]: Stopped systemd-fsck-usr.service. Oct 16 23:41:11.210415 kernel: loop: module loaded Oct 16 23:41:11.210422 kernel: fuse: init (API version 7.39) Oct 16 23:41:11.210429 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 16 23:41:11.210437 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 16 23:41:11.210444 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 16 23:41:11.210452 kernel: ACPI: bus type drm_connector registered Oct 16 23:41:11.210461 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 16 23:41:11.210483 systemd-journald[1141]: Collecting audit messages is disabled. Oct 16 23:41:11.210500 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 16 23:41:11.210508 systemd-journald[1141]: Journal started Oct 16 23:41:11.210525 systemd-journald[1141]: Runtime Journal (/run/log/journal/5d4d635518cf46d98b7fbc98724c2232) is 6.0M, max 48.2M, 42.2M free. Oct 16 23:41:10.987916 systemd[1]: Queued start job for default target multi-user.target. Oct 16 23:41:11.004116 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 16 23:41:11.004453 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 16 23:41:11.214558 systemd[1]: verity-setup.service: Deactivated successfully. Oct 16 23:41:11.214603 systemd[1]: Stopped verity-setup.service. Oct 16 23:41:11.218182 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 16 23:41:11.220323 systemd[1]: Started systemd-journald.service - Journal Service. Oct 16 23:41:11.221703 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 16 23:41:11.223117 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 16 23:41:11.224570 systemd[1]: Mounted media.mount - External Media Directory. Oct 16 23:41:11.225886 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 16 23:41:11.227327 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 16 23:41:11.228792 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 16 23:41:11.230242 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 16 23:41:11.231909 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 16 23:41:11.233636 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 16 23:41:11.233753 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 16 23:41:11.235406 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 16 23:41:11.235518 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 16 23:41:11.237260 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 16 23:41:11.237421 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 16 23:41:11.239101 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 16 23:41:11.239286 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 16 23:41:11.241292 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 16 23:41:11.241403 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 16 23:41:11.243123 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 16 23:41:11.243376 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 16 23:41:11.245119 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 16 23:41:11.246929 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 16 23:41:11.248726 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 16 23:41:11.255212 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 16 23:41:11.260805 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 16 23:41:11.279371 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 16 23:41:11.281993 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 16 23:41:11.283543 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 16 23:41:11.283593 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 16 23:41:11.286267 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 16 23:41:11.288948 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 16 23:41:11.291340 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 16 23:41:11.292713 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 16 23:41:11.293878 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 16 23:41:11.295128 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 16 23:41:11.298335 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 16 23:41:11.299005 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 16 23:41:11.300469 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 16 23:41:11.302922 systemd-journald[1141]: Time spent on flushing to /var/log/journal/5d4d635518cf46d98b7fbc98724c2232 is 20.111ms for 974 entries. Oct 16 23:41:11.302922 systemd-journald[1141]: System Journal (/var/log/journal/5d4d635518cf46d98b7fbc98724c2232) is 8.0M, max 195.6M, 187.6M free. Oct 16 23:41:11.333742 systemd-journald[1141]: Received client request to flush runtime journal. Oct 16 23:41:11.304296 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 16 23:41:11.310280 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 16 23:41:11.313912 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 16 23:41:11.318268 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 16 23:41:11.321403 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 16 23:41:11.323624 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 16 23:41:11.326011 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 16 23:41:11.328027 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 16 23:41:11.333576 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 16 23:41:11.335610 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 16 23:41:11.343171 kernel: loop0: detected capacity change from 0 to 221624 Oct 16 23:41:11.344475 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 16 23:41:11.346636 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Oct 16 23:41:11.346652 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Oct 16 23:41:11.350942 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 16 23:41:11.353359 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 16 23:41:11.358389 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 16 23:41:11.363737 udevadm[1178]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 16 23:41:11.369169 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 16 23:41:11.378702 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 16 23:41:11.379213 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 16 23:41:11.387273 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 16 23:41:11.394322 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 16 23:41:11.396576 kernel: loop1: detected capacity change from 0 to 142488 Oct 16 23:41:11.411573 systemd-tmpfiles[1199]: ACLs are not supported, ignoring. Oct 16 23:41:11.411586 systemd-tmpfiles[1199]: ACLs are not supported, ignoring. Oct 16 23:41:11.416644 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 16 23:41:11.443178 kernel: loop2: detected capacity change from 0 to 140768 Oct 16 23:41:11.489688 kernel: loop3: detected capacity change from 0 to 221624 Oct 16 23:41:11.498179 kernel: loop4: detected capacity change from 0 to 142488 Oct 16 23:41:11.506175 kernel: loop5: detected capacity change from 0 to 140768 Oct 16 23:41:11.510970 (sd-merge)[1206]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Oct 16 23:41:11.511829 (sd-merge)[1206]: Merged extensions into '/usr'. Oct 16 23:41:11.515537 systemd[1]: Reloading requested from client PID 1175 ('systemd-sysext') (unit systemd-sysext.service)... Oct 16 23:41:11.515556 systemd[1]: Reloading... Oct 16 23:41:11.550207 zram_generator::config[1229]: No configuration found. Oct 16 23:41:11.559655 ldconfig[1170]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 16 23:41:11.631479 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. Oct 16 23:41:11.660238 systemd[1]: Reloading finished in 144 ms. Oct 16 23:41:11.693013 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 16 23:41:11.694753 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 16 23:41:11.696624 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 16 23:41:11.712369 systemd[1]: Starting ensure-sysext.service... Oct 16 23:41:11.714220 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 16 23:41:11.718321 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 16 23:41:11.721743 systemd[1]: Reloading requested from client PID 1270 ('systemctl') (unit ensure-sysext.service)... Oct 16 23:41:11.721790 systemd[1]: Reloading... Oct 16 23:41:11.730080 systemd-tmpfiles[1271]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 16 23:41:11.730314 systemd-tmpfiles[1271]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 16 23:41:11.730880 systemd-tmpfiles[1271]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 16 23:41:11.731039 systemd-tmpfiles[1271]: ACLs are not supported, ignoring. Oct 16 23:41:11.731095 systemd-tmpfiles[1271]: ACLs are not supported, ignoring. Oct 16 23:41:11.733076 systemd-tmpfiles[1271]: Detected autofs mount point /boot during canonicalization of boot. Oct 16 23:41:11.733092 systemd-tmpfiles[1271]: Skipping /boot Oct 16 23:41:11.737640 systemd-udevd[1272]: Using default interface naming scheme 'v255'. Oct 16 23:41:11.738222 systemd-tmpfiles[1271]: Detected autofs mount point /boot during canonicalization of boot. Oct 16 23:41:11.738239 systemd-tmpfiles[1271]: Skipping /boot Oct 16 23:41:11.757191 zram_generator::config[1298]: No configuration found. Oct 16 23:41:11.798192 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1322) Oct 16 23:41:11.823192 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Oct 16 23:41:11.828196 kernel: ACPI: button: Power Button [PWRF] Oct 16 23:41:11.845173 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Oct 16 23:41:11.846846 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. Oct 16 23:41:11.853370 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Oct 16 23:41:11.853547 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 16 23:41:11.858442 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Oct 16 23:41:11.858576 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Oct 16 23:41:11.902591 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 16 23:41:11.904726 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 16 23:41:11.904995 systemd[1]: Reloading finished in 183 ms. Oct 16 23:41:11.934209 kernel: mousedev: PS/2 mouse device common for all mice Oct 16 23:41:11.941831 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 16 23:41:11.971797 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 16 23:41:11.989621 systemd[1]: Finished ensure-sysext.service. Oct 16 23:41:11.991070 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 16 23:41:12.005519 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 16 23:41:12.015460 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 16 23:41:12.018337 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 16 23:41:12.020025 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 16 23:41:12.023274 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 16 23:41:12.028314 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 16 23:41:12.029574 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 16 23:41:12.033045 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 16 23:41:12.038175 lvm[1379]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 16 23:41:12.039350 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 16 23:41:12.040976 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 16 23:41:12.041650 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 16 23:41:12.046313 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 16 23:41:12.049292 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 16 23:41:12.052205 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 16 23:41:12.055100 augenrules[1394]: No rules Oct 16 23:41:12.056490 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 16 23:41:12.060105 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 16 23:41:12.062937 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 16 23:41:12.064491 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 16 23:41:12.065385 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 16 23:41:12.066220 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 16 23:41:12.083872 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 16 23:41:12.083988 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 16 23:41:12.085846 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 16 23:41:12.087680 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 16 23:41:12.087803 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 16 23:41:12.089435 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 16 23:41:12.089564 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 16 23:41:12.091382 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 16 23:41:12.091480 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 16 23:41:12.093070 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 16 23:41:12.093827 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 16 23:41:12.099550 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 16 23:41:12.100965 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 16 23:41:12.101744 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 16 23:41:12.101810 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 16 23:41:12.102547 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 16 23:41:12.105327 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 16 23:41:12.105928 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). Oct 16 23:41:12.108249 lvm[1416]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 16 23:41:12.106319 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 16 23:41:12.112106 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 16 23:41:12.129295 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 16 23:41:12.132176 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 16 23:41:12.135839 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 16 23:41:12.180290 systemd-networkd[1395]: lo: Link UP Oct 16 23:41:12.180304 systemd-networkd[1395]: lo: Gained carrier Oct 16 23:41:12.181086 systemd-networkd[1395]: Enumeration completed Oct 16 23:41:12.181211 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 16 23:41:12.181526 systemd-networkd[1395]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:41:12.181540 systemd-networkd[1395]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 16 23:41:12.183007 systemd-networkd[1395]: eth0: Link UP Oct 16 23:41:12.183021 systemd-networkd[1395]: eth0: Gained carrier Oct 16 23:41:12.183032 systemd-networkd[1395]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 16 23:41:12.188414 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 16 23:41:12.190219 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 16 23:41:12.191010 systemd-resolved[1397]: Positive Trust Anchors: Oct 16 23:41:12.191020 systemd-resolved[1397]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 16 23:41:12.191045 systemd-resolved[1397]: 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 Oct 16 23:41:12.191915 systemd[1]: Reached target time-set.target - System Time Set. Oct 16 23:41:12.195933 systemd-resolved[1397]: Defaulting to hostname 'linux'. Oct 16 23:41:12.197200 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 16 23:41:12.198978 systemd[1]: Reached target network.target - Network. Oct 16 23:41:12.200257 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 16 23:41:12.201885 systemd[1]: Reached target sysinit.target - System Initialization. Oct 16 23:41:12.203349 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 16 23:41:12.205026 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 16 23:41:12.205201 systemd-networkd[1395]: eth0: DHCPv4 address 10.0.0.37/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 16 23:41:12.205717 systemd-timesyncd[1401]: Network configuration changed, trying to establish connection. Oct 16 23:41:12.692581 systemd-resolved[1397]: Clock change detected. Flushing caches. Oct 16 23:41:12.692611 systemd-timesyncd[1401]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 16 23:41:12.692636 systemd-timesyncd[1401]: Initial clock synchronization to Fri 2026-10-16 23:41:12.692546 UTC. Oct 16 23:41:12.693254 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 16 23:41:12.694723 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 16 23:41:12.696427 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 16 23:41:12.698205 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 16 23:41:12.698244 systemd[1]: Reached target paths.target - Path Units. Oct 16 23:41:12.699475 systemd[1]: Reached target timers.target - Timer Units. Oct 16 23:41:12.701064 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 16 23:41:12.703859 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 16 23:41:12.714074 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 16 23:41:12.715841 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 16 23:41:12.717444 systemd[1]: Reached target sockets.target - Socket Units. Oct 16 23:41:12.718733 systemd[1]: Reached target basic.target - Basic System. Oct 16 23:41:12.720006 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 16 23:41:12.720044 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 16 23:41:12.720780 systemd[1]: Starting containerd.service - containerd container runtime... Oct 16 23:41:12.722897 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 16 23:41:12.724928 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 16 23:41:12.726936 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 16 23:41:12.728430 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). Oct 16 23:41:12.731545 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 16 23:41:12.734035 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 16 23:41:12.736810 jq[1438]: false Oct 16 23:41:12.737638 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 16 23:41:12.739810 extend-filesystems[1439]: Found loop3 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found loop4 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found loop5 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found sr0 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda1 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda2 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda3 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found usr Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda4 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda6 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda7 Oct 16 23:41:12.741209 extend-filesystems[1439]: Found vda9 Oct 16 23:41:12.741209 extend-filesystems[1439]: Checking size of /dev/vda9 Oct 16 23:41:12.743223 dbus-daemon[1437]: [system] SELinux support is enabled Oct 16 23:41:12.741287 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 16 23:41:12.743717 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 16 23:41:12.743990 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 16 23:41:12.746104 systemd[1]: Starting update-engine.service - Update Engine... Oct 16 23:41:12.776208 update_engine[1446]: I20261016 23:41:12.760037 1446 main.cc:92] Flatcar Update Engine starting Oct 16 23:41:12.776208 update_engine[1446]: I20261016 23:41:12.761087 1446 update_check_scheduler.cc:74] Next update check in 3m52s Oct 16 23:41:12.750288 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 16 23:41:12.751372 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 16 23:41:12.757615 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 16 23:41:12.757729 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 16 23:41:12.757895 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 16 23:41:12.757989 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 16 23:41:12.761556 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). Oct 16 23:41:12.761587 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 16 23:41:12.763721 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). Oct 16 23:41:12.763734 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 16 23:41:12.764461 systemd[1]: Started update-engine.service - Update Engine. Oct 16 23:41:12.765619 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 16 23:41:12.779426 jq[1451]: true Oct 16 23:41:12.781437 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 29 scanned by (udev-worker) (1312) Oct 16 23:41:12.781492 extend-filesystems[1439]: Resized partition /dev/vda9 Oct 16 23:41:12.785669 extend-filesystems[1468]: resize2fs 1.47.1 (20-May-2024) Oct 16 23:41:12.782589 systemd[1]: motdgen.service: Deactivated successfully. Oct 16 23:41:12.782769 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 16 23:41:12.789127 jq[1466]: true Oct 16 23:41:12.783781 (ntainerd)[1463]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 16 23:41:12.793431 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Oct 16 23:41:12.810537 systemd-logind[1444]: Watching system buttons on /dev/input/event1 (Power Button) Oct 16 23:41:12.810552 systemd-logind[1444]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 16 23:41:12.813523 systemd-logind[1444]: New seat seat0. Oct 16 23:41:12.816441 systemd[1]: Started systemd-logind.service - User Login Management. Oct 16 23:41:12.824427 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Oct 16 23:41:12.842162 locksmithd[1460]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 16 23:41:12.844970 extend-filesystems[1468]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 16 23:41:12.844970 extend-filesystems[1468]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 16 23:41:12.844970 extend-filesystems[1468]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Oct 16 23:41:12.851435 extend-filesystems[1439]: Resized filesystem in /dev/vda9 Oct 16 23:41:12.846331 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 16 23:41:12.846494 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 16 23:41:12.853460 bash[1486]: Updated "/home/core/.ssh/authorized_keys" Oct 16 23:41:12.855098 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 16 23:41:12.857288 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 16 23:41:12.930884 containerd[1463]: time="2026-10-16T23:41:12.930802396Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Oct 16 23:41:12.947888 containerd[1463]: time="2026-10-16T23:41:12.947840527Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.949435 containerd[1463]: time="2026-10-16T23:41:12.949373654Z" 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.157-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:41:12.949435 containerd[1463]: time="2026-10-16T23:41:12.949414358Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 16 23:41:12.949435 containerd[1463]: time="2026-10-16T23:41:12.949426737Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 16 23:41:12.949562 containerd[1463]: time="2026-10-16T23:41:12.949540634Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 16 23:41:12.949581 containerd[1463]: time="2026-10-16T23:41:12.949566912Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.949620 containerd[1463]: time="2026-10-16T23:41:12.949604027Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:41:12.949635 containerd[1463]: time="2026-10-16T23:41:12.949620737Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949740143Z" 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 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949759180Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949768432Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949775252Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949826877Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.949967093Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.950070194Z" 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 Oct 16 23:41:12.950073 containerd[1463]: time="2026-10-16T23:41:12.950080045Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 16 23:41:12.950232 containerd[1463]: time="2026-10-16T23:41:12.950130873Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 16 23:41:12.950232 containerd[1463]: time="2026-10-16T23:41:12.950157551Z" level=info msg="metadata content store policy set" policy=shared Oct 16 23:41:12.953746 containerd[1463]: time="2026-10-16T23:41:12.953705312Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 16 23:41:12.953812 containerd[1463]: time="2026-10-16T23:41:12.953757401Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 16 23:41:12.953812 containerd[1463]: time="2026-10-16T23:41:12.953777187Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 16 23:41:12.953812 containerd[1463]: time="2026-10-16T23:41:12.953788648Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 16 23:41:12.953812 containerd[1463]: time="2026-10-16T23:41:12.953799938Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 16 23:41:12.953907 containerd[1463]: time="2026-10-16T23:41:12.953890148Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 16 23:41:12.954101 containerd[1463]: time="2026-10-16T23:41:12.954075211Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 16 23:41:12.954171 containerd[1463]: time="2026-10-16T23:41:12.954155822Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 16 23:41:12.954205 containerd[1463]: time="2026-10-16T23:41:12.954191800Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 16 23:41:12.954224 containerd[1463]: time="2026-10-16T23:41:12.954210641Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 16 23:41:12.954224 containerd[1463]: time="2026-10-16T23:41:12.954221532Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954256 containerd[1463]: time="2026-10-16T23:41:12.954230868Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954256 containerd[1463]: time="2026-10-16T23:41:12.954239551Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954256 containerd[1463]: time="2026-10-16T23:41:12.954249941Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954298 containerd[1463]: time="2026-10-16T23:41:12.954259910Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954298 containerd[1463]: time="2026-10-16T23:41:12.954268913Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954298 containerd[1463]: time="2026-10-16T23:41:12.954277312Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954298 containerd[1463]: time="2026-10-16T23:41:12.954285837Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954298744Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954308134Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954316448Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954329695Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954338093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954347285Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954356 containerd[1463]: time="2026-10-16T23:41:12.954354830Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954363217Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954372546Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954382348Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954416921Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954425579Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954434156Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954446233Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954459312Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954466950Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954503 containerd[1463]: time="2026-10-16T23:41:12.954474138Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954511574Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954524539Z" 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 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954532317Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954540009Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954546527Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954554303Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954560553Z" level=info msg="NRI interface is disabled by configuration." Oct 16 23:41:12.954642 containerd[1463]: time="2026-10-16T23:41:12.954567442Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 16 23:41:12.954796 containerd[1463]: time="2026-10-16T23:41:12.954758453Z" 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}" Oct 16 23:41:12.954913 containerd[1463]: time="2026-10-16T23:41:12.954800875Z" level=info msg="Connect containerd service" Oct 16 23:41:12.954913 containerd[1463]: time="2026-10-16T23:41:12.954822017Z" level=info msg="using legacy CRI server" Oct 16 23:41:12.954913 containerd[1463]: time="2026-10-16T23:41:12.954826375Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 16 23:41:12.955589 containerd[1463]: time="2026-10-16T23:41:12.954966135Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 16 23:41:12.955589 containerd[1463]: time="2026-10-16T23:41:12.955540861Z" 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" Oct 16 23:41:12.955681 containerd[1463]: time="2026-10-16T23:41:12.955646560Z" level=info msg="Start subscribing containerd event" Oct 16 23:41:12.955697 containerd[1463]: time="2026-10-16T23:41:12.955684560Z" level=info msg="Start recovering state" Oct 16 23:41:12.955786 containerd[1463]: time="2026-10-16T23:41:12.955770745Z" level=info msg="Start event monitor" Oct 16 23:41:12.955817 containerd[1463]: time="2026-10-16T23:41:12.955790254Z" level=info msg="Start snapshots syncer" Oct 16 23:41:12.955817 containerd[1463]: time="2026-10-16T23:41:12.955798146Z" level=info msg="Start cni network conf syncer for default" Oct 16 23:41:12.955842 containerd[1463]: time="2026-10-16T23:41:12.955830380Z" level=info msg="Start streaming server" Oct 16 23:41:12.955986 containerd[1463]: time="2026-10-16T23:41:12.955952293Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 16 23:41:12.956075 containerd[1463]: time="2026-10-16T23:41:12.956058862Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 16 23:41:12.956181 systemd[1]: Started containerd.service - containerd container runtime. Oct 16 23:41:12.957883 containerd[1463]: time="2026-10-16T23:41:12.957812164Z" level=info msg="containerd successfully booted in 0.028345s" Oct 16 23:41:13.090625 sshd_keygen[1452]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 16 23:41:13.109650 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 16 23:41:13.126108 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 16 23:41:13.130777 systemd[1]: issuegen.service: Deactivated successfully. Oct 16 23:41:13.130921 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 16 23:41:13.133421 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 16 23:41:13.142842 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 16 23:41:13.145435 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 16 23:41:13.147469 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 16 23:41:13.148090 systemd[1]: Reached target getty.target - Login Prompts. Oct 16 23:41:14.010659 systemd-networkd[1395]: eth0: Gained IPv6LL Oct 16 23:41:14.012907 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 16 23:41:14.015447 systemd[1]: Reached target network-online.target - Network is Online. Oct 16 23:41:14.034672 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 16 23:41:14.037250 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 16 23:41:14.039436 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 16 23:41:14.051301 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 16 23:41:14.051477 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 16 23:41:14.053278 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 16 23:41:14.055311 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 16 23:41:14.625975 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 16 23:41:14.627777 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 16 23:41:14.629283 systemd[1]: Startup finished in 799ms (kernel) + 4.021s (initrd) + 3.473s (userspace) = 8.293s. Oct 16 23:41:14.631720 (kubelet)[1542]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Oct 16 23:41:14.961349 kubelet[1542]: E1016 23:41:14.961203 1542 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" Oct 16 23:41:14.963203 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Oct 16 23:41:14.963319 systemd[1]: kubelet.service: Failed with result 'exit-code'. Oct 16 23:41:19.855236 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 16 23:41:19.856272 systemd[1]: Started sshd@0-10.0.0.37:22-10.0.0.1:48338.service - OpenSSH per-connection server daemon (10.0.0.1:48338). Oct 16 23:41:19.893152 sshd[1555]: Accepted publickey for core from 10.0.0.1 port 48338 ssh2: RSA SHA256:yGQV8mQo//nu+FedLGpenz6VvjRKol8wYSZx5aFvTzs Oct 16 23:41:19.894379 sshd[1555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:41:19.900008 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 16 23:41:19.910655 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 16 23:41:19.912158 systemd-logind[1444]: New session 1 of user core. Oct 16 23:41:19.918558 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 16 23:41:19.920215 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 16 23:41:19.925649 (systemd)[1559]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 16 23:41:19.999250 systemd[1559]: Queued start job for default target default.target. Oct 16 23:41:20.010128 systemd[1559]: Created slice app.slice - User Application Slice. Oct 16 23:41:20.010158 systemd[1559]: Reached target paths.target - Paths. Oct 16 23:41:20.010168 systemd[1559]: Reached target timers.target - Timers. Oct 16 23:41:20.011128 systemd[1559]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 16 23:41:20.019109 systemd[1559]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 16 23:41:20.019163 systemd[1559]: Reached target sockets.target - Sockets. Oct 16 23:41:20.019171 systemd[1559]: Reached target basic.target - Basic System. Oct 16 23:41:20.019196 systemd[1559]: Reached target default.target - Main User Target. Oct 16 23:41:20.019215 systemd[1559]: Startup finished in 88ms. Oct 16 23:41:20.019565 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 16 23:41:20.020872 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 16 23:41:20.083604 systemd[1]: Started sshd@1-10.0.0.37:22-10.0.0.1:48350.service - OpenSSH per-connection server daemon (10.0.0.1:48350). Oct 16 23:41:20.115009 sshd[1570]: Accepted publickey for core from 10.0.0.1 port 48350 ssh2: RSA SHA256:yGQV8mQo//nu+FedLGpenz6VvjRKol8wYSZx5aFvTzs Oct 16 23:41:20.115959 sshd[1570]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:41:20.119403 systemd-logind[1444]: New session 2 of user core. Oct 16 23:41:20.131541 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 16 23:41:20.181888 sshd[1570]: pam_unix(sshd:session): session closed for user core Oct 16 23:41:20.206478 systemd[1]: sshd@1-10.0.0.37:22-10.0.0.1:48350.service: Deactivated successfully. Oct 16 23:41:20.207547 systemd[1]: session-2.scope: Deactivated successfully. Oct 16 23:41:20.208442 systemd-logind[1444]: Session 2 logged out. Waiting for processes to exit. Oct 16 23:41:20.209310 systemd[1]: Started sshd@2-10.0.0.37:22-10.0.0.1:48364.service - OpenSSH per-connection server daemon (10.0.0.1:48364). Oct 16 23:41:20.209869 systemd-logind[1444]: Removed session 2. Oct 16 23:41:20.237353 sshd[1577]: Accepted publickey for core from 10.0.0.1 port 48364 ssh2: RSA SHA256:yGQV8mQo//nu+FedLGpenz6VvjRKol8wYSZx5aFvTzs Oct 16 23:41:20.238451 sshd[1577]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:41:20.241678 systemd-logind[1444]: New session 3 of user core. Oct 16 23:41:20.247526 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 16 23:41:20.294675 sshd[1577]: pam_unix(sshd:session): session closed for user core Oct 16 23:41:20.308200 systemd[1]: sshd@2-10.0.0.37:22-10.0.0.1:48364.service: Deactivated successfully. Oct 16 23:41:20.309349 systemd[1]: session-3.scope: Deactivated successfully. Oct 16 23:41:20.310239 systemd-logind[1444]: Session 3 logged out. Waiting for processes to exit. Oct 16 23:41:20.311210 systemd[1]: Started sshd@3-10.0.0.37:22-10.0.0.1:48370.service - OpenSSH per-connection server daemon (10.0.0.1:48370). Oct 16 23:41:20.311722 systemd-logind[1444]: Removed session 3. Oct 16 23:41:20.338112 sshd[1584]: Accepted publickey for core from 10.0.0.1 port 48370 ssh2: RSA SHA256:yGQV8mQo//nu+FedLGpenz6VvjRKol8wYSZx5aFvTzs Oct 16 23:41:20.338998 sshd[1584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:41:20.342040 systemd-logind[1444]: New session 4 of user core. Oct 16 23:41:20.349580 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 16 23:41:20.400948 sshd[1584]: pam_unix(sshd:session): session closed for user core Oct 16 23:41:20.408954 systemd[1]: sshd@3-10.0.0.37:22-10.0.0.1:48370.service: Deactivated successfully. Oct 16 23:41:20.409924 systemd[1]: session-4.scope: Deactivated successfully. Oct 16 23:41:20.410810 systemd-logind[1444]: Session 4 logged out. Waiting for processes to exit. Oct 16 23:41:20.411655 systemd[1]: Started sshd@4-10.0.0.37:22-10.0.0.1:48374.service - OpenSSH per-connection server daemon (10.0.0.1:48374). Oct 16 23:41:20.412220 systemd-logind[1444]: Removed session 4. Oct 16 23:41:20.438839 sshd[1591]: Accepted publickey for core from 10.0.0.1 port 48374 ssh2: RSA SHA256:yGQV8mQo//nu+FedLGpenz6VvjRKol8wYSZx5aFvTzs Oct 16 23:41:20.439725 sshd[1591]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 16 23:41:20.442674 systemd-logind[1444]: New session 5 of user core. Oct 16 23:41:20.448532 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 16 23:41:20.501342 sudo[1594]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Oct 16 23:41:20.501615 sudo[1594]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 16 23:41:20.520650 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 16 23:41:20.533596 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 16 23:41:20.533738 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 16 23:41:20.971145 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 16 23:41:20.981616 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 16 23:41:20.999170 systemd[1]: Reloading requested from client PID 1644 ('systemctl') (unit session-5.scope)... Oct 16 23:41:20.999189 systemd[1]: Reloading... Oct 16 23:41:21.052803 zram_generator::config[1685]: No configuration found. Oct 16 23:41:21.144760 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. Oct 16 23:41:21.189216 systemd[1]: Reloading finished in 189 ms. Oct 16 23:41:21.227739 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Oct 16 23:41:21.230515 systemd[1]: kubelet.service: Deactivated successfully. Oct 16 23:41:21.230676 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Oct 16 23:41:21.231797 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Oct 16 23:41:21.331865 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Oct 16 23:41:21.334994 (kubelet)[1732]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Oct 16 23:41:21.361708 kubelet[1732]: 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. Oct 16 23:41:21.364850 kubelet[1732]: I1016 23:41:21.364776 1732 server.go:257] "Effective KubeletConfiguration" config=< Oct 16 23:41:21.364850 kubelet[1732]: address: 0.0.0.0 Oct 16 23:41:21.364850 kubelet[1732]: apiVersion: kubelet.config.k8s.io/v1beta1 Oct 16 23:41:21.364850 kubelet[1732]: authentication: Oct 16 23:41:21.364850 kubelet[1732]: anonymous: Oct 16 23:41:21.364850 kubelet[1732]: enabled: false Oct 16 23:41:21.364850 kubelet[1732]: webhook: Oct 16 23:41:21.364850 kubelet[1732]: cacheTTL: 2m0s Oct 16 23:41:21.364850 kubelet[1732]: enabled: true Oct 16 23:41:21.364850 kubelet[1732]: x509: Oct 16 23:41:21.364850 kubelet[1732]: clientCAFile: /etc/kubernetes/pki/ca.crt Oct 16 23:41:21.364850 kubelet[1732]: authorization: Oct 16 23:41:21.364850 kubelet[1732]: mode: Webhook Oct 16 23:41:21.364850 kubelet[1732]: webhook: Oct 16 23:41:21.364850 kubelet[1732]: cacheAuthorizedTTL: 5m0s Oct 16 23:41:21.364850 kubelet[1732]: cacheUnauthorizedTTL: 30s Oct 16 23:41:21.364850 kubelet[1732]: cgroupDriver: systemd Oct 16 23:41:21.364850 kubelet[1732]: cgroupsPerQOS: true Oct 16 23:41:21.364850 kubelet[1732]: clusterDNS: Oct 16 23:41:21.364850 kubelet[1732]: - 10.96.0.10 Oct 16 23:41:21.364850 kubelet[1732]: clusterDomain: cluster.local Oct 16 23:41:21.364850 kubelet[1732]: configMapAndSecretChangeDetectionStrategy: Watch Oct 16 23:41:21.364850 kubelet[1732]: containerLogMaxFiles: 5 Oct 16 23:41:21.364850 kubelet[1732]: containerLogMaxSize: 10Mi Oct 16 23:41:21.364850 kubelet[1732]: containerLogMaxWorkers: 1 Oct 16 23:41:21.364850 kubelet[1732]: containerLogMonitorInterval: 10s Oct 16 23:41:21.364850 kubelet[1732]: containerRuntimeEndpoint: unix:///var/run/containerd/containerd.sock Oct 16 23:41:21.364850 kubelet[1732]: contentType: application/vnd.kubernetes.protobuf Oct 16 23:41:21.364850 kubelet[1732]: cpuCFSQuota: true Oct 16 23:41:21.364850 kubelet[1732]: cpuCFSQuotaPeriod: 100ms Oct 16 23:41:21.364850 kubelet[1732]: cpuManagerPolicy: none Oct 16 23:41:21.364850 kubelet[1732]: cpuManagerReconcilePeriod: 10s Oct 16 23:41:21.364850 kubelet[1732]: crashLoopBackOff: Oct 16 23:41:21.364850 kubelet[1732]: maxContainerRestartPeriod: 5m0s Oct 16 23:41:21.364850 kubelet[1732]: enableControllerAttachDetach: true Oct 16 23:41:21.364850 kubelet[1732]: enableDebugFlagsHandler: true Oct 16 23:41:21.364850 kubelet[1732]: enableDebuggingHandlers: true Oct 16 23:41:21.364850 kubelet[1732]: enableProfilingHandler: true Oct 16 23:41:21.364850 kubelet[1732]: enableServer: true Oct 16 23:41:21.364850 kubelet[1732]: enableSystemLogHandler: true Oct 16 23:41:21.364850 kubelet[1732]: enableSystemLogQuery: false Oct 16 23:41:21.364850 kubelet[1732]: enforceNodeAllocatable: Oct 16 23:41:21.364850 kubelet[1732]: - pods Oct 16 23:41:21.364850 kubelet[1732]: eventBurst: 100 Oct 16 23:41:21.364850 kubelet[1732]: eventRecordQPS: 50 Oct 16 23:41:21.364850 kubelet[1732]: evictionHard: Oct 16 23:41:21.364850 kubelet[1732]: imagefs.available: 15% Oct 16 23:41:21.364850 kubelet[1732]: imagefs.inodesFree: 5% Oct 16 23:41:21.364850 kubelet[1732]: memory.available: 100Mi Oct 16 23:41:21.364850 kubelet[1732]: nodefs.available: 10% Oct 16 23:41:21.364850 kubelet[1732]: nodefs.inodesFree: 5% Oct 16 23:41:21.364850 kubelet[1732]: evictionPressureTransitionPeriod: 5m0s Oct 16 23:41:21.364850 kubelet[1732]: failCgroupV1: true Oct 16 23:41:21.364850 kubelet[1732]: failSwapOn: true Oct 16 23:41:21.364850 kubelet[1732]: fileCheckFrequency: 20s Oct 16 23:41:21.364850 kubelet[1732]: hairpinMode: promiscuous-bridge Oct 16 23:41:21.364850 kubelet[1732]: healthzBindAddress: 127.0.0.1 Oct 16 23:41:21.364850 kubelet[1732]: healthzPort: 10248 Oct 16 23:41:21.364850 kubelet[1732]: httpCheckFrequency: 20s Oct 16 23:41:21.364850 kubelet[1732]: imageGCHighThresholdPercent: 85 Oct 16 23:41:21.364850 kubelet[1732]: imageGCLowThresholdPercent: 80 Oct 16 23:41:21.364850 kubelet[1732]: imageMaximumGCAge: 0s Oct 16 23:41:21.364850 kubelet[1732]: imageMinimumGCAge: 2m0s Oct 16 23:41:21.364850 kubelet[1732]: imagePullCredentialsVerificationPolicy: NeverVerifyPreloadedImages Oct 16 23:41:21.364850 kubelet[1732]: iptablesDropBit: 15 Oct 16 23:41:21.364850 kubelet[1732]: iptablesMasqueradeBit: 14 Oct 16 23:41:21.364850 kubelet[1732]: kind: KubeletConfiguration Oct 16 23:41:21.364850 kubelet[1732]: kubeAPIBurst: 100 Oct 16 23:41:21.364850 kubelet[1732]: kubeAPIQPS: 50 Oct 16 23:41:21.364850 kubelet[1732]: localStorageCapacityIsolation: true Oct 16 23:41:21.364850 kubelet[1732]: logging: Oct 16 23:41:21.364850 kubelet[1732]: flushFrequency: 5s Oct 16 23:41:21.364850 kubelet[1732]: format: text Oct 16 23:41:21.364850 kubelet[1732]: options: Oct 16 23:41:21.364850 kubelet[1732]: json: Oct 16 23:41:21.364850 kubelet[1732]: infoBufferSize: "0" Oct 16 23:41:21.364850 kubelet[1732]: text: Oct 16 23:41:21.364850 kubelet[1732]: infoBufferSize: "0" Oct 16 23:41:21.366293 kubelet[1732]: verbosity: 0 Oct 16 23:41:21.366293 kubelet[1732]: makeIPTablesUtilChains: true Oct 16 23:41:21.366293 kubelet[1732]: maxOpenFiles: 1000000 Oct 16 23:41:21.366293 kubelet[1732]: maxPods: 110 Oct 16 23:41:21.366293 kubelet[1732]: memoryManagerPolicy: None Oct 16 23:41:21.366293 kubelet[1732]: memoryReservationPolicy: None Oct 16 23:41:21.366293 kubelet[1732]: memorySwap: {} Oct 16 23:41:21.366293 kubelet[1732]: mergeDefaultEvictionSettings: false Oct 16 23:41:21.366293 kubelet[1732]: nodeLeaseDurationSeconds: 40 Oct 16 23:41:21.366293 kubelet[1732]: nodeStatusMaxImages: 50 Oct 16 23:41:21.366293 kubelet[1732]: nodeStatusReportFrequency: 5m0s Oct 16 23:41:21.366293 kubelet[1732]: nodeStatusUpdateFrequency: 10s Oct 16 23:41:21.366293 kubelet[1732]: oomScoreAdj: -999 Oct 16 23:41:21.366293 kubelet[1732]: podLogsDir: /var/log/pods Oct 16 23:41:21.366293 kubelet[1732]: podPidsLimit: -1 Oct 16 23:41:21.366293 kubelet[1732]: port: 10250 Oct 16 23:41:21.366293 kubelet[1732]: registerNode: true Oct 16 23:41:21.366293 kubelet[1732]: registryBurst: 10 Oct 16 23:41:21.366293 kubelet[1732]: registryPullQPS: 5 Oct 16 23:41:21.366293 kubelet[1732]: resolvConf: /run/systemd/resolve/resolv.conf Oct 16 23:41:21.366293 kubelet[1732]: rotateCertificates: true Oct 16 23:41:21.366293 kubelet[1732]: runtimeRequestTimeout: 2m0s Oct 16 23:41:21.366293 kubelet[1732]: seccompDefault: false Oct 16 23:41:21.366293 kubelet[1732]: serializeImagePulls: true Oct 16 23:41:21.366293 kubelet[1732]: shutdownGracePeriod: 0s Oct 16 23:41:21.366293 kubelet[1732]: shutdownGracePeriodCriticalPods: 0s Oct 16 23:41:21.366293 kubelet[1732]: staticPodPath: /etc/kubernetes/manifests Oct 16 23:41:21.366293 kubelet[1732]: streamingConnectionIdleTimeout: 4h0m0s Oct 16 23:41:21.366293 kubelet[1732]: syncFrequency: 1m0s Oct 16 23:41:21.366293 kubelet[1732]: topologyManagerPolicy: none Oct 16 23:41:21.366293 kubelet[1732]: topologyManagerScope: container Oct 16 23:41:21.366293 kubelet[1732]: volumePluginDir: /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ Oct 16 23:41:21.366293 kubelet[1732]: volumeStatsAggPeriod: 1m0s Oct 16 23:41:21.366293 kubelet[1732]: > Oct 16 23:41:21.531754 kubelet[1732]: I1016 23:41:21.531582 1732 server.go:545] "Kubelet version" kubeletVersion="v1.37.0" Oct 16 23:41:21.531754 kubelet[1732]: I1016 23:41:21.531647 1732 server.go:547] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Oct 16 23:41:21.531754 kubelet[1732]: I1016 23:41:21.531677 1732 watchdog_linux.go:94] "Systemd watchdog is not enabled" Oct 16 23:41:21.531754 kubelet[1732]: I1016 23:41:21.531681 1732 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Oct 16 23:41:21.532007 kubelet[1732]: I1016 23:41:21.531989 1732 server.go:1036] "Client rotation is on, will bootstrap in background" Oct 16 23:41:21.536937 kubelet[1732]: I1016 23:41:21.536864 1732 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Oct 16 23:41:21.541463 kubelet[1732]: E1016 23:41:21.541384 1732 remote_runtime.go:1359] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Oct 16 23:41:21.541463 kubelet[1732]: I1016 23:41:21.541451 1732 server.go:1479] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Oct 16 23:41:21.547968 kubelet[1732]: I1016 23:41:21.547758 1732 server.go:858] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Oct 16 23:41:21.548365 kubelet[1732]: I1016 23:41:21.548156 1732 container_manager_linux.go:273] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Oct 16 23:41:21.549192 kubelet[1732]: I1016 23:41:21.548197 1732 container_manager_linux.go:278] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.37","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"MemoryReservationPolicy":"None","MemoryThrottlingFactor":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Oct 16 23:41:21.549192 kubelet[1732]: I1016 23:41:21.548862 1732 topology_manager.go:183] "Creating topology manager with none policy" Oct 16 23:41:21.549192 kubelet[1732]: I1016 23:41:21.548871 1732 container_manager_linux.go:310] "Creating device plugin manager" Oct 16 23:41:21.549192 kubelet[1732]: I1016 23:41:21.548960 1732 container_manager_linux.go:319] "Creating Dynamic Resource Allocation (DRA) manager" Oct 16 23:41:21.603939 kubelet[1732]: I1016 23:41:21.603884 1732 state_mem.go:45] "Initialized" logger="CPUManager state memory" Oct 16 23:41:21.604233 kubelet[1732]: I1016 23:41:21.604207 1732 kubelet.go:512] "Attempting to sync node with API server" Oct 16 23:41:21.604233 kubelet[1732]: I1016 23:41:21.604231 1732 kubelet.go:389] "Adding static pod path" path="/etc/kubernetes/manifests" Oct 16 23:41:21.604271 kubelet[1732]: I1016 23:41:21.604260 1732 kubelet.go:400] "Adding apiserver pod source" Oct 16 23:41:21.604287 kubelet[1732]: I1016 23:41:21.604274 1732 apiserver.go:41] "Waiting for node sync before watching apiserver pods" Oct 16 23:41:21.605840 kubelet[1732]: E1016 23:41:21.605788 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:21.607367 kubelet[1732]: E1016 23:41:21.607304 1732 file.go:97] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:21.608842 kubelet[1732]: I1016 23:41:21.608807 1732 kuberuntime_manager.go:315] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Oct 16 23:41:21.610860 kubelet[1732]: I1016 23:41:21.610800 1732 kubelet.go:1011] "ClusterTrustBundle informer will be started eventually once a trust bundle is requested" Oct 16 23:41:21.610929 kubelet[1732]: I1016 23:41:21.610884 1732 podcertificatemanager.go:340] "podcertificate.IssuingManager starting up" Oct 16 23:41:21.610929 kubelet[1732]: W1016 23:41:21.610916 1732 probe.go:275] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614172 1732 server.go:1336] "Started kubelet" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614267 1732 server.go:196] "Starting to listen" address="0.0.0.0" port=10250 Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614644 1732 server.go:293] "Starting to serve the pods API" endpoint="unix:/var/lib/kubelet/pods-api/pods-api.sock" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614755 1732 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614779 1732 server_v1.go:49] "podresources" method="list" useActivePods=true Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.614871 1732 server.go:267] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.615288 1732 server.go:365] "Adding debug handlers to kubelet server" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.615427 1732 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.615953 1732 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Oct 16 23:41:21.616215 kubelet[1732]: I1016 23:41:21.616030 1732 tlsconfig.go:243] "Starting DynamicServingCertificateController" Oct 16 23:41:21.617836 kubelet[1732]: I1016 23:41:21.617818 1732 volume_manager.go:331] "Starting Kubelet Volume Manager" Oct 16 23:41:21.617928 kubelet[1732]: I1016 23:41:21.617907 1732 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Oct 16 23:41:21.618000 kubelet[1732]: I1016 23:41:21.617957 1732 reconciler.go:29] "Reconciler: start to sync state" Oct 16 23:41:21.618296 kubelet[1732]: I1016 23:41:21.618265 1732 factory.go:222] Registration of the systemd container factory successfully Oct 16 23:41:21.618358 kubelet[1732]: I1016 23:41:21.618337 1732 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 Oct 16 23:41:21.618692 kubelet[1732]: E1016 23:41:21.618647 1732 kubelet_node_status.go:396] "Error getting the current node from lister" err="node \"10.0.0.37\" not found" Oct 16 23:41:21.618811 kubelet[1732]: E1016 23:41:21.618774 1732 kubelet.go:3596] "Unable to register mirror pod because node is not registered yet" err="node \"10.0.0.37\" not found" node="10.0.0.37" Oct 16 23:41:21.619476 kubelet[1732]: E1016 23:41:21.619456 1732 kubelet.go:1754] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Oct 16 23:41:21.620498 kubelet[1732]: I1016 23:41:21.620454 1732 factory.go:222] Registration of the containerd container factory successfully Oct 16 23:41:21.628532 kubelet[1732]: I1016 23:41:21.628505 1732 cpu_manager.go:239] "Starting" policy="none" Oct 16 23:41:21.628532 kubelet[1732]: I1016 23:41:21.628522 1732 cpu_manager.go:240] "Reconciling" reconcilePeriod="10s" Oct 16 23:41:21.628532 kubelet[1732]: I1016 23:41:21.628541 1732 state_mem.go:45] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Oct 16 23:41:21.628638 kubelet[1732]: I1016 23:41:21.628546 1732 state_checkpoint.go:191] "trying to load v4 CPU manager checkpoint" logger="CPUManager state checkpoint" Oct 16 23:41:21.631270 kubelet[1732]: I1016 23:41:21.631242 1732 policy_none.go:51] "Start" Oct 16 23:41:21.631270 kubelet[1732]: I1016 23:41:21.631272 1732 memory_manager.go:209] "Starting memorymanager" policy="None" Oct 16 23:41:21.631367 kubelet[1732]: I1016 23:41:21.631281 1732 state_mem.go:39] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Oct 16 23:41:21.632374 kubelet[1732]: E1016 23:41:21.632125 1732 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.37\" not found" node="10.0.0.37" Oct 16 23:41:21.635125 kubelet[1732]: I1016 23:41:21.635098 1732 policy_none.go:47] "Start" Oct 16 23:41:21.640295 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Oct 16 23:41:21.649572 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Oct 16 23:41:21.652344 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Oct 16 23:41:21.661990 kubelet[1732]: E1016 23:41:21.661951 1732 manager.go:550] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Oct 16 23:41:21.662492 kubelet[1732]: I1016 23:41:21.662144 1732 eviction_manager.go:193] "Eviction manager: starting control loop" Oct 16 23:41:21.662492 kubelet[1732]: I1016 23:41:21.662156 1732 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Oct 16 23:41:21.662492 kubelet[1732]: I1016 23:41:21.662379 1732 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Oct 16 23:41:21.664022 kubelet[1732]: E1016 23:41:21.663559 1732 eviction_manager.go:280] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Oct 16 23:41:21.664022 kubelet[1732]: E1016 23:41:21.663592 1732 eviction_manager.go:305] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.37\" not found" Oct 16 23:41:21.676514 kubelet[1732]: I1016 23:41:21.676438 1732 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv4" Oct 16 23:41:21.677477 kubelet[1732]: I1016 23:41:21.677455 1732 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv6" Oct 16 23:41:21.677515 kubelet[1732]: I1016 23:41:21.677482 1732 status_manager.go:283] "Starting to sync pod status with apiserver" Oct 16 23:41:21.677515 kubelet[1732]: I1016 23:41:21.677504 1732 kubelet.go:2673] "Starting kubelet main sync loop" Oct 16 23:41:21.677559 kubelet[1732]: E1016 23:41:21.677535 1732 kubelet.go:2697] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Oct 16 23:41:21.719561 kubelet[1732]: E1016 23:41:21.719477 1732 kubelet.go:3596] "Unable to register mirror pod because node is not registered yet" err="node \"10.0.0.37\" not found" node="10.0.0.37" Oct 16 23:41:21.763714 kubelet[1732]: I1016 23:41:21.763676 1732 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.37" Oct 16 23:41:21.768128 kubelet[1732]: I1016 23:41:21.768085 1732 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.37" Oct 16 23:41:21.768128 kubelet[1732]: E1016 23:41:21.768113 1732 kubelet_node_status.go:479] "Error updating node status, will retry" err="error getting node \"10.0.0.37\": node \"10.0.0.37\" not found" Oct 16 23:41:21.844700 sudo[1594]: pam_unix(sudo:session): session closed for user root Oct 16 23:41:21.846850 sshd[1591]: pam_unix(sshd:session): session closed for user core Oct 16 23:41:21.850358 systemd[1]: sshd@4-10.0.0.37:22-10.0.0.1:48374.service: Deactivated successfully. Oct 16 23:41:21.852566 systemd[1]: session-5.scope: Deactivated successfully. Oct 16 23:41:21.853268 systemd-logind[1444]: Session 5 logged out. Waiting for processes to exit. Oct 16 23:41:21.854024 systemd-logind[1444]: Removed session 5. Oct 16 23:41:21.879266 kubelet[1732]: I1016 23:41:21.879218 1732 kuberuntime_manager.go:2315] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Oct 16 23:41:21.879724 containerd[1463]: time="2026-10-16T23:41:21.879678530Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Oct 16 23:41:21.879967 kubelet[1732]: I1016 23:41:21.879919 1732 kubelet_network.go:48] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Oct 16 23:41:22.534756 kubelet[1732]: I1016 23:41:22.534638 1732 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Oct 16 23:41:22.535545 kubelet[1732]: I1016 23:41:22.535093 1732 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:178" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:178: Unexpected watch close - watch lasted less than a second and no items received" Oct 16 23:41:22.535545 kubelet[1732]: I1016 23:41:22.535137 1732 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:178" type="*v1.PodCertificateRequest" err="very short watch: k8s.io/client-go/informers/factory.go:178: Unexpected watch close - watch lasted less than a second and no items received" Oct 16 23:41:22.535545 kubelet[1732]: I1016 23:41:22.535164 1732 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:178" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:178: Unexpected watch close - watch lasted less than a second and no items received" Oct 16 23:41:22.535545 kubelet[1732]: I1016 23:41:22.535144 1732 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:178" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:178: Unexpected watch close - watch lasted less than a second and no items received" Oct 16 23:41:22.605962 kubelet[1732]: E1016 23:41:22.605905 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:22.605962 kubelet[1732]: I1016 23:41:22.605928 1732 apiserver.go:51] "Watching apiserver" Oct 16 23:41:22.615754 kubelet[1732]: I1016 23:41:22.615680 1732 server.go:177] "Pod update broadcasted" podUID="c1b52ecd-dd2c-4473-8025-fe3263649c8f" type="ADDED" Oct 16 23:41:22.616835 kubelet[1732]: I1016 23:41:22.616812 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="ADDED" Oct 16 23:41:22.618288 kubelet[1732]: I1016 23:41:22.618241 1732 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Oct 16 23:41:22.621908 systemd[1]: Created slice kubepods-besteffort-podc1b52ecd_dd2c_4473_8025_fe3263649c8f.slice - libcontainer container kubepods-besteffort-podc1b52ecd_dd2c_4473_8025_fe3263649c8f.slice. Oct 16 23:41:22.622515 kubelet[1732]: I1016 23:41:22.622495 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/d7e83521-b7ad-4010-b50c-38b745a88731-run\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622544 kubelet[1732]: I1016 23:41:22.622526 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/d7e83521-b7ad-4010-b50c-38b745a88731-cni-plugin\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622544 kubelet[1732]: I1016 23:41:22.622542 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/d7e83521-b7ad-4010-b50c-38b745a88731-cni\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622583 kubelet[1732]: I1016 23:41:22.622552 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/d7e83521-b7ad-4010-b50c-38b745a88731-flannel-cfg\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622583 kubelet[1732]: I1016 23:41:22.622563 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d7e83521-b7ad-4010-b50c-38b745a88731-xtables-lock\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622583 kubelet[1732]: I1016 23:41:22.622573 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hptjn\" (UniqueName: \"kubernetes.io/projected/d7e83521-b7ad-4010-b50c-38b745a88731-kube-api-access-hptjn\") pod \"kube-flannel-ds-7tv6z\" (UID: \"d7e83521-b7ad-4010-b50c-38b745a88731\") " pod="kube-flannel/kube-flannel-ds-7tv6z" Oct 16 23:41:22.622632 kubelet[1732]: I1016 23:41:22.622587 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/c1b52ecd-dd2c-4473-8025-fe3263649c8f-kube-proxy\") pod \"kube-proxy-vg76m\" (UID: \"c1b52ecd-dd2c-4473-8025-fe3263649c8f\") " pod="kube-system/kube-proxy-vg76m" Oct 16 23:41:22.622632 kubelet[1732]: I1016 23:41:22.622598 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/c1b52ecd-dd2c-4473-8025-fe3263649c8f-xtables-lock\") pod \"kube-proxy-vg76m\" (UID: \"c1b52ecd-dd2c-4473-8025-fe3263649c8f\") " pod="kube-system/kube-proxy-vg76m" Oct 16 23:41:22.622632 kubelet[1732]: I1016 23:41:22.622608 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/c1b52ecd-dd2c-4473-8025-fe3263649c8f-lib-modules\") pod \"kube-proxy-vg76m\" (UID: \"c1b52ecd-dd2c-4473-8025-fe3263649c8f\") " pod="kube-system/kube-proxy-vg76m" Oct 16 23:41:22.622694 kubelet[1732]: I1016 23:41:22.622675 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8nzvv\" (UniqueName: \"kubernetes.io/projected/c1b52ecd-dd2c-4473-8025-fe3263649c8f-kube-api-access-8nzvv\") pod \"kube-proxy-vg76m\" (UID: \"c1b52ecd-dd2c-4473-8025-fe3263649c8f\") " pod="kube-system/kube-proxy-vg76m" Oct 16 23:41:22.635023 systemd[1]: Created slice kubepods-burstable-podd7e83521_b7ad_4010_b50c_38b745a88731.slice - libcontainer container kubepods-burstable-podd7e83521_b7ad_4010_b50c_38b745a88731.slice. Oct 16 23:41:22.936041 kubelet[1732]: E1016 23:41:22.935905 1732 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" Oct 16 23:41:22.936847 containerd[1463]: time="2026-10-16T23:41:22.936794414Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-vg76m,Uid:c1b52ecd-dd2c-4473-8025-fe3263649c8f,Namespace:kube-system,Attempt:0,}" Oct 16 23:41:22.944816 kubelet[1732]: E1016 23:41:22.944782 1732 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" Oct 16 23:41:22.945357 containerd[1463]: time="2026-10-16T23:41:22.945155859Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-7tv6z,Uid:d7e83521-b7ad-4010-b50c-38b745a88731,Namespace:kube-flannel,Attempt:0,}" Oct 16 23:41:23.330196 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount179593425.mount: Deactivated successfully. Oct 16 23:41:23.335160 containerd[1463]: time="2026-10-16T23:41:23.335124214Z" 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\"}" Oct 16 23:41:23.336363 containerd[1463]: time="2026-10-16T23:41:23.336326639Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312116" Oct 16 23:41:23.336891 containerd[1463]: time="2026-10-16T23:41:23.336865134Z" 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\"}" Oct 16 23:41:23.337522 containerd[1463]: time="2026-10-16T23:41:23.337494985Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Oct 16 23:41:23.337948 containerd[1463]: time="2026-10-16T23:41:23.337916001Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Oct 16 23:41:23.339519 containerd[1463]: time="2026-10-16T23:41:23.339486871Z" 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\"}" Oct 16 23:41:23.340586 containerd[1463]: time="2026-10-16T23:41:23.340563872Z" 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 403.67942ms" Oct 16 23:41:23.341042 containerd[1463]: time="2026-10-16T23:41:23.341020163Z" 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 395.805222ms" Oct 16 23:41:23.413416 containerd[1463]: time="2026-10-16T23:41:23.413322669Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 16 23:41:23.413416 containerd[1463]: time="2026-10-16T23:41:23.413366105Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 16 23:41:23.413416 containerd[1463]: time="2026-10-16T23:41:23.413377335Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:23.413549 containerd[1463]: time="2026-10-16T23:41:23.413451863Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:23.414182 containerd[1463]: time="2026-10-16T23:41:23.414123828Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 16 23:41:23.414182 containerd[1463]: time="2026-10-16T23:41:23.414155085Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 16 23:41:23.414182 containerd[1463]: time="2026-10-16T23:41:23.414165754Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:23.414237 containerd[1463]: time="2026-10-16T23:41:23.414213511Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:23.468561 systemd[1]: Started cri-containerd-1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c.scope - libcontainer container 1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c. Oct 16 23:41:23.469519 systemd[1]: Started cri-containerd-ae093a55ce6916c486aa3eca94d827953b14851d2c550acaab69d38d8df63c96.scope - libcontainer container ae093a55ce6916c486aa3eca94d827953b14851d2c550acaab69d38d8df63c96. Oct 16 23:41:23.489186 containerd[1463]: time="2026-10-16T23:41:23.489132368Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-vg76m,Uid:c1b52ecd-dd2c-4473-8025-fe3263649c8f,Namespace:kube-system,Attempt:0,} returns sandbox id \"ae093a55ce6916c486aa3eca94d827953b14851d2c550acaab69d38d8df63c96\"" Oct 16 23:41:23.492847 kubelet[1732]: E1016 23:41:23.492580 1732 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" Oct 16 23:41:23.492847 kubelet[1732]: I1016 23:41:23.492677 1732 server.go:177] "Pod update broadcasted" podUID="c1b52ecd-dd2c-4473-8025-fe3263649c8f" type="MODIFIED" Oct 16 23:41:23.494085 containerd[1463]: time="2026-10-16T23:41:23.494035332Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.37.1\"" Oct 16 23:41:23.501184 containerd[1463]: time="2026-10-16T23:41:23.501148677Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-7tv6z,Uid:d7e83521-b7ad-4010-b50c-38b745a88731,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\"" Oct 16 23:41:23.502003 kubelet[1732]: E1016 23:41:23.501933 1732 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" Oct 16 23:41:23.502003 kubelet[1732]: I1016 23:41:23.501964 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:23.606513 kubelet[1732]: E1016 23:41:23.606227 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:24.128301 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2911218477.mount: Deactivated successfully. Oct 16 23:41:24.349807 containerd[1463]: time="2026-10-16T23:41:24.349729982Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.37.1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:24.350318 containerd[1463]: time="2026-10-16T23:41:24.350287101Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.37.1: active requests=0, bytes read=30219266" Oct 16 23:41:24.351174 containerd[1463]: time="2026-10-16T23:41:24.351126719Z" level=info msg="ImageCreate event name:\"sha256:728902c90c8b555afa3fdb372f31c83f932a8c6369d37b44dea9e8ddc835d42e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:24.352631 containerd[1463]: time="2026-10-16T23:41:24.352606412Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:b9ae667ed9c160c9d5b66f55e8afec97fc5483a12db0ada5286541b0385cb9f4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:24.353679 containerd[1463]: time="2026-10-16T23:41:24.353645412Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.37.1\" with image id \"sha256:728902c90c8b555afa3fdb372f31c83f932a8c6369d37b44dea9e8ddc835d42e\", repo tag \"registry.k8s.io/kube-proxy:v1.37.1\", repo digest \"registry.k8s.io/kube-proxy@sha256:b9ae667ed9c160c9d5b66f55e8afec97fc5483a12db0ada5286541b0385cb9f4\", size \"30218046\" in 859.319374ms" Oct 16 23:41:24.353715 containerd[1463]: time="2026-10-16T23:41:24.353678293Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.37.1\" returns image reference \"sha256:728902c90c8b555afa3fdb372f31c83f932a8c6369d37b44dea9e8ddc835d42e\"" Oct 16 23:41:24.354800 containerd[1463]: time="2026-10-16T23:41:24.354777655Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Oct 16 23:41:24.356241 containerd[1463]: time="2026-10-16T23:41:24.356212016Z" level=info msg="CreateContainer within sandbox \"ae093a55ce6916c486aa3eca94d827953b14851d2c550acaab69d38d8df63c96\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Oct 16 23:41:24.365825 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3668395606.mount: Deactivated successfully. Oct 16 23:41:24.368093 containerd[1463]: time="2026-10-16T23:41:24.368038550Z" level=info msg="CreateContainer within sandbox \"ae093a55ce6916c486aa3eca94d827953b14851d2c550acaab69d38d8df63c96\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"5b4e9b1b6ee8bff57f60723af4ee6d932f30a21e4f024be028fd0ba7316044ad\"" Oct 16 23:41:24.368735 containerd[1463]: time="2026-10-16T23:41:24.368711462Z" level=info msg="StartContainer for \"5b4e9b1b6ee8bff57f60723af4ee6d932f30a21e4f024be028fd0ba7316044ad\"" Oct 16 23:41:24.393580 systemd[1]: Started cri-containerd-5b4e9b1b6ee8bff57f60723af4ee6d932f30a21e4f024be028fd0ba7316044ad.scope - libcontainer container 5b4e9b1b6ee8bff57f60723af4ee6d932f30a21e4f024be028fd0ba7316044ad. Oct 16 23:41:24.415468 containerd[1463]: time="2026-10-16T23:41:24.415060022Z" level=info msg="StartContainer for \"5b4e9b1b6ee8bff57f60723af4ee6d932f30a21e4f024be028fd0ba7316044ad\" returns successfully" Oct 16 23:41:24.417772 kubelet[1732]: I1016 23:41:24.417739 1732 server.go:177] "Pod update broadcasted" podUID="c1b52ecd-dd2c-4473-8025-fe3263649c8f" type="MODIFIED" Oct 16 23:41:24.427092 kubelet[1732]: I1016 23:41:24.426999 1732 pod_startup_latency_tracker.go:144] "Observed pod startup duration" pod="kube-system/kube-proxy-vg76m" podStartSLOduration=2.566108973 podStartE2EDuration="3.426988064s" totalImagesPullingTime="860.879091ms" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-10-16 23:41:21 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-10-16 23:41:24.426972735 +0000 UTC m=+3.088533768" watchObservedRunningTime="2026-10-16 23:41:24.426988064 +0000 UTC m=+3.088549108" Oct 16 23:41:24.606930 kubelet[1732]: E1016 23:41:24.606890 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:25.607715 kubelet[1732]: E1016 23:41:25.607653 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:25.664956 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1117659048.mount: Deactivated successfully. Oct 16 23:41:25.695232 containerd[1463]: time="2026-10-16T23:41:25.695162258Z" 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\"}" Oct 16 23:41:25.695711 containerd[1463]: time="2026-10-16T23:41:25.695675580Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Oct 16 23:41:25.696449 containerd[1463]: time="2026-10-16T23:41:25.696417168Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:25.698878 containerd[1463]: time="2026-10-16T23:41:25.698842266Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:25.699764 containerd[1463]: time="2026-10-16T23:41:25.699737389Z" 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.344932186s" Oct 16 23:41:25.699809 containerd[1463]: time="2026-10-16T23:41:25.699765828Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Oct 16 23:41:25.701781 containerd[1463]: time="2026-10-16T23:41:25.701757005Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Oct 16 23:41:25.710066 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount207184775.mount: Deactivated successfully. Oct 16 23:41:25.712197 containerd[1463]: time="2026-10-16T23:41:25.712157724Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd\"" Oct 16 23:41:25.713096 containerd[1463]: time="2026-10-16T23:41:25.712545773Z" level=info msg="StartContainer for \"b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd\"" Oct 16 23:41:25.735585 systemd[1]: Started cri-containerd-b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd.scope - libcontainer container b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd. Oct 16 23:41:25.754004 containerd[1463]: time="2026-10-16T23:41:25.753942837Z" level=info msg="StartContainer for \"b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd\" returns successfully" Oct 16 23:41:25.754660 systemd[1]: cri-containerd-b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd.scope: Deactivated successfully. Oct 16 23:41:25.756882 kubelet[1732]: I1016 23:41:25.756860 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:25.771351 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd-rootfs.mount: Deactivated successfully. Oct 16 23:41:25.847977 containerd[1463]: time="2026-10-16T23:41:25.847873486Z" level=info msg="shim disconnected" id=b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd namespace=k8s.io Oct 16 23:41:25.847977 containerd[1463]: time="2026-10-16T23:41:25.847934917Z" level=warning msg="cleaning up after shim disconnected" id=b04b3fd56fbd7b2425c7ddbe18b550dde87465971046ba54cf988aa2484907dd namespace=k8s.io Oct 16 23:41:25.847977 containerd[1463]: time="2026-10-16T23:41:25.847941621Z" level=info msg="cleaning up dead shim" namespace=k8s.io Oct 16 23:41:26.608233 kubelet[1732]: E1016 23:41:26.608174 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:26.690068 kubelet[1732]: I1016 23:41:26.689918 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:26.690225 kubelet[1732]: E1016 23:41:26.690155 1732 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" Oct 16 23:41:26.690969 containerd[1463]: time="2026-10-16T23:41:26.690941413Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Oct 16 23:41:27.609158 kubelet[1732]: E1016 23:41:27.609113 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:28.507041 containerd[1463]: time="2026-10-16T23:41:28.506977651Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:28.507556 containerd[1463]: time="2026-10-16T23:41:28.507523950Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Oct 16 23:41:28.508667 containerd[1463]: time="2026-10-16T23:41:28.508618250Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:28.512129 containerd[1463]: time="2026-10-16T23:41:28.512047208Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:28.513268 containerd[1463]: time="2026-10-16T23:41:28.513243821Z" 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.822268683s" Oct 16 23:41:28.513306 containerd[1463]: time="2026-10-16T23:41:28.513273051Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Oct 16 23:41:28.515127 containerd[1463]: time="2026-10-16T23:41:28.515102451Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Oct 16 23:41:28.524872 containerd[1463]: time="2026-10-16T23:41:28.524791963Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667\"" Oct 16 23:41:28.525355 containerd[1463]: time="2026-10-16T23:41:28.525323358Z" level=info msg="StartContainer for \"4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667\"" Oct 16 23:41:28.551571 systemd[1]: Started cri-containerd-4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667.scope - libcontainer container 4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667. Oct 16 23:41:28.570296 systemd[1]: cri-containerd-4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667.scope: Deactivated successfully. Oct 16 23:41:28.572120 containerd[1463]: time="2026-10-16T23:41:28.572058511Z" level=info msg="StartContainer for \"4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667\" returns successfully" Oct 16 23:41:28.574127 kubelet[1732]: I1016 23:41:28.574078 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:28.587309 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667-rootfs.mount: Deactivated successfully. Oct 16 23:41:28.609296 kubelet[1732]: E1016 23:41:28.609243 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:28.609296 kubelet[1732]: I1016 23:41:28.609294 1732 kubelet_node_status.go:431] "Fast updating node status as it just became ready" Oct 16 23:41:28.649950 containerd[1463]: time="2026-10-16T23:41:28.649874334Z" level=info msg="shim disconnected" id=4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667 namespace=k8s.io Oct 16 23:41:28.649950 containerd[1463]: time="2026-10-16T23:41:28.649920836Z" level=warning msg="cleaning up after shim disconnected" id=4d4161fcaa162d2117e1b07d34c615c0dcc3a45b348d046b125964e9206c1667 namespace=k8s.io Oct 16 23:41:28.649950 containerd[1463]: time="2026-10-16T23:41:28.649928427Z" level=info msg="cleaning up dead shim" namespace=k8s.io Oct 16 23:41:28.693074 kubelet[1732]: I1016 23:41:28.693013 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:28.693271 kubelet[1732]: E1016 23:41:28.693217 1732 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" Oct 16 23:41:28.695212 containerd[1463]: time="2026-10-16T23:41:28.695168862Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Oct 16 23:41:28.706321 containerd[1463]: time="2026-10-16T23:41:28.706264541Z" level=info msg="CreateContainer within sandbox \"1e287ac0f413c3f1a91529af7b05cf1acd5a7c408bde707e1c8ab4f11a30c90c\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"df217ca35e23a4fc1457d39cdb49d886d3d18662ad909e370c711a6b186efbbb\"" Oct 16 23:41:28.706809 containerd[1463]: time="2026-10-16T23:41:28.706784748Z" level=info msg="StartContainer for \"df217ca35e23a4fc1457d39cdb49d886d3d18662ad909e370c711a6b186efbbb\"" Oct 16 23:41:28.728542 systemd[1]: Started cri-containerd-df217ca35e23a4fc1457d39cdb49d886d3d18662ad909e370c711a6b186efbbb.scope - libcontainer container df217ca35e23a4fc1457d39cdb49d886d3d18662ad909e370c711a6b186efbbb. Oct 16 23:41:28.747469 containerd[1463]: time="2026-10-16T23:41:28.747382998Z" level=info msg="StartContainer for \"df217ca35e23a4fc1457d39cdb49d886d3d18662ad909e370c711a6b186efbbb\" returns successfully" Oct 16 23:41:28.750700 kubelet[1732]: I1016 23:41:28.750659 1732 server.go:177] "Pod update broadcasted" podUID="d7e83521-b7ad-4010-b50c-38b745a88731" type="MODIFIED" Oct 16 23:41:28.811997 kubelet[1732]: I1016 23:41:28.811805 1732 pod_startup_latency_tracker.go:144] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-7tv6z" podStartSLOduration=3.790330431 podStartE2EDuration="7.811785416s" totalImagesPullingTime="4.021454985s" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-10-16 23:41:21 +0000 UTC" imagePullSessionsCount=2 imagePullSessionsStartsCount=0 observedRunningTime="2026-10-16 23:41:28.811741675 +0000 UTC m=+7.473302718" watchObservedRunningTime="2026-10-16 23:41:28.811785416 +0000 UTC m=+7.473346466" Oct 16 23:41:29.609883 kubelet[1732]: E1016 23:41:29.609794 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:29.802969 systemd-networkd[1395]: flannel.1: Link UP Oct 16 23:41:29.802980 systemd-networkd[1395]: flannel.1: Gained carrier Oct 16 23:41:30.610522 kubelet[1732]: E1016 23:41:30.610449 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:31.354641 systemd-networkd[1395]: flannel.1: Gained IPv6LL Oct 16 23:41:31.611603 kubelet[1732]: E1016 23:41:31.611298 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:32.539584 kubelet[1732]: I1016 23:41:32.539514 1732 server.go:177] "Pod update broadcasted" podUID="7b99c408-9a0d-4ae0-bf31-256357c487b9" type="ADDED" Oct 16 23:41:32.545333 systemd[1]: Created slice kubepods-besteffort-pod7b99c408_9a0d_4ae0_bf31_256357c487b9.slice - libcontainer container kubepods-besteffort-pod7b99c408_9a0d_4ae0_bf31_256357c487b9.slice. Oct 16 23:41:32.589260 kubelet[1732]: I1016 23:41:32.589177 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-kqkm8\" (UniqueName: \"kubernetes.io/projected/7b99c408-9a0d-4ae0-bf31-256357c487b9-kube-api-access-kqkm8\") pod \"nginx-deployment-5b96b857d-dzxg6\" (UID: \"7b99c408-9a0d-4ae0-bf31-256357c487b9\") " pod="default/nginx-deployment-5b96b857d-dzxg6" Oct 16 23:41:32.611960 kubelet[1732]: E1016 23:41:32.611888 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:32.853525 containerd[1463]: time="2026-10-16T23:41:32.853300947Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-5b96b857d-dzxg6,Uid:7b99c408-9a0d-4ae0-bf31-256357c487b9,Namespace:default,Attempt:0,}" Oct 16 23:41:32.870506 systemd-networkd[1395]: cni0: Link UP Oct 16 23:41:32.870513 systemd-networkd[1395]: cni0: Gained carrier Oct 16 23:41:32.871707 systemd-networkd[1395]: cni0: Lost carrier Oct 16 23:41:32.881653 kernel: cni0: port 1(vethacefa2e0) entered blocking state Oct 16 23:41:32.881709 kernel: cni0: port 1(vethacefa2e0) entered disabled state Oct 16 23:41:32.881722 kernel: vethacefa2e0: entered allmulticast mode Oct 16 23:41:32.879083 systemd-networkd[1395]: vethacefa2e0: Link UP Oct 16 23:41:32.883056 kernel: vethacefa2e0: entered promiscuous mode Oct 16 23:41:32.886774 kernel: cni0: port 1(vethacefa2e0) entered blocking state Oct 16 23:41:32.886824 kernel: cni0: port 1(vethacefa2e0) entered forwarding state Oct 16 23:41:32.886838 kernel: cni0: port 1(vethacefa2e0) entered disabled state Oct 16 23:41:32.895242 kernel: cni0: port 1(vethacefa2e0) entered blocking state Oct 16 23:41:32.895273 kernel: cni0: port 1(vethacefa2e0) entered forwarding state Oct 16 23:41:32.895334 systemd-networkd[1395]: vethacefa2e0: Gained carrier Oct 16 23:41:32.895542 systemd-networkd[1395]: cni0: Gained carrier Oct 16 23:41:32.897273 containerd[1463]: 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"} Oct 16 23:41:32.897273 containerd[1463]: delegateAdd: netconf sent to delegate plugin: Oct 16 23:41:32.921998 containerd[1463]: {"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-10-16T23:41:32.921892778Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 16 23:41:32.923133 containerd[1463]: time="2026-10-16T23:41:32.923023573Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 16 23:41:32.923133 containerd[1463]: time="2026-10-16T23:41:32.923080008Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:32.923216 containerd[1463]: time="2026-10-16T23:41:32.923174585Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:32.943554 systemd[1]: Started cri-containerd-354efa9935906cefd6b33f71cbf4a46b0134be4d1d321389e5f27115455550de.scope - libcontainer container 354efa9935906cefd6b33f71cbf4a46b0134be4d1d321389e5f27115455550de. Oct 16 23:41:32.956715 systemd-resolved[1397]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 16 23:41:32.980751 containerd[1463]: time="2026-10-16T23:41:32.980701234Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-5b96b857d-dzxg6,Uid:7b99c408-9a0d-4ae0-bf31-256357c487b9,Namespace:default,Attempt:0,} returns sandbox id \"354efa9935906cefd6b33f71cbf4a46b0134be4d1d321389e5f27115455550de\"" Oct 16 23:41:32.981552 kubelet[1732]: I1016 23:41:32.981519 1732 server.go:177] "Pod update broadcasted" podUID="7b99c408-9a0d-4ae0-bf31-256357c487b9" type="MODIFIED" Oct 16 23:41:32.982081 containerd[1463]: time="2026-10-16T23:41:32.981997151Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 16 23:41:33.612705 kubelet[1732]: E1016 23:41:33.612643 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:33.978712 systemd-networkd[1395]: vethacefa2e0: Gained IPv6LL Oct 16 23:41:34.235042 systemd-networkd[1395]: cni0: Gained IPv6LL Oct 16 23:41:34.613621 kubelet[1732]: E1016 23:41:34.613370 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:35.622828 kubelet[1732]: E1016 23:41:35.622719 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:35.719519 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1180254246.mount: Deactivated successfully. Oct 16 23:41:36.444837 containerd[1463]: time="2026-10-16T23:41:36.444775573Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:36.445301 containerd[1463]: time="2026-10-16T23:41:36.445269318Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=64640498" Oct 16 23:41:36.445981 containerd[1463]: time="2026-10-16T23:41:36.445938631Z" level=info msg="ImageCreate event name:\"sha256:3a8edbda21b6357f9d8e8d441c00c44673e89af4c157e76f0f117f2429570e60\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:36.448064 containerd[1463]: time="2026-10-16T23:41:36.448020252Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:a183384b53e7717e9c1e3faf17393ce4dfa3d0800d250cceb829a2bde27f6bc2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:36.448833 containerd[1463]: time="2026-10-16T23:41:36.448800288Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:3a8edbda21b6357f9d8e8d441c00c44673e89af4c157e76f0f117f2429570e60\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a183384b53e7717e9c1e3faf17393ce4dfa3d0800d250cceb829a2bde27f6bc2\", size \"64640376\" in 3.46677231s" Oct 16 23:41:36.448868 containerd[1463]: time="2026-10-16T23:41:36.448831361Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:3a8edbda21b6357f9d8e8d441c00c44673e89af4c157e76f0f117f2429570e60\"" Oct 16 23:41:36.450534 containerd[1463]: time="2026-10-16T23:41:36.450507800Z" level=info msg="CreateContainer within sandbox \"354efa9935906cefd6b33f71cbf4a46b0134be4d1d321389e5f27115455550de\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Oct 16 23:41:36.458762 containerd[1463]: time="2026-10-16T23:41:36.458719458Z" level=info msg="CreateContainer within sandbox \"354efa9935906cefd6b33f71cbf4a46b0134be4d1d321389e5f27115455550de\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"c093013ffba6f6e12e7be3e39292ffaa542f2d4ccc59d9b6817db0c10ccd94e7\"" Oct 16 23:41:36.459159 containerd[1463]: time="2026-10-16T23:41:36.459132185Z" level=info msg="StartContainer for \"c093013ffba6f6e12e7be3e39292ffaa542f2d4ccc59d9b6817db0c10ccd94e7\"" Oct 16 23:41:36.506682 systemd[1]: Started cri-containerd-c093013ffba6f6e12e7be3e39292ffaa542f2d4ccc59d9b6817db0c10ccd94e7.scope - libcontainer container c093013ffba6f6e12e7be3e39292ffaa542f2d4ccc59d9b6817db0c10ccd94e7. Oct 16 23:41:36.533984 containerd[1463]: time="2026-10-16T23:41:36.533828495Z" level=info msg="StartContainer for \"c093013ffba6f6e12e7be3e39292ffaa542f2d4ccc59d9b6817db0c10ccd94e7\" returns successfully" Oct 16 23:41:36.535842 kubelet[1732]: I1016 23:41:36.535797 1732 server.go:177] "Pod update broadcasted" podUID="7b99c408-9a0d-4ae0-bf31-256357c487b9" type="MODIFIED" Oct 16 23:41:36.624632 kubelet[1732]: E1016 23:41:36.624525 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:37.625330 kubelet[1732]: E1016 23:41:37.625040 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:38.625446 kubelet[1732]: E1016 23:41:38.625344 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:38.764704 kubelet[1732]: I1016 23:41:38.764605 1732 pod_startup_latency_tracker.go:144] "Observed pod startup duration" pod="default/nginx-deployment-5b96b857d-dzxg6" podStartSLOduration=3.296776953 podStartE2EDuration="6.764581788s" totalImagesPullingTime="3.467804835s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-10-16 23:41:32 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-10-16 23:41:36.544577687 +0000 UTC m=+15.206138721" watchObservedRunningTime="2026-10-16 23:41:38.764581788 +0000 UTC m=+17.426142821" Oct 16 23:41:38.770171 kubelet[1732]: I1016 23:41:38.770093 1732 server.go:177] "Pod update broadcasted" podUID="64267bf7-c027-4b2c-8dcc-5933aa959688" type="ADDED" Oct 16 23:41:38.775741 systemd[1]: Created slice kubepods-besteffort-pod64267bf7_c027_4b2c_8dcc_5933aa959688.slice - libcontainer container kubepods-besteffort-pod64267bf7_c027_4b2c_8dcc_5933aa959688.slice. Oct 16 23:41:38.791077 kubelet[1732]: I1016 23:41:38.791003 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/64267bf7-c027-4b2c-8dcc-5933aa959688-data\") pod \"nfs-server-provisioner-0\" (UID: \"64267bf7-c027-4b2c-8dcc-5933aa959688\") " pod="default/nfs-server-provisioner-0" Oct 16 23:41:38.791077 kubelet[1732]: I1016 23:41:38.791050 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-pmntx\" (UniqueName: \"kubernetes.io/projected/64267bf7-c027-4b2c-8dcc-5933aa959688-kube-api-access-pmntx\") pod \"nfs-server-provisioner-0\" (UID: \"64267bf7-c027-4b2c-8dcc-5933aa959688\") " pod="default/nfs-server-provisioner-0" Oct 16 23:41:39.085161 containerd[1463]: time="2026-10-16T23:41:39.084962941Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:64267bf7-c027-4b2c-8dcc-5933aa959688,Namespace:default,Attempt:0,}" Oct 16 23:41:39.104890 systemd-networkd[1395]: vethdc637f36: Link UP Oct 16 23:41:39.106864 kernel: cni0: port 2(vethdc637f36) entered blocking state Oct 16 23:41:39.106931 kernel: cni0: port 2(vethdc637f36) entered disabled state Oct 16 23:41:39.106945 kernel: vethdc637f36: entered allmulticast mode Oct 16 23:41:39.108455 kernel: vethdc637f36: entered promiscuous mode Oct 16 23:41:39.114903 kernel: cni0: port 2(vethdc637f36) entered blocking state Oct 16 23:41:39.114953 kernel: cni0: port 2(vethdc637f36) entered forwarding state Oct 16 23:41:39.116610 systemd-networkd[1395]: vethdc637f36: Gained carrier Oct 16 23:41:39.118698 containerd[1463]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a950), "name":"cbr0", "type":"bridge"} Oct 16 23:41:39.118698 containerd[1463]: delegateAdd: netconf sent to delegate plugin: Oct 16 23:41:39.155992 containerd[1463]: {"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-10-16T23:41:39.155880659Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 16 23:41:39.155992 containerd[1463]: time="2026-10-16T23:41:39.155950776Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 16 23:41:39.155992 containerd[1463]: time="2026-10-16T23:41:39.155966874Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:39.156191 containerd[1463]: time="2026-10-16T23:41:39.156059059Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:39.178813 systemd[1]: Started cri-containerd-7f7f8cd8f4059dc657973b9e75746d72a4290ce5190d4e8829d26e35c1f116f9.scope - libcontainer container 7f7f8cd8f4059dc657973b9e75746d72a4290ce5190d4e8829d26e35c1f116f9. Oct 16 23:41:39.198475 systemd-resolved[1397]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 16 23:41:39.275995 containerd[1463]: time="2026-10-16T23:41:39.275950793Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:64267bf7-c027-4b2c-8dcc-5933aa959688,Namespace:default,Attempt:0,} returns sandbox id \"7f7f8cd8f4059dc657973b9e75746d72a4290ce5190d4e8829d26e35c1f116f9\"" Oct 16 23:41:39.277117 kubelet[1732]: I1016 23:41:39.277090 1732 server.go:177] "Pod update broadcasted" podUID="64267bf7-c027-4b2c-8dcc-5933aa959688" type="MODIFIED" Oct 16 23:41:39.277857 containerd[1463]: time="2026-10-16T23:41:39.277805860Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Oct 16 23:41:39.625950 kubelet[1732]: E1016 23:41:39.625900 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:40.429759 systemd-networkd[1395]: vethdc637f36: Gained IPv6LL Oct 16 23:41:40.626376 kubelet[1732]: E1016 23:41:40.626327 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:40.980194 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount193577914.mount: Deactivated successfully. Oct 16 23:41:41.604671 kubelet[1732]: E1016 23:41:41.604596 1732 file.go:103] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:41.627163 kubelet[1732]: E1016 23:41:41.627087 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:42.628058 kubelet[1732]: E1016 23:41:42.627988 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:42.642377 containerd[1463]: time="2026-10-16T23:41:42.642326019Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:42.643023 containerd[1463]: time="2026-10-16T23:41:42.642970143Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039378" Oct 16 23:41:42.643801 containerd[1463]: time="2026-10-16T23:41:42.643769852Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:42.646340 containerd[1463]: time="2026-10-16T23:41:42.646305091Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:42.647185 containerd[1463]: time="2026-10-16T23:41:42.647161025Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 3.369320255s" Oct 16 23:41:42.647229 containerd[1463]: time="2026-10-16T23:41:42.647191145Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Oct 16 23:41:42.649270 containerd[1463]: time="2026-10-16T23:41:42.649245476Z" level=info msg="CreateContainer within sandbox \"7f7f8cd8f4059dc657973b9e75746d72a4290ce5190d4e8829d26e35c1f116f9\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Oct 16 23:41:42.661522 containerd[1463]: time="2026-10-16T23:41:42.661469062Z" level=info msg="CreateContainer within sandbox \"7f7f8cd8f4059dc657973b9e75746d72a4290ce5190d4e8829d26e35c1f116f9\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"2f267132624ce950988a3223bece5631f348c78495b825659307aa7b8a5e6e1c\"" Oct 16 23:41:42.664117 containerd[1463]: time="2026-10-16T23:41:42.664091493Z" level=info msg="StartContainer for \"2f267132624ce950988a3223bece5631f348c78495b825659307aa7b8a5e6e1c\"" Oct 16 23:41:42.786558 systemd[1]: Started cri-containerd-2f267132624ce950988a3223bece5631f348c78495b825659307aa7b8a5e6e1c.scope - libcontainer container 2f267132624ce950988a3223bece5631f348c78495b825659307aa7b8a5e6e1c. Oct 16 23:41:42.813318 containerd[1463]: time="2026-10-16T23:41:42.813278635Z" level=info msg="StartContainer for \"2f267132624ce950988a3223bece5631f348c78495b825659307aa7b8a5e6e1c\" returns successfully" Oct 16 23:41:42.815571 kubelet[1732]: I1016 23:41:42.815366 1732 server.go:177] "Pod update broadcasted" podUID="64267bf7-c027-4b2c-8dcc-5933aa959688" type="MODIFIED" Oct 16 23:41:42.825641 kubelet[1732]: I1016 23:41:42.825572 1732 pod_startup_latency_tracker.go:144] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.4552683229999999 podStartE2EDuration="4.82556059s" totalImagesPullingTime="3.370292267s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-10-16 23:41:38 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-10-16 23:41:42.825272248 +0000 UTC m=+21.486833297" watchObservedRunningTime="2026-10-16 23:41:42.82556059 +0000 UTC m=+21.487121630" Oct 16 23:41:43.628289 kubelet[1732]: E1016 23:41:43.628207 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:44.629303 kubelet[1732]: E1016 23:41:44.629230 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:45.629952 kubelet[1732]: E1016 23:41:45.629845 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:46.630816 kubelet[1732]: E1016 23:41:46.630719 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:47.631100 kubelet[1732]: E1016 23:41:47.631031 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:48.064496 kubelet[1732]: I1016 23:41:48.064430 1732 server.go:177] "Pod update broadcasted" podUID="e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d" type="ADDED" Oct 16 23:41:48.069957 systemd[1]: Created slice kubepods-besteffort-pode287e9fa_3db3_4c79_9c1e_8554d9d6eb7d.slice - libcontainer container kubepods-besteffort-pode287e9fa_3db3_4c79_9c1e_8554d9d6eb7d.slice. Oct 16 23:41:48.222965 kubelet[1732]: I1016 23:41:48.222870 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-ec326ede-6498-4be6-9f7d-4f82b4050fbe\" (UniqueName: \"kubernetes.io/nfs/e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d-pvc-ec326ede-6498-4be6-9f7d-4f82b4050fbe\") pod \"test-pod-1\" (UID: \"e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d\") " pod="default/test-pod-1" Oct 16 23:41:48.222965 kubelet[1732]: I1016 23:41:48.222941 1732 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-9gtbq\" (UniqueName: \"kubernetes.io/projected/e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d-kube-api-access-9gtbq\") pod \"test-pod-1\" (UID: \"e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d\") " pod="default/test-pod-1" Oct 16 23:41:48.351460 kernel: FS-Cache: Loaded Oct 16 23:41:48.418626 kernel: RPC: Registered named UNIX socket transport module. Oct 16 23:41:48.418780 kernel: RPC: Registered udp transport module. Oct 16 23:41:48.418795 kernel: RPC: Registered tcp transport module. Oct 16 23:41:48.420079 kernel: RPC: Registered tcp-with-tls transport module. Oct 16 23:41:48.420106 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Oct 16 23:41:48.631676 kubelet[1732]: E1016 23:41:48.631555 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:48.636854 kernel: NFS: Registering the id_resolver key type Oct 16 23:41:48.636961 kernel: Key type id_resolver registered Oct 16 23:41:48.636997 kernel: Key type id_legacy registered Oct 16 23:41:48.672681 nfsidmap[2744]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 16 23:41:48.676184 nfsidmap[2747]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Oct 16 23:41:48.977939 containerd[1463]: time="2026-10-16T23:41:48.977895270Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d,Namespace:default,Attempt:0,}" Oct 16 23:41:49.023171 systemd-networkd[1395]: veth9fdb41df: Link UP Oct 16 23:41:49.025758 kernel: cni0: port 3(veth9fdb41df) entered blocking state Oct 16 23:41:49.025797 kernel: cni0: port 3(veth9fdb41df) entered disabled state Oct 16 23:41:49.025810 kernel: veth9fdb41df: entered allmulticast mode Oct 16 23:41:49.027456 kernel: veth9fdb41df: entered promiscuous mode Oct 16 23:41:49.039817 kernel: cni0: port 3(veth9fdb41df) entered blocking state Oct 16 23:41:49.039887 kernel: cni0: port 3(veth9fdb41df) entered forwarding state Oct 16 23:41:49.039942 systemd-networkd[1395]: veth9fdb41df: Gained carrier Oct 16 23:41:49.041956 containerd[1463]: 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)(0xc00009c7f0), "name":"cbr0", "type":"bridge"} Oct 16 23:41:49.041956 containerd[1463]: delegateAdd: netconf sent to delegate plugin: Oct 16 23:41:49.072056 containerd[1463]: {"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-10-16T23:41:49.071913816Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 16 23:41:49.072656 containerd[1463]: time="2026-10-16T23:41:49.072576209Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 16 23:41:49.072656 containerd[1463]: time="2026-10-16T23:41:49.072611705Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:49.072932 containerd[1463]: time="2026-10-16T23:41:49.072858326Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 16 23:41:49.092697 systemd[1]: Started cri-containerd-8159bdc5877096ce724eada1d1693c89004bbb28ad6f99fb703952117629e3c6.scope - libcontainer container 8159bdc5877096ce724eada1d1693c89004bbb28ad6f99fb703952117629e3c6. Oct 16 23:41:49.106584 systemd-resolved[1397]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 16 23:41:49.147139 containerd[1463]: time="2026-10-16T23:41:49.147047634Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d,Namespace:default,Attempt:0,} returns sandbox id \"8159bdc5877096ce724eada1d1693c89004bbb28ad6f99fb703952117629e3c6\"" Oct 16 23:41:49.149851 kubelet[1732]: I1016 23:41:49.148413 1732 server.go:177] "Pod update broadcasted" podUID="e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d" type="MODIFIED" Oct 16 23:41:49.150456 containerd[1463]: time="2026-10-16T23:41:49.150236723Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Oct 16 23:41:49.546878 containerd[1463]: time="2026-10-16T23:41:49.546814745Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Oct 16 23:41:49.547371 containerd[1463]: time="2026-10-16T23:41:49.547284839Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Oct 16 23:41:49.550411 containerd[1463]: time="2026-10-16T23:41:49.550364588Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:3a8edbda21b6357f9d8e8d441c00c44673e89af4c157e76f0f117f2429570e60\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a183384b53e7717e9c1e3faf17393ce4dfa3d0800d250cceb829a2bde27f6bc2\", size \"64640376\" in 400.095725ms" Oct 16 23:41:49.550450 containerd[1463]: time="2026-10-16T23:41:49.550420517Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:3a8edbda21b6357f9d8e8d441c00c44673e89af4c157e76f0f117f2429570e60\"" Oct 16 23:41:49.552849 containerd[1463]: time="2026-10-16T23:41:49.552830437Z" level=info msg="CreateContainer within sandbox \"8159bdc5877096ce724eada1d1693c89004bbb28ad6f99fb703952117629e3c6\" for container &ContainerMetadata{Name:test,Attempt:0,}" Oct 16 23:41:49.565114 containerd[1463]: time="2026-10-16T23:41:49.565076584Z" level=info msg="CreateContainer within sandbox \"8159bdc5877096ce724eada1d1693c89004bbb28ad6f99fb703952117629e3c6\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"95cb9a164bc18ede0cda3876a3a0805d2fd2098617d7e75b6e5cae0be1be0d10\"" Oct 16 23:41:49.565175 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1882526115.mount: Deactivated successfully. Oct 16 23:41:49.565771 containerd[1463]: time="2026-10-16T23:41:49.565750850Z" level=info msg="StartContainer for \"95cb9a164bc18ede0cda3876a3a0805d2fd2098617d7e75b6e5cae0be1be0d10\"" Oct 16 23:41:49.611563 systemd[1]: Started cri-containerd-95cb9a164bc18ede0cda3876a3a0805d2fd2098617d7e75b6e5cae0be1be0d10.scope - libcontainer container 95cb9a164bc18ede0cda3876a3a0805d2fd2098617d7e75b6e5cae0be1be0d10. Oct 16 23:41:49.632000 kubelet[1732]: E1016 23:41:49.631921 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:49.640586 containerd[1463]: time="2026-10-16T23:41:49.640551530Z" level=info msg="StartContainer for \"95cb9a164bc18ede0cda3876a3a0805d2fd2098617d7e75b6e5cae0be1be0d10\" returns successfully" Oct 16 23:41:49.642835 kubelet[1732]: I1016 23:41:49.642812 1732 server.go:177] "Pod update broadcasted" podUID="e287e9fa-3db3-4c79-9c1e-8554d9d6eb7d" type="MODIFIED" Oct 16 23:41:49.652423 kubelet[1732]: I1016 23:41:49.651806 1732 pod_startup_latency_tracker.go:144] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=11.249043371 podStartE2EDuration="11.651785145s" totalImagesPullingTime="402.741774ms" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-10-16 23:41:38 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-10-16 23:41:49.65109313 +0000 UTC m=+28.312654174" watchObservedRunningTime="2026-10-16 23:41:49.651785145 +0000 UTC m=+28.313346179" Oct 16 23:41:50.632761 kubelet[1732]: E1016 23:41:50.632657 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:51.066715 systemd-networkd[1395]: veth9fdb41df: Gained IPv6LL Oct 16 23:41:51.632910 kubelet[1732]: E1016 23:41:51.632825 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:52.633498 kubelet[1732]: E1016 23:41:52.633345 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:53.634426 kubelet[1732]: E1016 23:41:53.634322 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:54.635203 kubelet[1732]: E1016 23:41:54.635106 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:55.635708 kubelet[1732]: E1016 23:41:55.635625 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Oct 16 23:41:56.636367 kubelet[1732]: E1016 23:41:56.636238 1732 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"