Nov 24 00:32:40.922411 kernel: Linux version 6.12.58-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT_DYNAMIC Sun Nov 23 20:49:05 -00 2025 Nov 24 00:32:40.922435 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=akamai verity.usrhash=a5a093dfb613b73c778207057706f88d5254927e05ae90617f314b938bd34a14 Nov 24 00:32:40.922444 kernel: BIOS-provided physical RAM map: Nov 24 00:32:40.922451 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009f7ff] usable Nov 24 00:32:40.922457 kernel: BIOS-e820: [mem 0x000000000009f800-0x000000000009ffff] reserved Nov 24 00:32:40.922463 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Nov 24 00:32:40.922472 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdcfff] usable Nov 24 00:32:40.922479 kernel: BIOS-e820: [mem 0x000000007ffdd000-0x000000007fffffff] reserved Nov 24 00:32:40.922485 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Nov 24 00:32:40.922491 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Nov 24 00:32:40.922498 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 24 00:32:40.922504 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Nov 24 00:32:40.922510 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000017fffffff] usable Nov 24 00:32:40.922517 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 24 00:32:40.922526 kernel: NX (Execute Disable) protection: active Nov 24 00:32:40.922533 kernel: APIC: Static calls initialized Nov 24 00:32:40.922540 kernel: SMBIOS 2.8 present. Nov 24 00:32:40.922547 kernel: DMI: Linode Compute Instance/Standard PC (Q35 + ICH9, 2009), BIOS Not Specified Nov 24 00:32:40.922554 kernel: DMI: Memory slots populated: 1/1 Nov 24 00:32:40.922560 kernel: Hypervisor detected: KVM Nov 24 00:32:40.922569 kernel: last_pfn = 0x7ffdd max_arch_pfn = 0x400000000 Nov 24 00:32:40.922576 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 24 00:32:40.922582 kernel: kvm-clock: using sched offset of 7261121450 cycles Nov 24 00:32:40.922590 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 24 00:32:40.922597 kernel: tsc: Detected 1999.998 MHz processor Nov 24 00:32:40.922604 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 24 00:32:40.922611 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 24 00:32:40.922618 kernel: last_pfn = 0x180000 max_arch_pfn = 0x400000000 Nov 24 00:32:40.922625 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Nov 24 00:32:40.922634 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 24 00:32:40.922641 kernel: last_pfn = 0x7ffdd max_arch_pfn = 0x400000000 Nov 24 00:32:40.922648 kernel: Using GB pages for direct mapping Nov 24 00:32:40.922655 kernel: ACPI: Early table checksum verification disabled Nov 24 00:32:40.922662 kernel: ACPI: RSDP 0x00000000000F5160 000014 (v00 BOCHS ) Nov 24 00:32:40.922669 kernel: ACPI: RSDT 0x000000007FFE2307 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922676 kernel: ACPI: FACP 0x000000007FFE20F7 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922683 kernel: ACPI: DSDT 0x000000007FFE0040 0020B7 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922689 kernel: ACPI: FACS 0x000000007FFE0000 000040 Nov 24 00:32:40.922696 kernel: ACPI: APIC 0x000000007FFE21EB 000080 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922705 kernel: ACPI: HPET 0x000000007FFE226B 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922715 kernel: ACPI: MCFG 0x000000007FFE22A3 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922723 kernel: ACPI: WAET 0x000000007FFE22DF 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 24 00:32:40.922730 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe20f7-0x7ffe21ea] Nov 24 00:32:40.922737 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe20f6] Nov 24 00:32:40.922746 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] Nov 24 00:32:40.922754 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe21eb-0x7ffe226a] Nov 24 00:32:40.922761 kernel: ACPI: Reserving HPET table memory at [mem 0x7ffe226b-0x7ffe22a2] Nov 24 00:32:40.922768 kernel: ACPI: Reserving MCFG table memory at [mem 0x7ffe22a3-0x7ffe22de] Nov 24 00:32:40.922775 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe22df-0x7ffe2306] Nov 24 00:32:40.922782 kernel: No NUMA configuration found Nov 24 00:32:40.922790 kernel: Faking a node at [mem 0x0000000000000000-0x000000017fffffff] Nov 24 00:32:40.922797 kernel: NODE_DATA(0) allocated [mem 0x17fff6dc0-0x17fffdfff] Nov 24 00:32:40.922804 kernel: Zone ranges: Nov 24 00:32:40.922813 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 24 00:32:40.922821 kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Nov 24 00:32:40.922828 kernel: Normal [mem 0x0000000100000000-0x000000017fffffff] Nov 24 00:32:40.922835 kernel: Device empty Nov 24 00:32:40.922842 kernel: Movable zone start for each node Nov 24 00:32:40.922849 kernel: Early memory node ranges Nov 24 00:32:40.922856 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Nov 24 00:32:40.922863 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdcfff] Nov 24 00:32:40.922871 kernel: node 0: [mem 0x0000000100000000-0x000000017fffffff] Nov 24 00:32:40.922880 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff] Nov 24 00:32:40.922887 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 24 00:32:40.922894 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Nov 24 00:32:40.922902 kernel: On node 0, zone Normal: 35 pages in unavailable ranges Nov 24 00:32:40.922909 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 24 00:32:40.922916 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 24 00:32:40.922923 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 24 00:32:40.922931 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 24 00:32:40.922938 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 24 00:32:40.922947 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 24 00:32:40.922954 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 24 00:32:40.922962 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 24 00:32:40.922969 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 24 00:32:40.922976 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 24 00:32:40.922983 kernel: TSC deadline timer available Nov 24 00:32:40.923005 kernel: CPU topo: Max. logical packages: 1 Nov 24 00:32:40.923012 kernel: CPU topo: Max. logical dies: 1 Nov 24 00:32:40.923019 kernel: CPU topo: Max. dies per package: 1 Nov 24 00:32:40.923026 kernel: CPU topo: Max. threads per core: 1 Nov 24 00:32:40.923036 kernel: CPU topo: Num. cores per package: 2 Nov 24 00:32:40.923043 kernel: CPU topo: Num. threads per package: 2 Nov 24 00:32:40.923050 kernel: CPU topo: Allowing 2 present CPUs plus 0 hotplug CPUs Nov 24 00:32:40.923057 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 24 00:32:40.923064 kernel: kvm-guest: KVM setup pv remote TLB flush Nov 24 00:32:40.923071 kernel: kvm-guest: setup PV sched yield Nov 24 00:32:40.923078 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Nov 24 00:32:40.923085 kernel: Booting paravirtualized kernel on KVM Nov 24 00:32:40.923092 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 24 00:32:40.923101 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Nov 24 00:32:40.923108 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u1048576 Nov 24 00:32:40.923115 kernel: pcpu-alloc: s207832 r8192 d29736 u1048576 alloc=1*2097152 Nov 24 00:32:40.923122 kernel: pcpu-alloc: [0] 0 1 Nov 24 00:32:40.923129 kernel: kvm-guest: PV spinlocks enabled Nov 24 00:32:40.923136 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 24 00:32:40.923144 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=akamai verity.usrhash=a5a093dfb613b73c778207057706f88d5254927e05ae90617f314b938bd34a14 Nov 24 00:32:40.923151 kernel: random: crng init done Nov 24 00:32:40.923160 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 24 00:32:40.923167 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 24 00:32:40.923174 kernel: Fallback order for Node 0: 0 Nov 24 00:32:40.923182 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1048443 Nov 24 00:32:40.923188 kernel: Policy zone: Normal Nov 24 00:32:40.923195 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 24 00:32:40.923202 kernel: software IO TLB: area num 2. Nov 24 00:32:40.923209 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 24 00:32:40.923216 kernel: ftrace: allocating 40103 entries in 157 pages Nov 24 00:32:40.923226 kernel: ftrace: allocated 157 pages with 5 groups Nov 24 00:32:40.923233 kernel: Dynamic Preempt: voluntary Nov 24 00:32:40.923240 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 24 00:32:40.923247 kernel: rcu: RCU event tracing is enabled. Nov 24 00:32:40.923255 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 24 00:32:40.923262 kernel: Trampoline variant of Tasks RCU enabled. Nov 24 00:32:40.923269 kernel: Rude variant of Tasks RCU enabled. Nov 24 00:32:40.923276 kernel: Tracing variant of Tasks RCU enabled. Nov 24 00:32:40.923283 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 24 00:32:40.923292 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 24 00:32:40.923299 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 24 00:32:40.923313 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 24 00:32:40.923322 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 24 00:32:40.923330 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Nov 24 00:32:40.923337 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 24 00:32:40.923345 kernel: Console: colour VGA+ 80x25 Nov 24 00:32:40.923352 kernel: printk: legacy console [tty0] enabled Nov 24 00:32:40.923359 kernel: printk: legacy console [ttyS0] enabled Nov 24 00:32:40.923367 kernel: ACPI: Core revision 20240827 Nov 24 00:32:40.923376 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Nov 24 00:32:40.923384 kernel: APIC: Switch to symmetric I/O mode setup Nov 24 00:32:40.923391 kernel: x2apic enabled Nov 24 00:32:40.923398 kernel: APIC: Switched APIC routing to: physical x2apic Nov 24 00:32:40.923405 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Nov 24 00:32:40.923413 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Nov 24 00:32:40.923420 kernel: kvm-guest: setup PV IPIs Nov 24 00:32:40.923430 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Nov 24 00:32:40.923437 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x39a8595ce59, max_idle_ns: 881590778713 ns Nov 24 00:32:40.923445 kernel: Calibrating delay loop (skipped) preset value.. 3999.99 BogoMIPS (lpj=1999998) Nov 24 00:32:40.923452 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 24 00:32:40.923459 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Nov 24 00:32:40.923467 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Nov 24 00:32:40.923475 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 24 00:32:40.923482 kernel: Spectre V2 : Mitigation: Retpolines Nov 24 00:32:40.923489 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 24 00:32:40.923499 kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Nov 24 00:32:40.923506 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 24 00:32:40.923513 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 24 00:32:40.923521 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Nov 24 00:32:40.923529 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Nov 24 00:32:40.923536 kernel: active return thunk: srso_alias_return_thunk Nov 24 00:32:40.923543 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Nov 24 00:32:40.923551 kernel: Transient Scheduler Attacks: Forcing mitigation on in a VM Nov 24 00:32:40.923560 kernel: Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode Nov 24 00:32:40.923567 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 24 00:32:40.923575 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 24 00:32:40.923582 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 24 00:32:40.923589 kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' Nov 24 00:32:40.923597 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 24 00:32:40.923604 kernel: x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 Nov 24 00:32:40.923611 kernel: x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. Nov 24 00:32:40.923619 kernel: Freeing SMP alternatives memory: 32K Nov 24 00:32:40.923628 kernel: pid_max: default: 32768 minimum: 301 Nov 24 00:32:40.923636 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 24 00:32:40.923643 kernel: landlock: Up and running. Nov 24 00:32:40.923650 kernel: SELinux: Initializing. Nov 24 00:32:40.923657 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 24 00:32:40.923665 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 24 00:32:40.923672 kernel: smpboot: CPU0: AMD EPYC 7713 64-Core Processor (family: 0x19, model: 0x1, stepping: 0x1) Nov 24 00:32:40.923680 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Nov 24 00:32:40.923687 kernel: ... version: 0 Nov 24 00:32:40.923696 kernel: ... bit width: 48 Nov 24 00:32:40.923704 kernel: ... generic registers: 6 Nov 24 00:32:40.923711 kernel: ... value mask: 0000ffffffffffff Nov 24 00:32:40.923718 kernel: ... max period: 00007fffffffffff Nov 24 00:32:40.923726 kernel: ... fixed-purpose events: 0 Nov 24 00:32:40.923733 kernel: ... event mask: 000000000000003f Nov 24 00:32:40.923740 kernel: signal: max sigframe size: 3376 Nov 24 00:32:40.923747 kernel: rcu: Hierarchical SRCU implementation. Nov 24 00:32:40.923755 kernel: rcu: Max phase no-delay instances is 400. Nov 24 00:32:40.923764 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 24 00:32:40.923772 kernel: smp: Bringing up secondary CPUs ... Nov 24 00:32:40.923779 kernel: smpboot: x86: Booting SMP configuration: Nov 24 00:32:40.923787 kernel: .... node #0, CPUs: #1 Nov 24 00:32:40.923794 kernel: smp: Brought up 1 node, 2 CPUs Nov 24 00:32:40.924027 kernel: smpboot: Total of 2 processors activated (7999.99 BogoMIPS) Nov 24 00:32:40.924038 kernel: Memory: 3952852K/4193772K available (14336K kernel code, 2444K rwdata, 26064K rodata, 46200K init, 2560K bss, 235492K reserved, 0K cma-reserved) Nov 24 00:32:40.924046 kernel: devtmpfs: initialized Nov 24 00:32:40.924054 kernel: x86/mm: Memory block size: 128MB Nov 24 00:32:40.924065 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 24 00:32:40.924072 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 24 00:32:40.924079 kernel: pinctrl core: initialized pinctrl subsystem Nov 24 00:32:40.924087 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 24 00:32:40.924094 kernel: audit: initializing netlink subsys (disabled) Nov 24 00:32:40.924101 kernel: audit: type=2000 audit(1763944358.147:1): state=initialized audit_enabled=0 res=1 Nov 24 00:32:40.924108 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 24 00:32:40.924115 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 24 00:32:40.924121 kernel: cpuidle: using governor menu Nov 24 00:32:40.924131 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 24 00:32:40.924138 kernel: dca service started, version 1.12.1 Nov 24 00:32:40.924145 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Nov 24 00:32:40.924152 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Nov 24 00:32:40.924159 kernel: PCI: Using configuration type 1 for base access Nov 24 00:32:40.924166 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 24 00:32:40.924173 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 24 00:32:40.924180 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 24 00:32:40.924187 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 24 00:32:40.924196 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 24 00:32:40.924203 kernel: ACPI: Added _OSI(Module Device) Nov 24 00:32:40.924210 kernel: ACPI: Added _OSI(Processor Device) Nov 24 00:32:40.924217 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 24 00:32:40.924224 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 24 00:32:40.924231 kernel: ACPI: Interpreter enabled Nov 24 00:32:40.924238 kernel: ACPI: PM: (supports S0 S3 S5) Nov 24 00:32:40.924245 kernel: ACPI: Using IOAPIC for interrupt routing Nov 24 00:32:40.924252 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 24 00:32:40.924261 kernel: PCI: Using E820 reservations for host bridge windows Nov 24 00:32:40.924268 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 24 00:32:40.924275 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 24 00:32:40.924482 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 24 00:32:40.924620 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Nov 24 00:32:40.924744 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Nov 24 00:32:40.924754 kernel: PCI host bridge to bus 0000:00 Nov 24 00:32:40.924885 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 24 00:32:40.925334 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 24 00:32:40.925458 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 24 00:32:40.925571 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] Nov 24 00:32:40.925683 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Nov 24 00:32:40.926142 kernel: pci_bus 0000:00: root bus resource [mem 0x180000000-0x97fffffff window] Nov 24 00:32:40.926285 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 24 00:32:40.926432 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 24 00:32:40.926569 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Nov 24 00:32:40.926693 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Nov 24 00:32:40.926834 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Nov 24 00:32:40.926957 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Nov 24 00:32:40.928558 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 24 00:32:40.928712 kernel: pci 0000:00:02.0: [1af4:1004] type 00 class 0x010000 conventional PCI endpoint Nov 24 00:32:40.928837 kernel: pci 0000:00:02.0: BAR 0 [io 0xc000-0xc03f] Nov 24 00:32:40.928960 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Nov 24 00:32:40.929103 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Nov 24 00:32:40.929235 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 24 00:32:40.929357 kernel: pci 0000:00:03.0: BAR 0 [io 0xc040-0xc07f] Nov 24 00:32:40.929477 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Nov 24 00:32:40.929602 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Nov 24 00:32:40.929722 kernel: pci 0000:00:03.0: ROM [mem 0xfeb80000-0xfebbffff pref] Nov 24 00:32:40.929850 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 24 00:32:40.929970 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 24 00:32:40.930118 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 24 00:32:40.930241 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc0c0-0xc0df] Nov 24 00:32:40.930365 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd3000-0xfebd3fff] Nov 24 00:32:40.931073 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 24 00:32:40.931326 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Nov 24 00:32:40.931341 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 24 00:32:40.931350 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 24 00:32:40.931357 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 24 00:32:40.931365 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 24 00:32:40.931372 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 24 00:32:40.931383 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 24 00:32:40.931391 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 24 00:32:40.931398 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 24 00:32:40.931405 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 24 00:32:40.931413 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 24 00:32:40.931420 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 24 00:32:40.931427 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 24 00:32:40.931435 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 24 00:32:40.931442 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 24 00:32:40.931452 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 24 00:32:40.931459 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 24 00:32:40.931466 kernel: iommu: Default domain type: Translated Nov 24 00:32:40.931474 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 24 00:32:40.931481 kernel: PCI: Using ACPI for IRQ routing Nov 24 00:32:40.931488 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 24 00:32:40.931496 kernel: e820: reserve RAM buffer [mem 0x0009f800-0x0009ffff] Nov 24 00:32:40.931503 kernel: e820: reserve RAM buffer [mem 0x7ffdd000-0x7fffffff] Nov 24 00:32:40.931633 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 24 00:32:40.931760 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 24 00:32:40.931880 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 24 00:32:40.931890 kernel: vgaarb: loaded Nov 24 00:32:40.931898 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Nov 24 00:32:40.931906 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Nov 24 00:32:40.931913 kernel: clocksource: Switched to clocksource kvm-clock Nov 24 00:32:40.931920 kernel: VFS: Disk quotas dquot_6.6.0 Nov 24 00:32:40.931928 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 24 00:32:40.931935 kernel: pnp: PnP ACPI init Nov 24 00:32:40.933132 kernel: system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved Nov 24 00:32:40.933154 kernel: pnp: PnP ACPI: found 5 devices Nov 24 00:32:40.933165 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 24 00:32:40.933173 kernel: NET: Registered PF_INET protocol family Nov 24 00:32:40.933184 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 24 00:32:40.933196 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 24 00:32:40.933207 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 24 00:32:40.933214 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 24 00:32:40.933226 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 24 00:32:40.933234 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 24 00:32:40.933241 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 24 00:32:40.933249 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 24 00:32:40.933257 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 24 00:32:40.933264 kernel: NET: Registered PF_XDP protocol family Nov 24 00:32:40.933396 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 24 00:32:40.933513 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 24 00:32:40.933631 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 24 00:32:40.933743 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] Nov 24 00:32:40.933852 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Nov 24 00:32:40.933980 kernel: pci_bus 0000:00: resource 9 [mem 0x180000000-0x97fffffff window] Nov 24 00:32:40.935034 kernel: PCI: CLS 0 bytes, default 64 Nov 24 00:32:40.935043 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Nov 24 00:32:40.935051 kernel: software IO TLB: mapped [mem 0x000000007bfdd000-0x000000007ffdd000] (64MB) Nov 24 00:32:40.935058 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x39a8595ce59, max_idle_ns: 881590778713 ns Nov 24 00:32:40.935066 kernel: Initialise system trusted keyrings Nov 24 00:32:40.935077 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 24 00:32:40.935084 kernel: Key type asymmetric registered Nov 24 00:32:40.935092 kernel: Asymmetric key parser 'x509' registered Nov 24 00:32:40.935099 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 24 00:32:40.935106 kernel: io scheduler mq-deadline registered Nov 24 00:32:40.935114 kernel: io scheduler kyber registered Nov 24 00:32:40.935121 kernel: io scheduler bfq registered Nov 24 00:32:40.935128 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 24 00:32:40.935136 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 24 00:32:40.935146 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 24 00:32:40.935154 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 24 00:32:40.935161 kernel: 00:02: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 24 00:32:40.935169 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 24 00:32:40.935176 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 24 00:32:40.935184 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 24 00:32:40.935191 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 24 00:32:40.935340 kernel: rtc_cmos 00:03: RTC can wake from S4 Nov 24 00:32:40.935630 kernel: rtc_cmos 00:03: registered as rtc0 Nov 24 00:32:40.935749 kernel: rtc_cmos 00:03: setting system clock to 2025-11-24T00:32:40 UTC (1763944360) Nov 24 00:32:40.935863 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Nov 24 00:32:40.935873 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Nov 24 00:32:40.935881 kernel: NET: Registered PF_INET6 protocol family Nov 24 00:32:40.935889 kernel: Segment Routing with IPv6 Nov 24 00:32:40.935896 kernel: In-situ OAM (IOAM) with IPv6 Nov 24 00:32:40.935904 kernel: NET: Registered PF_PACKET protocol family Nov 24 00:32:40.935911 kernel: Key type dns_resolver registered Nov 24 00:32:40.935922 kernel: IPI shorthand broadcast: enabled Nov 24 00:32:40.935929 kernel: sched_clock: Marking stable (3053003985, 352286454)->(3497559777, -92269338) Nov 24 00:32:40.935937 kernel: registered taskstats version 1 Nov 24 00:32:40.935944 kernel: Loading compiled-in X.509 certificates Nov 24 00:32:40.935951 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.58-flatcar: 960cbe7f2b1ea74b5c881d6d42eea4d1ac19a607' Nov 24 00:32:40.935959 kernel: Demotion targets for Node 0: null Nov 24 00:32:40.935966 kernel: Key type .fscrypt registered Nov 24 00:32:40.935973 kernel: Key type fscrypt-provisioning registered Nov 24 00:32:40.935981 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 24 00:32:40.936010 kernel: ima: Allocated hash algorithm: sha1 Nov 24 00:32:40.936017 kernel: ima: No architecture policies found Nov 24 00:32:40.936025 kernel: clk: Disabling unused clocks Nov 24 00:32:40.936032 kernel: Warning: unable to open an initial console. Nov 24 00:32:40.936040 kernel: Freeing unused kernel image (initmem) memory: 46200K Nov 24 00:32:40.936047 kernel: Write protecting the kernel read-only data: 40960k Nov 24 00:32:40.936055 kernel: Freeing unused kernel image (rodata/data gap) memory: 560K Nov 24 00:32:40.936062 kernel: Run /init as init process Nov 24 00:32:40.936072 kernel: with arguments: Nov 24 00:32:40.936079 kernel: /init Nov 24 00:32:40.936087 kernel: with environment: Nov 24 00:32:40.936109 kernel: HOME=/ Nov 24 00:32:40.936119 kernel: TERM=linux Nov 24 00:32:40.936128 systemd[1]: Successfully made /usr/ read-only. Nov 24 00:32:40.936138 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 24 00:32:40.936147 systemd[1]: Detected virtualization kvm. Nov 24 00:32:40.936157 systemd[1]: Detected architecture x86-64. Nov 24 00:32:40.936165 systemd[1]: Running in initrd. Nov 24 00:32:40.936173 systemd[1]: No hostname configured, using default hostname. Nov 24 00:32:40.936181 systemd[1]: Hostname set to . Nov 24 00:32:40.936190 systemd[1]: Initializing machine ID from random generator. Nov 24 00:32:40.936198 systemd[1]: Queued start job for default target initrd.target. Nov 24 00:32:40.936223 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:32:40.936233 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:32:40.936244 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 24 00:32:40.936252 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 24 00:32:40.936261 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 24 00:32:40.936270 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 24 00:32:40.936279 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 24 00:32:40.936289 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 24 00:32:40.936298 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:32:40.936308 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:32:40.936316 systemd[1]: Reached target paths.target - Path Units. Nov 24 00:32:40.936324 systemd[1]: Reached target slices.target - Slice Units. Nov 24 00:32:40.936333 systemd[1]: Reached target swap.target - Swaps. Nov 24 00:32:40.936341 systemd[1]: Reached target timers.target - Timer Units. Nov 24 00:32:40.936349 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 24 00:32:40.936357 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 24 00:32:40.936366 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 24 00:32:40.936376 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 24 00:32:40.936384 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:32:40.936392 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 24 00:32:40.936402 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:32:40.936411 systemd[1]: Reached target sockets.target - Socket Units. Nov 24 00:32:40.936419 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 24 00:32:40.936429 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 24 00:32:40.936437 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 24 00:32:40.936445 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 24 00:32:40.936454 systemd[1]: Starting systemd-fsck-usr.service... Nov 24 00:32:40.936462 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 24 00:32:40.936470 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 24 00:32:40.936478 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:32:40.936486 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 24 00:32:40.936521 systemd-journald[187]: Collecting audit messages is disabled. Nov 24 00:32:40.936542 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:32:40.936551 systemd[1]: Finished systemd-fsck-usr.service. Nov 24 00:32:40.936560 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 24 00:32:40.936568 systemd-journald[187]: Journal started Nov 24 00:32:40.936586 systemd-journald[187]: Runtime Journal (/run/log/journal/0f2f43ba4d5d48d5bf74f789da496daf) is 8M, max 78.2M, 70.2M free. Nov 24 00:32:40.932067 systemd-modules-load[188]: Inserted module 'overlay' Nov 24 00:32:40.946132 systemd[1]: Started systemd-journald.service - Journal Service. Nov 24 00:32:40.951089 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 24 00:32:40.980113 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:32:40.997090 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 24 00:32:40.997116 kernel: Bridge firewalling registered Nov 24 00:32:40.989749 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 24 00:32:40.991432 systemd-modules-load[188]: Inserted module 'br_netfilter' Nov 24 00:32:40.998419 systemd-tmpfiles[201]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 24 00:32:41.086106 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 24 00:32:41.087270 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:32:41.090024 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:32:41.095539 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 24 00:32:41.098941 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 24 00:32:41.101069 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:32:41.113880 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:32:41.117585 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 24 00:32:41.119885 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 24 00:32:41.124087 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 24 00:32:41.148264 dracut-cmdline[226]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=akamai verity.usrhash=a5a093dfb613b73c778207057706f88d5254927e05ae90617f314b938bd34a14 Nov 24 00:32:41.169480 systemd-resolved[225]: Positive Trust Anchors: Nov 24 00:32:41.169494 systemd-resolved[225]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 24 00:32:41.169520 systemd-resolved[225]: 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 Nov 24 00:32:41.174400 systemd-resolved[225]: Defaulting to hostname 'linux'. Nov 24 00:32:41.178233 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 24 00:32:41.179505 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:32:41.249025 kernel: SCSI subsystem initialized Nov 24 00:32:41.259047 kernel: Loading iSCSI transport class v2.0-870. Nov 24 00:32:41.270021 kernel: iscsi: registered transport (tcp) Nov 24 00:32:41.292083 kernel: iscsi: registered transport (qla4xxx) Nov 24 00:32:41.292122 kernel: QLogic iSCSI HBA Driver Nov 24 00:32:41.313680 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 24 00:32:41.331309 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:32:41.334390 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 24 00:32:41.379612 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 24 00:32:41.381832 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 24 00:32:41.442011 kernel: raid6: avx2x4 gen() 26573 MB/s Nov 24 00:32:41.460013 kernel: raid6: avx2x2 gen() 26167 MB/s Nov 24 00:32:41.478063 kernel: raid6: avx2x1 gen() 18391 MB/s Nov 24 00:32:41.478085 kernel: raid6: using algorithm avx2x4 gen() 26573 MB/s Nov 24 00:32:41.500027 kernel: raid6: .... xor() 4312 MB/s, rmw enabled Nov 24 00:32:41.500065 kernel: raid6: using avx2x2 recovery algorithm Nov 24 00:32:41.521008 kernel: xor: automatically using best checksumming function avx Nov 24 00:32:41.664023 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 24 00:32:41.671710 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 24 00:32:41.674157 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:32:41.704342 systemd-udevd[435]: Using default interface naming scheme 'v255'. Nov 24 00:32:41.711041 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:32:41.716180 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 24 00:32:41.740142 dracut-pre-trigger[442]: rd.md=0: removing MD RAID activation Nov 24 00:32:41.775069 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 24 00:32:41.777212 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 24 00:32:41.856770 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:32:41.860381 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 24 00:32:41.924033 kernel: cryptd: max_cpu_qlen set to 1000 Nov 24 00:32:41.936002 kernel: virtio_scsi virtio0: 2/0/0 default/read/poll queues Nov 24 00:32:41.952007 kernel: AES CTR mode by8 optimization enabled Nov 24 00:32:41.966669 kernel: libata version 3.00 loaded. Nov 24 00:32:41.977242 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Nov 24 00:32:42.139017 kernel: scsi host0: Virtio SCSI HBA Nov 24 00:32:42.139095 kernel: ahci 0000:00:1f.2: version 3.0 Nov 24 00:32:42.144157 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 24 00:32:42.184410 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 24 00:32:42.184623 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 24 00:32:42.184776 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 24 00:32:42.193089 kernel: scsi 0:0:0:0: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Nov 24 00:32:42.196051 kernel: scsi host1: ahci Nov 24 00:32:42.201666 kernel: scsi host2: ahci Nov 24 00:32:42.201962 kernel: scsi host3: ahci Nov 24 00:32:42.200453 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:32:42.232619 kernel: scsi host4: ahci Nov 24 00:32:42.232819 kernel: scsi host5: ahci Nov 24 00:32:42.232979 kernel: scsi host6: ahci Nov 24 00:32:42.233162 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3100 irq 46 lpm-pol 1 Nov 24 00:32:42.233176 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3180 irq 46 lpm-pol 1 Nov 24 00:32:42.233187 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3200 irq 46 lpm-pol 1 Nov 24 00:32:42.233198 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3280 irq 46 lpm-pol 1 Nov 24 00:32:42.233209 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3300 irq 46 lpm-pol 1 Nov 24 00:32:42.233220 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd3000 port 0xfebd3380 irq 46 lpm-pol 1 Nov 24 00:32:42.233232 kernel: sd 0:0:0:0: Power-on or device reset occurred Nov 24 00:32:42.233595 kernel: sd 0:0:0:0: [sda] 167739392 512-byte logical blocks: (85.9 GB/80.0 GiB) Nov 24 00:32:42.201376 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:32:42.244139 kernel: sd 0:0:0:0: [sda] Write Protect is off Nov 24 00:32:42.244390 kernel: sd 0:0:0:0: [sda] Mode Sense: 63 00 00 08 Nov 24 00:32:42.244561 kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Nov 24 00:32:42.208435 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:32:42.243341 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:32:42.247081 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Nov 24 00:32:42.254041 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 24 00:32:42.254071 kernel: GPT:9289727 != 167739391 Nov 24 00:32:42.257452 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 24 00:32:42.257470 kernel: GPT:9289727 != 167739391 Nov 24 00:32:42.258913 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 24 00:32:42.283293 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:32:42.288034 kernel: sd 0:0:0:0: [sda] Attached SCSI disk Nov 24 00:32:42.393389 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:32:42.533023 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.533113 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.533126 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.535029 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.538013 kernel: ata3: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.543261 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 24 00:32:42.614879 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - QEMU_HARDDISK ROOT. Nov 24 00:32:42.625150 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Nov 24 00:32:42.626631 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 24 00:32:42.638387 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - QEMU_HARDDISK EFI-SYSTEM. Nov 24 00:32:42.646408 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - QEMU_HARDDISK USR-A. Nov 24 00:32:42.647247 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - QEMU_HARDDISK USR-A. Nov 24 00:32:42.650302 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 24 00:32:42.651250 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:32:42.653253 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 24 00:32:42.656259 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 24 00:32:42.661099 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 24 00:32:42.673544 disk-uuid[618]: Primary Header is updated. Nov 24 00:32:42.673544 disk-uuid[618]: Secondary Entries is updated. Nov 24 00:32:42.673544 disk-uuid[618]: Secondary Header is updated. Nov 24 00:32:42.679142 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 24 00:32:42.683469 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:32:42.695036 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:32:43.697026 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Nov 24 00:32:43.697552 disk-uuid[623]: The operation has completed successfully. Nov 24 00:32:43.758622 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 24 00:32:43.758738 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 24 00:32:43.791800 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 24 00:32:43.811589 sh[640]: Success Nov 24 00:32:43.833062 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 24 00:32:43.833101 kernel: device-mapper: uevent: version 1.0.3 Nov 24 00:32:43.835605 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 24 00:32:43.849008 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Nov 24 00:32:43.892913 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 24 00:32:43.896274 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 24 00:32:43.906490 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 24 00:32:43.921009 kernel: BTRFS: device fsid 3af95a3e-5df6-49e0-91e3-ddf2109f68c7 devid 1 transid 35 /dev/mapper/usr (254:0) scanned by mount (652) Nov 24 00:32:43.921039 kernel: BTRFS info (device dm-0): first mount of filesystem 3af95a3e-5df6-49e0-91e3-ddf2109f68c7 Nov 24 00:32:43.925645 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:32:43.939564 kernel: BTRFS info (device dm-0): enabling ssd optimizations Nov 24 00:32:43.939591 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 24 00:32:43.939609 kernel: BTRFS info (device dm-0): enabling free space tree Nov 24 00:32:43.944358 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 24 00:32:43.945776 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 24 00:32:43.947077 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 24 00:32:43.947779 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 24 00:32:43.954098 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 24 00:32:43.988015 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (685) Nov 24 00:32:43.992176 kernel: BTRFS info (device sda6): first mount of filesystem 1e21b02a-5e52-4507-8281-b06fd4c187c7 Nov 24 00:32:43.996008 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:32:44.002414 kernel: BTRFS info (device sda6): enabling ssd optimizations Nov 24 00:32:44.002440 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:32:44.005314 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:32:44.016033 kernel: BTRFS info (device sda6): last unmount of filesystem 1e21b02a-5e52-4507-8281-b06fd4c187c7 Nov 24 00:32:44.016869 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 24 00:32:44.020102 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 24 00:32:44.138134 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 24 00:32:44.143155 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 24 00:32:44.143321 ignition[752]: Ignition 2.22.0 Nov 24 00:32:44.143328 ignition[752]: Stage: fetch-offline Nov 24 00:32:44.143535 ignition[752]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:44.143545 ignition[752]: no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:44.149097 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 24 00:32:44.143624 ignition[752]: parsed url from cmdline: "" Nov 24 00:32:44.143628 ignition[752]: no config URL provided Nov 24 00:32:44.143633 ignition[752]: reading system config file "/usr/lib/ignition/user.ign" Nov 24 00:32:44.143642 ignition[752]: no config at "/usr/lib/ignition/user.ign" Nov 24 00:32:44.143652 ignition[752]: failed to fetch config: resource requires networking Nov 24 00:32:44.143859 ignition[752]: Ignition finished successfully Nov 24 00:32:44.185662 systemd-networkd[827]: lo: Link UP Nov 24 00:32:44.185675 systemd-networkd[827]: lo: Gained carrier Nov 24 00:32:44.187467 systemd-networkd[827]: Enumeration completed Nov 24 00:32:44.187845 systemd-networkd[827]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:32:44.187849 systemd-networkd[827]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 24 00:32:44.188056 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 24 00:32:44.190586 systemd-networkd[827]: eth0: Link UP Nov 24 00:32:44.190753 systemd-networkd[827]: eth0: Gained carrier Nov 24 00:32:44.190763 systemd-networkd[827]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:32:44.191549 systemd[1]: Reached target network.target - Network. Nov 24 00:32:44.196055 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 24 00:32:44.224134 ignition[831]: Ignition 2.22.0 Nov 24 00:32:44.224147 ignition[831]: Stage: fetch Nov 24 00:32:44.224251 ignition[831]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:44.224262 ignition[831]: no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:44.224337 ignition[831]: parsed url from cmdline: "" Nov 24 00:32:44.224341 ignition[831]: no config URL provided Nov 24 00:32:44.224346 ignition[831]: reading system config file "/usr/lib/ignition/user.ign" Nov 24 00:32:44.224355 ignition[831]: no config at "/usr/lib/ignition/user.ign" Nov 24 00:32:44.224378 ignition[831]: PUT http://169.254.169.254/v1/token: attempt #1 Nov 24 00:32:44.224513 ignition[831]: PUT error: Put "http://169.254.169.254/v1/token": dial tcp 169.254.169.254:80: connect: network is unreachable Nov 24 00:32:44.424947 ignition[831]: PUT http://169.254.169.254/v1/token: attempt #2 Nov 24 00:32:44.425137 ignition[831]: PUT error: Put "http://169.254.169.254/v1/token": dial tcp 169.254.169.254:80: connect: network is unreachable Nov 24 00:32:44.826054 ignition[831]: PUT http://169.254.169.254/v1/token: attempt #3 Nov 24 00:32:44.826468 ignition[831]: PUT error: Put "http://169.254.169.254/v1/token": dial tcp 169.254.169.254:80: connect: network is unreachable Nov 24 00:32:44.950066 systemd-networkd[827]: eth0: DHCPv4 address 172.237.134.230/24, gateway 172.237.134.1 acquired from 23.213.15.216 Nov 24 00:32:45.360182 systemd-networkd[827]: eth0: Gained IPv6LL Nov 24 00:32:45.627528 ignition[831]: PUT http://169.254.169.254/v1/token: attempt #4 Nov 24 00:32:45.723436 ignition[831]: PUT result: OK Nov 24 00:32:45.723491 ignition[831]: GET http://169.254.169.254/v1/user-data: attempt #1 Nov 24 00:32:45.829469 ignition[831]: GET result: OK Nov 24 00:32:45.829589 ignition[831]: parsing config with SHA512: 12739b9a4c54a46f2c9d6e2101e41a11ef3bd6049579fed3b3fe19a61975aa41fdf6eb0c34eeff3fed7be968b6964156e0e28c7d7ead2cd81aa1597860bea7e2 Nov 24 00:32:45.834149 unknown[831]: fetched base config from "system" Nov 24 00:32:45.834161 unknown[831]: fetched base config from "system" Nov 24 00:32:45.840135 ignition[831]: fetch: fetch complete Nov 24 00:32:45.834167 unknown[831]: fetched user config from "akamai" Nov 24 00:32:45.840141 ignition[831]: fetch: fetch passed Nov 24 00:32:45.849070 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 24 00:32:45.840185 ignition[831]: Ignition finished successfully Nov 24 00:32:45.858299 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 24 00:32:45.889815 ignition[839]: Ignition 2.22.0 Nov 24 00:32:45.889830 ignition[839]: Stage: kargs Nov 24 00:32:45.889946 ignition[839]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:45.889956 ignition[839]: no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:45.890652 ignition[839]: kargs: kargs passed Nov 24 00:32:45.893382 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 24 00:32:45.890692 ignition[839]: Ignition finished successfully Nov 24 00:32:45.897103 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 24 00:32:45.930160 ignition[845]: Ignition 2.22.0 Nov 24 00:32:45.930174 ignition[845]: Stage: disks Nov 24 00:32:45.930303 ignition[845]: no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:45.930314 ignition[845]: no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:45.932581 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 24 00:32:45.930855 ignition[845]: disks: disks passed Nov 24 00:32:45.934637 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 24 00:32:45.930895 ignition[845]: Ignition finished successfully Nov 24 00:32:45.935720 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 24 00:32:45.937176 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 24 00:32:45.939034 systemd[1]: Reached target sysinit.target - System Initialization. Nov 24 00:32:45.940607 systemd[1]: Reached target basic.target - Basic System. Nov 24 00:32:45.943171 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 24 00:32:45.975088 systemd-fsck[853]: ROOT: clean, 15/553520 files, 52789/553472 blocks Nov 24 00:32:45.979822 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 24 00:32:45.982223 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 24 00:32:46.099017 kernel: EXT4-fs (sda9): mounted filesystem f89e2a65-2a4a-426b-9659-02844cc29a2a r/w with ordered data mode. Quota mode: none. Nov 24 00:32:46.099765 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 24 00:32:46.101184 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 24 00:32:46.104240 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 24 00:32:46.106904 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 24 00:32:46.110185 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 24 00:32:46.110260 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 24 00:32:46.110295 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 24 00:32:46.127797 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 24 00:32:46.145442 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (861) Nov 24 00:32:46.145477 kernel: BTRFS info (device sda6): first mount of filesystem 1e21b02a-5e52-4507-8281-b06fd4c187c7 Nov 24 00:32:46.145494 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:32:46.145510 kernel: BTRFS info (device sda6): enabling ssd optimizations Nov 24 00:32:46.145532 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:32:46.145547 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:32:46.147585 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 24 00:32:46.149785 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 24 00:32:46.213034 initrd-setup-root[885]: cut: /sysroot/etc/passwd: No such file or directory Nov 24 00:32:46.219547 initrd-setup-root[892]: cut: /sysroot/etc/group: No such file or directory Nov 24 00:32:46.225005 initrd-setup-root[899]: cut: /sysroot/etc/shadow: No such file or directory Nov 24 00:32:46.230308 initrd-setup-root[906]: cut: /sysroot/etc/gshadow: No such file or directory Nov 24 00:32:46.330344 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 24 00:32:46.333305 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 24 00:32:46.335604 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 24 00:32:46.354527 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 24 00:32:46.360054 kernel: BTRFS info (device sda6): last unmount of filesystem 1e21b02a-5e52-4507-8281-b06fd4c187c7 Nov 24 00:32:46.376167 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 24 00:32:46.397739 ignition[975]: INFO : Ignition 2.22.0 Nov 24 00:32:46.397739 ignition[975]: INFO : Stage: mount Nov 24 00:32:46.399422 ignition[975]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:46.399422 ignition[975]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:46.399422 ignition[975]: INFO : mount: mount passed Nov 24 00:32:46.399422 ignition[975]: INFO : Ignition finished successfully Nov 24 00:32:46.401033 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 24 00:32:46.404084 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 24 00:32:47.101272 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 24 00:32:47.131015 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 (8:6) scanned by mount (985) Nov 24 00:32:47.135162 kernel: BTRFS info (device sda6): first mount of filesystem 1e21b02a-5e52-4507-8281-b06fd4c187c7 Nov 24 00:32:47.135189 kernel: BTRFS info (device sda6): using crc32c (crc32c-intel) checksum algorithm Nov 24 00:32:47.142377 kernel: BTRFS info (device sda6): enabling ssd optimizations Nov 24 00:32:47.142402 kernel: BTRFS info (device sda6): turning on async discard Nov 24 00:32:47.146576 kernel: BTRFS info (device sda6): enabling free space tree Nov 24 00:32:47.148526 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 24 00:32:47.173558 ignition[1001]: INFO : Ignition 2.22.0 Nov 24 00:32:47.173558 ignition[1001]: INFO : Stage: files Nov 24 00:32:47.175539 ignition[1001]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:47.175539 ignition[1001]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:47.175539 ignition[1001]: DEBUG : files: compiled without relabeling support, skipping Nov 24 00:32:47.175539 ignition[1001]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 24 00:32:47.179768 ignition[1001]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 24 00:32:47.179768 ignition[1001]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 24 00:32:47.179768 ignition[1001]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 24 00:32:47.182914 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 24 00:32:47.179799 unknown[1001]: wrote ssh authorized keys file for user: core Nov 24 00:32:47.190326 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 24 00:32:47.190326 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 24 00:32:47.190326 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.1-x86-64.raw: attempt #1 Nov 24 00:32:47.646448 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Nov 24 00:32:48.033399 ignition[1001]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-x86-64.raw" Nov 24 00:32:48.033399 ignition[1001]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Nov 24 00:32:48.036202 ignition[1001]: INFO : files: op(7): op(8): [started] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Nov 24 00:32:48.036202 ignition[1001]: INFO : files: op(7): op(8): [finished] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Nov 24 00:32:48.036202 ignition[1001]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Nov 24 00:32:48.061610 ignition[1001]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 24 00:32:48.061610 ignition[1001]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 24 00:32:48.061610 ignition[1001]: INFO : files: files passed Nov 24 00:32:48.061610 ignition[1001]: INFO : Ignition finished successfully Nov 24 00:32:48.043161 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 24 00:32:48.062109 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 24 00:32:48.065123 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 24 00:32:48.074372 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 24 00:32:48.074486 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 24 00:32:48.082007 initrd-setup-root-after-ignition[1032]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:32:48.082007 initrd-setup-root-after-ignition[1032]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:32:48.085165 initrd-setup-root-after-ignition[1036]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 24 00:32:48.086386 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 24 00:32:48.087481 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 24 00:32:48.089552 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 24 00:32:48.137218 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 24 00:32:48.137374 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 24 00:32:48.139104 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 24 00:32:48.140539 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 24 00:32:48.142145 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 24 00:32:48.142843 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 24 00:32:48.172949 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 24 00:32:48.175106 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 24 00:32:48.193255 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:32:48.194942 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:32:48.195770 systemd[1]: Stopped target timers.target - Timer Units. Nov 24 00:32:48.196618 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 24 00:32:48.196719 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 24 00:32:48.198635 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 24 00:32:48.199628 systemd[1]: Stopped target basic.target - Basic System. Nov 24 00:32:48.201105 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 24 00:32:48.202886 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 24 00:32:48.204576 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 24 00:32:48.205980 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 24 00:32:48.207682 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 24 00:32:48.209221 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 24 00:32:48.210893 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 24 00:32:48.212513 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 24 00:32:48.214022 systemd[1]: Stopped target swap.target - Swaps. Nov 24 00:32:48.215615 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 24 00:32:48.215757 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 24 00:32:48.217626 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:32:48.218683 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:32:48.220113 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 24 00:32:48.220339 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:32:48.221523 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 24 00:32:48.221619 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 24 00:32:48.223688 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 24 00:32:48.223836 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 24 00:32:48.224840 systemd[1]: ignition-files.service: Deactivated successfully. Nov 24 00:32:48.224972 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 24 00:32:48.228066 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 24 00:32:48.231143 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 24 00:32:48.232718 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 24 00:32:48.232871 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:32:48.234278 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 24 00:32:48.234417 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 24 00:32:48.240149 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 24 00:32:48.240247 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 24 00:32:48.261015 ignition[1056]: INFO : Ignition 2.22.0 Nov 24 00:32:48.261015 ignition[1056]: INFO : Stage: umount Nov 24 00:32:48.261015 ignition[1056]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 24 00:32:48.261015 ignition[1056]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/akamai" Nov 24 00:32:48.267747 ignition[1056]: INFO : umount: umount passed Nov 24 00:32:48.267747 ignition[1056]: INFO : Ignition finished successfully Nov 24 00:32:48.263043 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 24 00:32:48.263159 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 24 00:32:48.266822 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 24 00:32:48.267661 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 24 00:32:48.267753 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 24 00:32:48.272502 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 24 00:32:48.272554 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 24 00:32:48.273866 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 24 00:32:48.273917 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 24 00:32:48.275282 systemd[1]: Stopped target network.target - Network. Nov 24 00:32:48.276660 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 24 00:32:48.276713 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 24 00:32:48.278191 systemd[1]: Stopped target paths.target - Path Units. Nov 24 00:32:48.279526 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 24 00:32:48.283142 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:32:48.284314 systemd[1]: Stopped target slices.target - Slice Units. Nov 24 00:32:48.285801 systemd[1]: Stopped target sockets.target - Socket Units. Nov 24 00:32:48.287325 systemd[1]: iscsid.socket: Deactivated successfully. Nov 24 00:32:48.287365 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 24 00:32:48.311122 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 24 00:32:48.311174 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 24 00:32:48.312487 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 24 00:32:48.312540 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 24 00:32:48.313902 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 24 00:32:48.313954 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 24 00:32:48.315482 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 24 00:32:48.316961 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 24 00:32:48.318727 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 24 00:32:48.318829 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 24 00:32:48.320462 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 24 00:32:48.320553 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 24 00:32:48.323404 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 24 00:32:48.323539 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 24 00:32:48.329295 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Nov 24 00:32:48.329610 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 24 00:32:48.329728 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 24 00:32:48.331893 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Nov 24 00:32:48.333207 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 24 00:32:48.334923 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 24 00:32:48.334965 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:32:48.337210 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 24 00:32:48.338907 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 24 00:32:48.338959 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 24 00:32:48.342775 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 24 00:32:48.342835 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:32:48.344633 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 24 00:32:48.344688 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 24 00:32:48.345792 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 24 00:32:48.345844 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:32:48.347760 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:32:48.351622 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 24 00:32:48.351695 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Nov 24 00:32:48.364174 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 24 00:32:48.364300 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 24 00:32:48.367166 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 24 00:32:48.367358 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:32:48.369102 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 24 00:32:48.369169 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 24 00:32:48.370472 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 24 00:32:48.370511 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:32:48.372074 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 24 00:32:48.372126 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 24 00:32:48.374277 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 24 00:32:48.374324 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 24 00:32:48.375853 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 24 00:32:48.375905 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 24 00:32:48.379095 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 24 00:32:48.381154 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 24 00:32:48.381212 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:32:48.382759 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 24 00:32:48.382810 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:32:48.385499 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 24 00:32:48.385547 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:32:48.386965 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 24 00:32:48.387030 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:32:48.390772 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 24 00:32:48.390829 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:32:48.394424 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Nov 24 00:32:48.394504 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev\x2dearly.service.mount: Deactivated successfully. Nov 24 00:32:48.394556 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Nov 24 00:32:48.394603 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Nov 24 00:32:48.398137 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 24 00:32:48.398238 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 24 00:32:48.400397 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 24 00:32:48.402239 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 24 00:32:48.419967 systemd[1]: Switching root. Nov 24 00:32:48.461540 systemd-journald[187]: Journal stopped Nov 24 00:32:49.666113 systemd-journald[187]: Received SIGTERM from PID 1 (systemd). Nov 24 00:32:49.666144 kernel: SELinux: policy capability network_peer_controls=1 Nov 24 00:32:49.666156 kernel: SELinux: policy capability open_perms=1 Nov 24 00:32:49.666166 kernel: SELinux: policy capability extended_socket_class=1 Nov 24 00:32:49.666175 kernel: SELinux: policy capability always_check_network=0 Nov 24 00:32:49.666187 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 24 00:32:49.666197 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 24 00:32:49.666207 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 24 00:32:49.666217 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 24 00:32:49.666226 kernel: SELinux: policy capability userspace_initial_context=0 Nov 24 00:32:49.666235 kernel: audit: type=1403 audit(1763944368.612:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 24 00:32:49.666276 systemd[1]: Successfully loaded SELinux policy in 74.678ms. Nov 24 00:32:49.666290 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 8.933ms. Nov 24 00:32:49.666302 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 24 00:32:49.666314 systemd[1]: Detected virtualization kvm. Nov 24 00:32:49.666324 systemd[1]: Detected architecture x86-64. Nov 24 00:32:49.666337 systemd[1]: Detected first boot. Nov 24 00:32:49.666348 systemd[1]: Initializing machine ID from random generator. Nov 24 00:32:49.666359 zram_generator::config[1100]: No configuration found. Nov 24 00:32:49.666370 kernel: Guest personality initialized and is inactive Nov 24 00:32:49.666380 kernel: VMCI host device registered (name=vmci, major=10, minor=258) Nov 24 00:32:49.666390 kernel: Initialized host personality Nov 24 00:32:49.666399 kernel: NET: Registered PF_VSOCK protocol family Nov 24 00:32:49.666410 systemd[1]: Populated /etc with preset unit settings. Nov 24 00:32:49.666423 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Nov 24 00:32:49.666434 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 24 00:32:49.666446 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 24 00:32:49.666456 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 24 00:32:49.666467 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 24 00:32:49.666478 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 24 00:32:49.666489 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 24 00:32:49.666501 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 24 00:32:49.666512 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 24 00:32:49.666523 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 24 00:32:49.666534 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 24 00:32:49.666544 systemd[1]: Created slice user.slice - User and Session Slice. Nov 24 00:32:49.666555 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 24 00:32:49.666565 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 24 00:32:49.666576 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 24 00:32:49.666589 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 24 00:32:49.666604 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 24 00:32:49.666615 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 24 00:32:49.666626 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 24 00:32:49.666637 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 24 00:32:49.666648 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 24 00:32:49.666659 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 24 00:32:49.666672 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 24 00:32:49.666684 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 24 00:32:49.666695 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 24 00:32:49.666706 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 24 00:32:49.666717 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 24 00:32:49.666728 systemd[1]: Reached target slices.target - Slice Units. Nov 24 00:32:49.666739 systemd[1]: Reached target swap.target - Swaps. Nov 24 00:32:49.666749 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 24 00:32:49.666760 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 24 00:32:49.666773 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 24 00:32:49.666785 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 24 00:32:49.666796 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 24 00:32:49.666807 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 24 00:32:49.666820 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 24 00:32:49.666831 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 24 00:32:49.666842 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 24 00:32:49.666853 systemd[1]: Mounting media.mount - External Media Directory... Nov 24 00:32:49.666864 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:49.666875 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 24 00:32:49.666886 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 24 00:32:49.666897 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 24 00:32:49.666911 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). Nov 24 00:32:49.666923 systemd[1]: Reached target machines.target - Containers. Nov 24 00:32:49.666934 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 24 00:32:49.666945 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:32:49.666956 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 24 00:32:49.666967 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 24 00:32:49.666978 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 24 00:32:49.667003 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 24 00:32:49.667015 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 24 00:32:49.667029 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 24 00:32:49.667040 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 24 00:32:49.667051 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 24 00:32:49.667062 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 24 00:32:49.667073 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 24 00:32:49.667084 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 24 00:32:49.667095 systemd[1]: Stopped systemd-fsck-usr.service. Nov 24 00:32:49.667106 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 24 00:32:49.667119 kernel: loop: module loaded Nov 24 00:32:49.667130 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 24 00:32:49.667141 kernel: fuse: init (API version 7.41) Nov 24 00:32:49.667151 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 24 00:32:49.667162 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 24 00:32:49.667174 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 24 00:32:49.667185 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 24 00:32:49.667195 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 24 00:32:49.667208 systemd[1]: verity-setup.service: Deactivated successfully. Nov 24 00:32:49.667219 kernel: ACPI: bus type drm_connector registered Nov 24 00:32:49.667229 systemd[1]: Stopped verity-setup.service. Nov 24 00:32:49.667240 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:49.667274 systemd-journald[1188]: Collecting audit messages is disabled. Nov 24 00:32:49.667299 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 24 00:32:49.667310 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 24 00:32:49.667321 systemd-journald[1188]: Journal started Nov 24 00:32:49.667341 systemd-journald[1188]: Runtime Journal (/run/log/journal/1c399172b1b746e6abfb5820399f00b9) is 8M, max 78.2M, 70.2M free. Nov 24 00:32:49.260476 systemd[1]: Queued start job for default target multi-user.target. Nov 24 00:32:49.287225 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Nov 24 00:32:49.287792 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 24 00:32:49.672017 systemd[1]: Started systemd-journald.service - Journal Service. Nov 24 00:32:49.672668 systemd[1]: Mounted media.mount - External Media Directory. Nov 24 00:32:49.673533 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 24 00:32:49.674416 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 24 00:32:49.675370 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 24 00:32:49.676466 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 24 00:32:49.677619 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 24 00:32:49.678722 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 24 00:32:49.679006 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 24 00:32:49.680098 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 24 00:32:49.680298 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 24 00:32:49.681683 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 24 00:32:49.681968 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 24 00:32:49.683061 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 24 00:32:49.683331 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 24 00:32:49.684434 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 24 00:32:49.684690 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 24 00:32:49.685806 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 24 00:32:49.686087 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 24 00:32:49.687626 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 24 00:32:49.688740 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 24 00:32:49.689846 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 24 00:32:49.691146 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 24 00:32:49.704812 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 24 00:32:49.708090 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 24 00:32:49.712128 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 24 00:32:49.714083 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 24 00:32:49.714113 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 24 00:32:49.715738 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 24 00:32:49.730171 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 24 00:32:49.733236 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:32:49.750137 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 24 00:32:49.753934 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 24 00:32:49.756111 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 24 00:32:49.765399 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 24 00:32:49.767072 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 24 00:32:49.772544 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 24 00:32:49.779156 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 24 00:32:49.782107 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 24 00:32:49.786351 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 24 00:32:49.788852 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 24 00:32:49.802067 systemd-journald[1188]: Time spent on flushing to /var/log/journal/1c399172b1b746e6abfb5820399f00b9 is 27.960ms for 994 entries. Nov 24 00:32:49.802067 systemd-journald[1188]: System Journal (/var/log/journal/1c399172b1b746e6abfb5820399f00b9) is 8M, max 195.6M, 187.6M free. Nov 24 00:32:49.856020 systemd-journald[1188]: Received client request to flush runtime journal. Nov 24 00:32:49.856081 kernel: loop0: detected capacity change from 0 to 110984 Nov 24 00:32:49.804731 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 24 00:32:49.815288 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 24 00:32:49.818229 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 24 00:32:49.826169 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 24 00:32:49.856540 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 24 00:32:49.859723 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 24 00:32:49.868414 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Nov 24 00:32:49.868429 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Nov 24 00:32:49.876410 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 24 00:32:49.887834 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 24 00:32:49.893229 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 24 00:32:49.896158 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 24 00:32:49.914008 kernel: loop1: detected capacity change from 0 to 8 Nov 24 00:32:49.931034 kernel: loop2: detected capacity change from 0 to 219144 Nov 24 00:32:49.960172 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 24 00:32:49.963532 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 24 00:32:49.975013 kernel: loop3: detected capacity change from 0 to 128560 Nov 24 00:32:50.004280 systemd-tmpfiles[1247]: ACLs are not supported, ignoring. Nov 24 00:32:50.004300 systemd-tmpfiles[1247]: ACLs are not supported, ignoring. Nov 24 00:32:50.011371 kernel: loop4: detected capacity change from 0 to 110984 Nov 24 00:32:50.017405 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 24 00:32:50.036020 kernel: loop5: detected capacity change from 0 to 8 Nov 24 00:32:50.041312 kernel: loop6: detected capacity change from 0 to 219144 Nov 24 00:32:50.066007 kernel: loop7: detected capacity change from 0 to 128560 Nov 24 00:32:50.083468 (sd-merge)[1250]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-akamai'. Nov 24 00:32:50.084298 (sd-merge)[1250]: Merged extensions into '/usr'. Nov 24 00:32:50.094092 systemd[1]: Reload requested from client PID 1225 ('systemd-sysext') (unit systemd-sysext.service)... Nov 24 00:32:50.094109 systemd[1]: Reloading... Nov 24 00:32:50.223018 zram_generator::config[1277]: No configuration found. Nov 24 00:32:50.297961 ldconfig[1220]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 24 00:32:50.439904 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 24 00:32:50.440109 systemd[1]: Reloading finished in 344 ms. Nov 24 00:32:50.471829 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 24 00:32:50.472980 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 24 00:32:50.474133 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 24 00:32:50.486498 systemd[1]: Starting ensure-sysext.service... Nov 24 00:32:50.490105 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 24 00:32:50.492947 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 24 00:32:50.510965 systemd[1]: Reload requested from client PID 1321 ('systemctl') (unit ensure-sysext.service)... Nov 24 00:32:50.511013 systemd[1]: Reloading... Nov 24 00:32:50.524534 systemd-tmpfiles[1322]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 24 00:32:50.525385 systemd-tmpfiles[1322]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 24 00:32:50.525748 systemd-tmpfiles[1322]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 24 00:32:50.527298 systemd-tmpfiles[1322]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 24 00:32:50.529606 systemd-tmpfiles[1322]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 24 00:32:50.530906 systemd-tmpfiles[1322]: ACLs are not supported, ignoring. Nov 24 00:32:50.531062 systemd-tmpfiles[1322]: ACLs are not supported, ignoring. Nov 24 00:32:50.536950 systemd-udevd[1323]: Using default interface naming scheme 'v255'. Nov 24 00:32:50.540341 systemd-tmpfiles[1322]: Detected autofs mount point /boot during canonicalization of boot. Nov 24 00:32:50.540710 systemd-tmpfiles[1322]: Skipping /boot Nov 24 00:32:50.560797 systemd-tmpfiles[1322]: Detected autofs mount point /boot during canonicalization of boot. Nov 24 00:32:50.560810 systemd-tmpfiles[1322]: Skipping /boot Nov 24 00:32:50.621523 zram_generator::config[1374]: No configuration found. Nov 24 00:32:50.848038 kernel: mousedev: PS/2 mouse device common for all mice Nov 24 00:32:50.855024 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Nov 24 00:32:50.888682 kernel: ACPI: button: Power Button [PWRF] Nov 24 00:32:50.902972 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 24 00:32:50.903479 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 24 00:32:50.915188 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 24 00:32:50.916079 systemd[1]: Reloading finished in 404 ms. Nov 24 00:32:50.926767 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 24 00:32:50.928757 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 24 00:32:50.962797 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:50.966295 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 24 00:32:50.972274 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 24 00:32:50.973297 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:32:50.975757 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 24 00:32:50.979208 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 24 00:32:50.986232 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 24 00:32:50.988162 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:32:50.988271 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 24 00:32:50.989477 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 24 00:32:50.996218 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 24 00:32:51.004255 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 24 00:32:51.008580 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 24 00:32:51.010246 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:51.016870 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:51.017066 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:32:51.017713 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:32:51.017805 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 24 00:32:51.017906 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:51.024779 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:51.026091 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 24 00:32:51.028432 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 24 00:32:51.030143 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 24 00:32:51.030244 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 24 00:32:51.030361 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 24 00:32:51.043328 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 24 00:32:51.044808 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 24 00:32:51.047667 systemd[1]: Finished ensure-sysext.service. Nov 24 00:32:51.061938 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 24 00:32:51.064686 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 24 00:32:51.068500 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). Nov 24 00:32:51.082533 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 24 00:32:51.112928 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 24 00:32:51.116213 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 24 00:32:51.122637 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 24 00:32:51.123284 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 24 00:32:51.124625 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 24 00:32:51.124867 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 24 00:32:51.129291 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 24 00:32:51.129650 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 24 00:32:51.135303 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 24 00:32:51.146481 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 24 00:32:51.151838 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 24 00:32:51.168093 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 24 00:32:51.180784 augenrules[1486]: No rules Nov 24 00:32:51.181955 systemd[1]: audit-rules.service: Deactivated successfully. Nov 24 00:32:51.187227 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 24 00:32:51.188552 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 24 00:32:51.236017 kernel: EDAC MC: Ver: 3.0.0 Nov 24 00:32:51.251515 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Nov 24 00:32:51.256225 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 24 00:32:51.286766 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 24 00:32:51.300185 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 24 00:32:51.407389 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 24 00:32:51.478777 systemd-resolved[1451]: Positive Trust Anchors: Nov 24 00:32:51.478796 systemd-resolved[1451]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 24 00:32:51.478826 systemd-resolved[1451]: 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 Nov 24 00:32:51.482619 systemd-resolved[1451]: Defaulting to hostname 'linux'. Nov 24 00:32:51.484218 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 24 00:32:51.485143 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 24 00:32:51.485626 systemd-networkd[1449]: lo: Link UP Nov 24 00:32:51.485638 systemd-networkd[1449]: lo: Gained carrier Nov 24 00:32:51.487502 systemd-networkd[1449]: Enumeration completed Nov 24 00:32:51.487585 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 24 00:32:51.487909 systemd-networkd[1449]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:32:51.487914 systemd-networkd[1449]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 24 00:32:51.488932 systemd[1]: Reached target network.target - Network. Nov 24 00:32:51.489187 systemd-networkd[1449]: eth0: Link UP Nov 24 00:32:51.489758 systemd-networkd[1449]: eth0: Gained carrier Nov 24 00:32:51.489772 systemd-networkd[1449]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 24 00:32:51.492320 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 24 00:32:51.498215 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 24 00:32:51.499267 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 24 00:32:51.500292 systemd[1]: Reached target sysinit.target - System Initialization. Nov 24 00:32:51.501586 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 24 00:32:51.503099 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 24 00:32:51.504304 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 24 00:32:51.505175 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 24 00:32:51.506330 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 24 00:32:51.506363 systemd[1]: Reached target paths.target - Path Units. Nov 24 00:32:51.507370 systemd[1]: Reached target time-set.target - System Time Set. Nov 24 00:32:51.508345 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 24 00:32:51.509300 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 24 00:32:51.510128 systemd[1]: Reached target timers.target - Timer Units. Nov 24 00:32:51.514021 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 24 00:32:51.516293 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 24 00:32:51.519240 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 24 00:32:51.520186 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 24 00:32:51.520967 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 24 00:32:51.523849 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 24 00:32:51.524942 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 24 00:32:51.526536 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 24 00:32:51.528147 systemd[1]: Reached target sockets.target - Socket Units. Nov 24 00:32:51.528823 systemd[1]: Reached target basic.target - Basic System. Nov 24 00:32:51.529570 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 24 00:32:51.529596 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 24 00:32:51.531129 systemd[1]: Starting containerd.service - containerd container runtime... Nov 24 00:32:51.534137 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 24 00:32:51.537945 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 24 00:32:51.540907 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 24 00:32:51.543719 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 24 00:32:51.547099 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 24 00:32:51.548906 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). Nov 24 00:32:51.552110 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 24 00:32:51.554235 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 24 00:32:51.560202 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 24 00:32:51.573195 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 24 00:32:51.581460 jq[1520]: false Nov 24 00:32:51.588515 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 24 00:32:51.591794 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 24 00:32:51.592373 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 24 00:32:51.593222 systemd[1]: Starting update-engine.service - Update Engine... Nov 24 00:32:51.601193 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 24 00:32:51.604532 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 24 00:32:51.608942 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 24 00:32:51.610179 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 24 00:32:51.611161 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 24 00:32:51.611494 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 24 00:32:51.611718 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 24 00:32:51.622078 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Refreshing passwd entry cache Nov 24 00:32:51.621190 oslogin_cache_refresh[1522]: Refreshing passwd entry cache Nov 24 00:32:51.629030 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Failure getting users, quitting Nov 24 00:32:51.629030 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 24 00:32:51.629030 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Refreshing group entry cache Nov 24 00:32:51.629030 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Failure getting groups, quitting Nov 24 00:32:51.629030 google_oslogin_nss_cache[1522]: oslogin_cache_refresh[1522]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 24 00:32:51.628945 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 24 00:32:51.625645 oslogin_cache_refresh[1522]: Failure getting users, quitting Nov 24 00:32:51.625662 oslogin_cache_refresh[1522]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 24 00:32:51.625702 oslogin_cache_refresh[1522]: Refreshing group entry cache Nov 24 00:32:51.627403 oslogin_cache_refresh[1522]: Failure getting groups, quitting Nov 24 00:32:51.627413 oslogin_cache_refresh[1522]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 24 00:32:51.629645 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 24 00:32:51.633541 update_engine[1529]: I20251124 00:32:51.633469 1529 main.cc:92] Flatcar Update Engine starting Nov 24 00:32:51.640075 extend-filesystems[1521]: Found /dev/sda6 Nov 24 00:32:51.659959 dbus-daemon[1518]: [system] SELinux support is enabled Nov 24 00:32:51.660142 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 24 00:32:51.662437 jq[1530]: true Nov 24 00:32:51.664262 update_engine[1529]: I20251124 00:32:51.664204 1529 update_check_scheduler.cc:74] Next update check in 9m45s Nov 24 00:32:51.665067 extend-filesystems[1521]: Found /dev/sda9 Nov 24 00:32:51.666358 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). Nov 24 00:32:51.666392 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 24 00:32:51.668076 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). Nov 24 00:32:51.668099 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 24 00:32:51.675172 systemd[1]: Started update-engine.service - Update Engine. Nov 24 00:32:51.680283 extend-filesystems[1521]: Checking size of /dev/sda9 Nov 24 00:32:51.689326 jq[1555]: true Nov 24 00:32:51.690394 (ntainerd)[1551]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 24 00:32:51.702469 extend-filesystems[1521]: Resized partition /dev/sda9 Nov 24 00:32:51.705039 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 24 00:32:51.707101 extend-filesystems[1563]: resize2fs 1.47.3 (8-Jul-2025) Nov 24 00:32:51.707548 systemd[1]: motdgen.service: Deactivated successfully. Nov 24 00:32:51.707811 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 24 00:32:51.710133 coreos-metadata[1517]: Nov 24 00:32:51.709 INFO Putting http://169.254.169.254/v1/token: Attempt #1 Nov 24 00:32:51.725436 kernel: EXT4-fs (sda9): resizing filesystem from 553472 to 20360187 blocks Nov 24 00:32:51.768827 systemd-logind[1528]: Watching system buttons on /dev/input/event2 (Power Button) Nov 24 00:32:51.768859 systemd-logind[1528]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 24 00:32:51.771787 systemd-logind[1528]: New seat seat0. Nov 24 00:32:51.788469 systemd[1]: Started systemd-logind.service - User Login Management. Nov 24 00:32:51.860533 bash[1581]: Updated "/home/core/.ssh/authorized_keys" Nov 24 00:32:51.861665 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 24 00:32:51.876844 systemd[1]: Starting sshkeys.service... Nov 24 00:32:51.923907 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Nov 24 00:32:51.969716 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Nov 24 00:32:51.981505 kernel: EXT4-fs (sda9): resized filesystem to 20360187 Nov 24 00:32:51.993417 extend-filesystems[1563]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Nov 24 00:32:51.993417 extend-filesystems[1563]: old_desc_blocks = 1, new_desc_blocks = 10 Nov 24 00:32:51.993417 extend-filesystems[1563]: The filesystem on /dev/sda9 is now 20360187 (4k) blocks long. Nov 24 00:32:52.007420 extend-filesystems[1521]: Resized filesystem in /dev/sda9 Nov 24 00:32:51.999862 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 24 00:32:52.000184 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 24 00:32:52.036024 locksmithd[1557]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 24 00:32:52.054931 containerd[1551]: time="2025-11-24T00:32:52Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 24 00:32:52.056336 containerd[1551]: time="2025-11-24T00:32:52.056290964Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Nov 24 00:32:52.057189 coreos-metadata[1591]: Nov 24 00:32:52.057 INFO Putting http://169.254.169.254/v1/token: Attempt #1 Nov 24 00:32:52.064950 containerd[1551]: time="2025-11-24T00:32:52.064926262Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.14µs" Nov 24 00:32:52.065078 containerd[1551]: time="2025-11-24T00:32:52.065060332Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 24 00:32:52.065131 containerd[1551]: time="2025-11-24T00:32:52.065119252Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 24 00:32:52.065312 containerd[1551]: time="2025-11-24T00:32:52.065296903Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 24 00:32:52.065364 containerd[1551]: time="2025-11-24T00:32:52.065353213Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 24 00:32:52.065418 containerd[1551]: time="2025-11-24T00:32:52.065407363Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 24 00:32:52.065530 containerd[1551]: time="2025-11-24T00:32:52.065514053Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 24 00:32:52.065575 containerd[1551]: time="2025-11-24T00:32:52.065564253Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 24 00:32:52.065866 containerd[1551]: time="2025-11-24T00:32:52.065846323Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 24 00:32:52.065917 containerd[1551]: time="2025-11-24T00:32:52.065905423Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 24 00:32:52.065959 containerd[1551]: time="2025-11-24T00:32:52.065947553Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 24 00:32:52.066038 containerd[1551]: time="2025-11-24T00:32:52.066024183Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 24 00:32:52.066174 containerd[1551]: time="2025-11-24T00:32:52.066158283Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 24 00:32:52.066539 containerd[1551]: time="2025-11-24T00:32:52.066521044Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 24 00:32:52.066611 containerd[1551]: time="2025-11-24T00:32:52.066597634Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 24 00:32:52.066667 containerd[1551]: time="2025-11-24T00:32:52.066654504Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 24 00:32:52.066743 containerd[1551]: time="2025-11-24T00:32:52.066730564Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 24 00:32:52.067040 containerd[1551]: time="2025-11-24T00:32:52.067024854Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 24 00:32:52.067143 containerd[1551]: time="2025-11-24T00:32:52.067128884Z" level=info msg="metadata content store policy set" policy=shared Nov 24 00:32:52.069179 containerd[1551]: time="2025-11-24T00:32:52.069160896Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 24 00:32:52.069269 containerd[1551]: time="2025-11-24T00:32:52.069255147Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 24 00:32:52.069377 containerd[1551]: time="2025-11-24T00:32:52.069362507Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 24 00:32:52.069429 containerd[1551]: time="2025-11-24T00:32:52.069417877Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 24 00:32:52.069473 containerd[1551]: time="2025-11-24T00:32:52.069462817Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 24 00:32:52.069514 containerd[1551]: time="2025-11-24T00:32:52.069504487Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 24 00:32:52.069557 containerd[1551]: time="2025-11-24T00:32:52.069547357Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 24 00:32:52.069599 containerd[1551]: time="2025-11-24T00:32:52.069589427Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 24 00:32:52.069639 containerd[1551]: time="2025-11-24T00:32:52.069629097Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 24 00:32:52.069688 containerd[1551]: time="2025-11-24T00:32:52.069677197Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 24 00:32:52.069728 containerd[1551]: time="2025-11-24T00:32:52.069718247Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 24 00:32:52.069769 containerd[1551]: time="2025-11-24T00:32:52.069759167Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 24 00:32:52.069903 containerd[1551]: time="2025-11-24T00:32:52.069887207Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 24 00:32:52.069964 containerd[1551]: time="2025-11-24T00:32:52.069952727Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 24 00:32:52.070048 containerd[1551]: time="2025-11-24T00:32:52.070034277Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 24 00:32:52.070108 containerd[1551]: time="2025-11-24T00:32:52.070096267Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 24 00:32:52.070159 containerd[1551]: time="2025-11-24T00:32:52.070148367Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 24 00:32:52.070202 containerd[1551]: time="2025-11-24T00:32:52.070191957Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070241228Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070254798Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070264868Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070274438Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070283628Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070321688Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 24 00:32:52.070356 containerd[1551]: time="2025-11-24T00:32:52.070332578Z" level=info msg="Start snapshots syncer" Nov 24 00:32:52.070579 containerd[1551]: time="2025-11-24T00:32:52.070557728Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 24 00:32:52.070880 containerd[1551]: time="2025-11-24T00:32:52.070847098Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 24 00:32:52.071080 containerd[1551]: time="2025-11-24T00:32:52.071063788Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 24 00:32:52.071188 containerd[1551]: time="2025-11-24T00:32:52.071173068Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 24 00:32:52.071380 containerd[1551]: time="2025-11-24T00:32:52.071362679Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 24 00:32:52.071440 containerd[1551]: time="2025-11-24T00:32:52.071428849Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 24 00:32:52.071483 containerd[1551]: time="2025-11-24T00:32:52.071473019Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 24 00:32:52.071522 containerd[1551]: time="2025-11-24T00:32:52.071512169Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 24 00:32:52.071571 containerd[1551]: time="2025-11-24T00:32:52.071560269Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 24 00:32:52.071613 containerd[1551]: time="2025-11-24T00:32:52.071603009Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 24 00:32:52.071665 containerd[1551]: time="2025-11-24T00:32:52.071653169Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 24 00:32:52.071718 containerd[1551]: time="2025-11-24T00:32:52.071706149Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 24 00:32:52.071766 containerd[1551]: time="2025-11-24T00:32:52.071755479Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 24 00:32:52.071808 containerd[1551]: time="2025-11-24T00:32:52.071798409Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 24 00:32:52.071924 containerd[1551]: time="2025-11-24T00:32:52.071876539Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 24 00:32:52.071924 containerd[1551]: time="2025-11-24T00:32:52.071893699Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 24 00:32:52.071924 containerd[1551]: time="2025-11-24T00:32:52.071901969Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072078739Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072096099Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072106259Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072121359Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072136249Z" level=info msg="runtime interface created" Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072141369Z" level=info msg="created NRI interface" Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072148329Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072157999Z" level=info msg="Connect containerd service" Nov 24 00:32:52.072208 containerd[1551]: time="2025-11-24T00:32:52.072180919Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 24 00:32:52.073184 containerd[1551]: time="2025-11-24T00:32:52.073164020Z" 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" Nov 24 00:32:52.151484 containerd[1551]: time="2025-11-24T00:32:52.151413069Z" level=info msg="Start subscribing containerd event" Nov 24 00:32:52.151583 containerd[1551]: time="2025-11-24T00:32:52.151570309Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 24 00:32:52.151806 containerd[1551]: time="2025-11-24T00:32:52.151625519Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 24 00:32:52.151806 containerd[1551]: time="2025-11-24T00:32:52.151663749Z" level=info msg="Start recovering state" Nov 24 00:32:52.151806 containerd[1551]: time="2025-11-24T00:32:52.151777109Z" level=info msg="Start event monitor" Nov 24 00:32:52.151898 containerd[1551]: time="2025-11-24T00:32:52.151886219Z" level=info msg="Start cni network conf syncer for default" Nov 24 00:32:52.155053 containerd[1551]: time="2025-11-24T00:32:52.151930379Z" level=info msg="Start streaming server" Nov 24 00:32:52.155152 containerd[1551]: time="2025-11-24T00:32:52.155138252Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 24 00:32:52.155292 containerd[1551]: time="2025-11-24T00:32:52.155192212Z" level=info msg="runtime interface starting up..." Nov 24 00:32:52.155292 containerd[1551]: time="2025-11-24T00:32:52.155222553Z" level=info msg="starting plugins..." Nov 24 00:32:52.155292 containerd[1551]: time="2025-11-24T00:32:52.155240513Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 24 00:32:52.155627 systemd[1]: Started containerd.service - containerd container runtime. Nov 24 00:32:52.159817 containerd[1551]: time="2025-11-24T00:32:52.159790287Z" level=info msg="containerd successfully booted in 0.105518s" Nov 24 00:32:52.229053 systemd-networkd[1449]: eth0: DHCPv4 address 172.237.134.230/24, gateway 172.237.134.1 acquired from 23.213.15.216 Nov 24 00:32:52.229147 dbus-daemon[1518]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1449 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 24 00:32:52.230588 systemd-timesyncd[1461]: Network configuration changed, trying to establish connection. Nov 24 00:32:52.237154 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Nov 24 00:32:52.325246 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Nov 24 00:32:52.327569 dbus-daemon[1518]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 24 00:32:52.328058 dbus-daemon[1518]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=1615 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 24 00:32:52.335207 systemd[1]: Starting polkit.service - Authorization Manager... Nov 24 00:32:52.423730 polkitd[1616]: Started polkitd version 126 Nov 24 00:32:52.427539 polkitd[1616]: Loading rules from directory /etc/polkit-1/rules.d Nov 24 00:32:52.427907 polkitd[1616]: Loading rules from directory /run/polkit-1/rules.d Nov 24 00:32:52.428020 polkitd[1616]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Nov 24 00:32:52.428289 polkitd[1616]: Loading rules from directory /usr/local/share/polkit-1/rules.d Nov 24 00:32:52.428358 polkitd[1616]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Nov 24 00:32:52.428448 polkitd[1616]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 24 00:32:52.429127 polkitd[1616]: Finished loading, compiling and executing 2 rules Nov 24 00:32:52.429389 systemd[1]: Started polkit.service - Authorization Manager. Nov 24 00:32:52.430542 dbus-daemon[1518]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 24 00:32:52.430967 polkitd[1616]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 24 00:32:52.439768 systemd-hostnamed[1615]: Hostname set to <172-237-134-230> (transient) Nov 24 00:32:52.439774 systemd-resolved[1451]: System hostname changed to '172-237-134-230'. Nov 24 00:32:52.679451 sshd_keygen[1546]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 24 00:32:52.699531 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 24 00:32:52.702359 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 24 00:32:52.715779 systemd[1]: issuegen.service: Deactivated successfully. Nov 24 00:32:52.716034 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 24 00:32:52.720249 coreos-metadata[1517]: Nov 24 00:32:52.720 INFO Putting http://169.254.169.254/v1/token: Attempt #2 Nov 24 00:32:52.720389 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 24 00:32:52.741221 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 24 00:32:52.744487 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 24 00:32:52.747325 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 24 00:32:52.749023 systemd[1]: Reached target getty.target - Login Prompts. Nov 24 00:32:52.809528 coreos-metadata[1517]: Nov 24 00:32:52.809 INFO Fetching http://169.254.169.254/v1/instance: Attempt #1 Nov 24 00:32:52.848175 systemd-networkd[1449]: eth0: Gained IPv6LL Nov 24 00:32:52.851613 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 24 00:32:52.853198 systemd[1]: Reached target network-online.target - Network is Online. Nov 24 00:32:52.856590 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 24 00:32:52.860207 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 24 00:32:52.890659 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 24 00:32:53.068562 coreos-metadata[1591]: Nov 24 00:32:53.068 INFO Putting http://169.254.169.254/v1/token: Attempt #2 Nov 24 00:32:53.159086 coreos-metadata[1591]: Nov 24 00:32:53.158 INFO Fetching http://169.254.169.254/v1/ssh-keys: Attempt #1 Nov 24 00:32:53.170762 coreos-metadata[1517]: Nov 24 00:32:53.170 INFO Fetch successful Nov 24 00:32:53.170762 coreos-metadata[1517]: Nov 24 00:32:53.170 INFO Fetching http://169.254.169.254/v1/network: Attempt #1 Nov 24 00:32:53.307032 coreos-metadata[1591]: Nov 24 00:32:53.306 INFO Fetch successful Nov 24 00:32:53.327446 update-ssh-keys[1657]: Updated "/home/core/.ssh/authorized_keys" Nov 24 00:32:53.329222 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Nov 24 00:32:53.333366 systemd[1]: Finished sshkeys.service. Nov 24 00:32:53.431822 coreos-metadata[1517]: Nov 24 00:32:53.431 INFO Fetch successful Nov 24 00:32:53.554619 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 24 00:32:53.556876 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 24 00:32:54.628576 systemd-resolved[1451]: Clock change detected. Flushing caches. Nov 24 00:32:54.629092 systemd-timesyncd[1461]: Contacted time server 66.118.229.14:123 (1.flatcar.pool.ntp.org). Nov 24 00:32:54.629176 systemd-timesyncd[1461]: Initial clock synchronization to Mon 2025-11-24 00:32:54.627755 UTC. Nov 24 00:32:54.718208 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 24 00:32:54.720591 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 24 00:32:54.722483 systemd[1]: Startup finished in 3.124s (kernel) + 7.944s (initrd) + 5.237s (userspace) = 16.307s. Nov 24 00:32:54.726452 (kubelet)[1685]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 24 00:32:55.216308 kubelet[1685]: E1124 00:32:55.216248 1685 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" Nov 24 00:32:55.219629 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 24 00:32:55.219825 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 24 00:32:55.220232 systemd[1]: kubelet.service: Consumed 875ms CPU time, 258M memory peak. Nov 24 00:32:56.173701 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 24 00:32:56.174857 systemd[1]: Started sshd@0-172.237.134.230:22-147.75.109.163:46840.service - OpenSSH per-connection server daemon (147.75.109.163:46840). Nov 24 00:32:56.515109 sshd[1697]: Accepted publickey for core from 147.75.109.163 port 46840 ssh2: RSA SHA256:Pchp35vWTs9Zdpru8qSkjaQDXNtKYOQijK11UPKUQY8 Nov 24 00:32:56.516546 sshd-session[1697]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:32:56.524076 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 24 00:32:56.525447 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 24 00:32:56.533748 systemd-logind[1528]: New session 1 of user core. Nov 24 00:32:56.545797 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 24 00:32:56.549573 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 24 00:32:56.566935 (systemd)[1702]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 24 00:32:56.570077 systemd-logind[1528]: New session c1 of user core. Nov 24 00:32:56.709229 systemd[1702]: Queued start job for default target default.target. Nov 24 00:32:56.721376 systemd[1702]: Created slice app.slice - User Application Slice. Nov 24 00:32:56.721405 systemd[1702]: Reached target paths.target - Paths. Nov 24 00:32:56.721450 systemd[1702]: Reached target timers.target - Timers. Nov 24 00:32:56.722865 systemd[1702]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 24 00:32:56.735246 systemd[1702]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 24 00:32:56.735469 systemd[1702]: Reached target sockets.target - Sockets. Nov 24 00:32:56.735618 systemd[1702]: Reached target basic.target - Basic System. Nov 24 00:32:56.735792 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 24 00:32:56.735916 systemd[1702]: Reached target default.target - Main User Target. Nov 24 00:32:56.737097 systemd[1702]: Startup finished in 159ms. Nov 24 00:32:56.746172 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 24 00:32:57.006861 systemd[1]: Started sshd@1-172.237.134.230:22-147.75.109.163:46848.service - OpenSSH per-connection server daemon (147.75.109.163:46848). Nov 24 00:32:57.344708 sshd[1713]: Accepted publickey for core from 147.75.109.163 port 46848 ssh2: RSA SHA256:Pchp35vWTs9Zdpru8qSkjaQDXNtKYOQijK11UPKUQY8 Nov 24 00:32:57.346738 sshd-session[1713]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:32:57.353639 systemd-logind[1528]: New session 2 of user core. Nov 24 00:32:57.362166 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 24 00:32:57.584842 sshd[1716]: Connection closed by 147.75.109.163 port 46848 Nov 24 00:32:57.585518 sshd-session[1713]: pam_unix(sshd:session): session closed for user core Nov 24 00:32:57.589818 systemd[1]: sshd@1-172.237.134.230:22-147.75.109.163:46848.service: Deactivated successfully. Nov 24 00:32:57.592234 systemd[1]: session-2.scope: Deactivated successfully. Nov 24 00:32:57.595227 systemd-logind[1528]: Session 2 logged out. Waiting for processes to exit. Nov 24 00:32:57.596973 systemd-logind[1528]: Removed session 2. Nov 24 00:32:57.658009 systemd[1]: Started sshd@2-172.237.134.230:22-147.75.109.163:46858.service - OpenSSH per-connection server daemon (147.75.109.163:46858). Nov 24 00:32:57.992402 sshd[1722]: Accepted publickey for core from 147.75.109.163 port 46858 ssh2: RSA SHA256:Pchp35vWTs9Zdpru8qSkjaQDXNtKYOQijK11UPKUQY8 Nov 24 00:32:57.993895 sshd-session[1722]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:32:57.999124 systemd-logind[1528]: New session 3 of user core. Nov 24 00:32:58.006143 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 24 00:32:58.225440 sshd[1725]: Connection closed by 147.75.109.163 port 46858 Nov 24 00:32:58.226067 sshd-session[1722]: pam_unix(sshd:session): session closed for user core Nov 24 00:32:58.230098 systemd[1]: sshd@2-172.237.134.230:22-147.75.109.163:46858.service: Deactivated successfully. Nov 24 00:32:58.231896 systemd[1]: session-3.scope: Deactivated successfully. Nov 24 00:32:58.232674 systemd-logind[1528]: Session 3 logged out. Waiting for processes to exit. Nov 24 00:32:58.233879 systemd-logind[1528]: Removed session 3. Nov 24 00:32:58.283889 systemd[1]: Started sshd@3-172.237.134.230:22-147.75.109.163:46868.service - OpenSSH per-connection server daemon (147.75.109.163:46868). Nov 24 00:32:58.608092 sshd[1731]: Accepted publickey for core from 147.75.109.163 port 46868 ssh2: RSA SHA256:Pchp35vWTs9Zdpru8qSkjaQDXNtKYOQijK11UPKUQY8 Nov 24 00:32:58.609724 sshd-session[1731]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:32:58.615857 systemd-logind[1528]: New session 4 of user core. Nov 24 00:32:58.621151 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 24 00:32:58.846159 sshd[1734]: Connection closed by 147.75.109.163 port 46868 Nov 24 00:32:58.846770 sshd-session[1731]: pam_unix(sshd:session): session closed for user core Nov 24 00:32:58.850854 systemd-logind[1528]: Session 4 logged out. Waiting for processes to exit. Nov 24 00:32:58.851632 systemd[1]: sshd@3-172.237.134.230:22-147.75.109.163:46868.service: Deactivated successfully. Nov 24 00:32:58.853451 systemd[1]: session-4.scope: Deactivated successfully. Nov 24 00:32:58.855209 systemd-logind[1528]: Removed session 4. Nov 24 00:32:58.911294 systemd[1]: Started sshd@4-172.237.134.230:22-147.75.109.163:46882.service - OpenSSH per-connection server daemon (147.75.109.163:46882). Nov 24 00:32:59.251228 sshd[1740]: Accepted publickey for core from 147.75.109.163 port 46882 ssh2: RSA SHA256:Pchp35vWTs9Zdpru8qSkjaQDXNtKYOQijK11UPKUQY8 Nov 24 00:32:59.252638 sshd-session[1740]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 24 00:32:59.257099 systemd-logind[1528]: New session 5 of user core. Nov 24 00:32:59.262156 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 24 00:32:59.455848 sudo[1744]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 24 00:32:59.456201 sudo[1744]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 24 00:33:00.055873 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 24 00:33:00.056920 systemd[1]: kubelet.service: Consumed 875ms CPU time, 258M memory peak. Nov 24 00:33:00.059935 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 24 00:33:00.092386 systemd[1]: Reload requested from client PID 1777 ('systemctl') (unit session-5.scope)... Nov 24 00:33:00.092482 systemd[1]: Reloading... Nov 24 00:33:00.235088 zram_generator::config[1816]: No configuration found. Nov 24 00:33:00.460787 systemd[1]: Reloading finished in 367 ms. Nov 24 00:33:00.524592 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Nov 24 00:33:00.524702 systemd[1]: kubelet.service: Failed with result 'signal'. Nov 24 00:33:00.525001 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 24 00:33:00.525079 systemd[1]: kubelet.service: Consumed 153ms CPU time, 98.2M memory peak. Nov 24 00:33:00.526583 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 24 00:33:00.719343 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 24 00:33:00.729412 (kubelet)[1874]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Nov 24 00:33:00.766562 kubelet[1874]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 24 00:33:00.766562 kubelet[1874]: 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. Nov 24 00:33:00.766942 kubelet[1874]: I1124 00:33:00.766587 1874 server.go:213] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Nov 24 00:33:01.819802 kubelet[1874]: I1124 00:33:01.819153 1874 server.go:529] "Kubelet version" kubeletVersion="v1.34.1" Nov 24 00:33:01.819802 kubelet[1874]: I1124 00:33:01.819184 1874 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 24 00:33:01.820671 kubelet[1874]: I1124 00:33:01.820232 1874 watchdog_linux.go:95] "Systemd watchdog is not enabled" Nov 24 00:33:01.820671 kubelet[1874]: I1124 00:33:01.820256 1874 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 24 00:33:01.820671 kubelet[1874]: I1124 00:33:01.820531 1874 server.go:956] "Client rotation is on, will bootstrap in background" Nov 24 00:33:01.824723 kubelet[1874]: I1124 00:33:01.824538 1874 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 24 00:33:01.829192 kubelet[1874]: I1124 00:33:01.829175 1874 server.go:1423] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Nov 24 00:33:01.834156 kubelet[1874]: I1124 00:33:01.833789 1874 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Nov 24 00:33:01.835541 kubelet[1874]: I1124 00:33:01.835520 1874 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 24 00:33:01.835725 kubelet[1874]: I1124 00:33:01.835607 1874 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"192.168.185.6","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Nov 24 00:33:01.835871 kubelet[1874]: I1124 00:33:01.835861 1874 topology_manager.go:138] "Creating topology manager with none policy" Nov 24 00:33:01.835918 kubelet[1874]: I1124 00:33:01.835910 1874 container_manager_linux.go:306] "Creating device plugin manager" Nov 24 00:33:01.836070 kubelet[1874]: I1124 00:33:01.836057 1874 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Nov 24 00:33:01.837862 kubelet[1874]: I1124 00:33:01.837848 1874 state_mem.go:36] "Initialized new in-memory state store" Nov 24 00:33:01.838081 kubelet[1874]: I1124 00:33:01.838069 1874 kubelet.go:475] "Attempting to sync node with API server" Nov 24 00:33:01.838141 kubelet[1874]: I1124 00:33:01.838132 1874 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 24 00:33:01.838192 kubelet[1874]: I1124 00:33:01.838185 1874 kubelet.go:387] "Adding apiserver pod source" Nov 24 00:33:01.838246 kubelet[1874]: I1124 00:33:01.838238 1874 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 24 00:33:01.838361 kubelet[1874]: E1124 00:33:01.838339 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:01.838394 kubelet[1874]: E1124 00:33:01.838369 1874 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:01.842756 kubelet[1874]: I1124 00:33:01.842728 1874 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v2.0.7" apiVersion="v1" Nov 24 00:33:01.846502 kubelet[1874]: I1124 00:33:01.844941 1874 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Nov 24 00:33:01.846502 kubelet[1874]: I1124 00:33:01.844982 1874 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Nov 24 00:33:01.846502 kubelet[1874]: W1124 00:33:01.845046 1874 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 24 00:33:01.846502 kubelet[1874]: E1124 00:33:01.846363 1874 reflector.go:205] "Failed to watch" err="failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" Nov 24 00:33:01.846502 kubelet[1874]: E1124 00:33:01.846475 1874 reflector.go:205] "Failed to watch" err="failed to list *v1.Node: nodes \"192.168.185.6\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Node" Nov 24 00:33:01.850514 kubelet[1874]: I1124 00:33:01.850489 1874 server.go:1262] "Started kubelet" Nov 24 00:33:01.851696 kubelet[1874]: I1124 00:33:01.851424 1874 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 24 00:33:01.854927 kubelet[1874]: I1124 00:33:01.854905 1874 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Nov 24 00:33:01.856287 kubelet[1874]: I1124 00:33:01.856273 1874 server.go:310] "Adding debug handlers to kubelet server" Nov 24 00:33:01.859430 kubelet[1874]: I1124 00:33:01.859405 1874 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 24 00:33:01.859510 kubelet[1874]: I1124 00:33:01.859498 1874 server_v1.go:49] "podresources" method="list" useActivePods=true Nov 24 00:33:01.859763 kubelet[1874]: I1124 00:33:01.859751 1874 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 24 00:33:01.863160 kubelet[1874]: I1124 00:33:01.863145 1874 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 24 00:33:01.864664 kubelet[1874]: E1124 00:33:01.864649 1874 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 24 00:33:01.865234 kubelet[1874]: I1124 00:33:01.865222 1874 volume_manager.go:313] "Starting Kubelet Volume Manager" Nov 24 00:33:01.865355 kubelet[1874]: I1124 00:33:01.865343 1874 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Nov 24 00:33:01.865428 kubelet[1874]: I1124 00:33:01.865419 1874 reconciler.go:29] "Reconciler: start to sync state" Nov 24 00:33:01.866123 kubelet[1874]: I1124 00:33:01.866105 1874 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Nov 24 00:33:01.867434 kubelet[1874]: I1124 00:33:01.867421 1874 factory.go:223] Registration of the containerd container factory successfully Nov 24 00:33:01.867503 kubelet[1874]: I1124 00:33:01.867494 1874 factory.go:223] Registration of the systemd container factory successfully Nov 24 00:33:01.868199 kubelet[1874]: E1124 00:33:01.868184 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:01.878043 kubelet[1874]: E1124 00:33:01.877424 1874 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"192.168.185.6\" not found" node="192.168.185.6" Nov 24 00:33:01.886926 kubelet[1874]: I1124 00:33:01.886907 1874 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 24 00:33:01.886926 kubelet[1874]: I1124 00:33:01.886922 1874 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 24 00:33:01.886995 kubelet[1874]: I1124 00:33:01.886939 1874 state_mem.go:36] "Initialized new in-memory state store" Nov 24 00:33:01.888610 kubelet[1874]: I1124 00:33:01.888490 1874 policy_none.go:49] "None policy: Start" Nov 24 00:33:01.888610 kubelet[1874]: I1124 00:33:01.888505 1874 memory_manager.go:187] "Starting memorymanager" policy="None" Nov 24 00:33:01.888610 kubelet[1874]: I1124 00:33:01.888516 1874 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Nov 24 00:33:01.889617 kubelet[1874]: I1124 00:33:01.889598 1874 policy_none.go:47] "Start" Nov 24 00:33:01.897335 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Nov 24 00:33:01.910861 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Nov 24 00:33:01.916756 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Nov 24 00:33:01.924042 kubelet[1874]: E1124 00:33:01.923575 1874 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Nov 24 00:33:01.925154 kubelet[1874]: I1124 00:33:01.924745 1874 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 24 00:33:01.926309 kubelet[1874]: I1124 00:33:01.926275 1874 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 24 00:33:01.926473 kubelet[1874]: I1124 00:33:01.926447 1874 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Nov 24 00:33:01.926657 kubelet[1874]: I1124 00:33:01.926645 1874 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 24 00:33:01.928226 kubelet[1874]: I1124 00:33:01.928205 1874 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Nov 24 00:33:01.928226 kubelet[1874]: I1124 00:33:01.928224 1874 status_manager.go:244] "Starting to sync pod status with apiserver" Nov 24 00:33:01.928281 kubelet[1874]: I1124 00:33:01.928249 1874 kubelet.go:2427] "Starting kubelet main sync loop" Nov 24 00:33:01.928342 kubelet[1874]: E1124 00:33:01.928318 1874 kubelet.go:2451] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Nov 24 00:33:01.929795 kubelet[1874]: E1124 00:33:01.929772 1874 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 24 00:33:01.929834 kubelet[1874]: E1124 00:33:01.929802 1874 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"192.168.185.6\" not found" Nov 24 00:33:02.027793 kubelet[1874]: I1124 00:33:02.027769 1874 kubelet_node_status.go:75] "Attempting to register node" node="192.168.185.6" Nov 24 00:33:02.032209 kubelet[1874]: I1124 00:33:02.032189 1874 kubelet_node_status.go:78] "Successfully registered node" node="192.168.185.6" Nov 24 00:33:02.032414 kubelet[1874]: E1124 00:33:02.032293 1874 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"192.168.185.6\": node \"192.168.185.6\" not found" Nov 24 00:33:02.049770 kubelet[1874]: E1124 00:33:02.049727 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.151218 kubelet[1874]: E1124 00:33:02.151077 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.238779 sudo[1744]: pam_unix(sudo:session): session closed for user root Nov 24 00:33:02.251497 kubelet[1874]: E1124 00:33:02.251471 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.289933 sshd[1743]: Connection closed by 147.75.109.163 port 46882 Nov 24 00:33:02.290643 sshd-session[1740]: pam_unix(sshd:session): session closed for user core Nov 24 00:33:02.294719 systemd-logind[1528]: Session 5 logged out. Waiting for processes to exit. Nov 24 00:33:02.295690 systemd[1]: sshd@4-172.237.134.230:22-147.75.109.163:46882.service: Deactivated successfully. Nov 24 00:33:02.297915 systemd[1]: session-5.scope: Deactivated successfully. Nov 24 00:33:02.298307 systemd[1]: session-5.scope: Consumed 481ms CPU time, 75.1M memory peak. Nov 24 00:33:02.300508 systemd-logind[1528]: Removed session 5. Nov 24 00:33:02.352523 kubelet[1874]: E1124 00:33:02.352483 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.453265 kubelet[1874]: E1124 00:33:02.453156 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.553783 kubelet[1874]: E1124 00:33:02.553715 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.654718 kubelet[1874]: E1124 00:33:02.654672 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.755556 kubelet[1874]: E1124 00:33:02.755417 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.822231 kubelet[1874]: I1124 00:33:02.822193 1874 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 24 00:33:02.822611 kubelet[1874]: I1124 00:33:02.822364 1874 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Nov 24 00:33:02.822611 kubelet[1874]: I1124 00:33:02.822399 1874 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Nov 24 00:33:02.838442 kubelet[1874]: E1124 00:33:02.838409 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:02.856093 kubelet[1874]: E1124 00:33:02.856066 1874 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"192.168.185.6\" not found" Nov 24 00:33:02.956907 kubelet[1874]: I1124 00:33:02.956885 1874 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 24 00:33:02.957241 containerd[1551]: time="2025-11-24T00:33:02.957214608Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 24 00:33:02.957765 kubelet[1874]: I1124 00:33:02.957733 1874 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 24 00:33:03.838634 kubelet[1874]: E1124 00:33:03.838560 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:03.839745 kubelet[1874]: I1124 00:33:03.839713 1874 apiserver.go:52] "Watching apiserver" Nov 24 00:33:03.853473 systemd[1]: Created slice kubepods-burstable-pod4f359575_baee_4066_a33f_54c279ad716f.slice - libcontainer container kubepods-burstable-pod4f359575_baee_4066_a33f_54c279ad716f.slice. Nov 24 00:33:03.864875 systemd[1]: Created slice kubepods-besteffort-pod8eef94cc_ed3f_48b0_9768_e8ae6d3fcf18.slice - libcontainer container kubepods-besteffort-pod8eef94cc_ed3f_48b0_9768_e8ae6d3fcf18.slice. Nov 24 00:33:03.866242 kubelet[1874]: I1124 00:33:03.865850 1874 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Nov 24 00:33:03.875953 kubelet[1874]: I1124 00:33:03.875931 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18-xtables-lock\") pod \"kube-proxy-xx4wf\" (UID: \"8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18\") " pod="kube-system/kube-proxy-xx4wf" Nov 24 00:33:03.876096 kubelet[1874]: I1124 00:33:03.875959 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-wgkqs\" (UniqueName: \"kubernetes.io/projected/8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18-kube-api-access-wgkqs\") pod \"kube-proxy-xx4wf\" (UID: \"8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18\") " pod="kube-system/kube-proxy-xx4wf" Nov 24 00:33:03.876096 kubelet[1874]: I1124 00:33:03.875978 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/4f359575-baee-4066-a33f-54c279ad716f-run\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:03.876096 kubelet[1874]: I1124 00:33:03.875996 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/4f359575-baee-4066-a33f-54c279ad716f-cni-plugin\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:03.876096 kubelet[1874]: I1124 00:33:03.876081 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/4f359575-baee-4066-a33f-54c279ad716f-xtables-lock\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:03.876096 kubelet[1874]: I1124 00:33:03.876098 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5xxln\" (UniqueName: \"kubernetes.io/projected/4f359575-baee-4066-a33f-54c279ad716f-kube-api-access-5xxln\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:03.876220 kubelet[1874]: I1124 00:33:03.876127 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18-kube-proxy\") pod \"kube-proxy-xx4wf\" (UID: \"8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18\") " pod="kube-system/kube-proxy-xx4wf" Nov 24 00:33:03.876220 kubelet[1874]: I1124 00:33:03.876143 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18-lib-modules\") pod \"kube-proxy-xx4wf\" (UID: \"8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18\") " pod="kube-system/kube-proxy-xx4wf" Nov 24 00:33:03.876220 kubelet[1874]: I1124 00:33:03.876156 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/4f359575-baee-4066-a33f-54c279ad716f-cni\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:03.876220 kubelet[1874]: I1124 00:33:03.876172 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/4f359575-baee-4066-a33f-54c279ad716f-flannel-cfg\") pod \"kube-flannel-ds-k8qxn\" (UID: \"4f359575-baee-4066-a33f-54c279ad716f\") " pod="kube-flannel/kube-flannel-ds-k8qxn" Nov 24 00:33:04.162898 kubelet[1874]: E1124 00:33:04.162803 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:04.163635 containerd[1551]: time="2025-11-24T00:33:04.163468454Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k8qxn,Uid:4f359575-baee-4066-a33f-54c279ad716f,Namespace:kube-flannel,Attempt:0,}" Nov 24 00:33:04.176759 kubelet[1874]: E1124 00:33:04.176738 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:04.177048 containerd[1551]: time="2025-11-24T00:33:04.176997838Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-xx4wf,Uid:8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18,Namespace:kube-system,Attempt:0,}" Nov 24 00:33:04.794798 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4073221044.mount: Deactivated successfully. Nov 24 00:33:04.802048 containerd[1551]: time="2025-11-24T00:33:04.801986283Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 24 00:33:04.802928 containerd[1551]: time="2025-11-24T00:33:04.802888883Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 24 00:33:04.803436 containerd[1551]: time="2025-11-24T00:33:04.803410114Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=321138" Nov 24 00:33:04.803937 containerd[1551]: time="2025-11-24T00:33:04.803890234Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 24 00:33:04.804399 containerd[1551]: time="2025-11-24T00:33:04.804360945Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 24 00:33:04.807037 containerd[1551]: time="2025-11-24T00:33:04.806521417Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 24 00:33:04.807122 containerd[1551]: time="2025-11-24T00:33:04.807102968Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 640.603281ms" Nov 24 00:33:04.807718 containerd[1551]: time="2025-11-24T00:33:04.807688098Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 628.916548ms" Nov 24 00:33:04.834516 containerd[1551]: time="2025-11-24T00:33:04.834469955Z" level=info msg="connecting to shim 4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333" address="unix:///run/containerd/s/3d3fbf8a79ee8e8b1d6b55b6c9c4a51298edd89934962c376e9af1e13453537a" namespace=k8s.io protocol=ttrpc version=3 Nov 24 00:33:04.834669 containerd[1551]: time="2025-11-24T00:33:04.834647165Z" level=info msg="connecting to shim cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712" address="unix:///run/containerd/s/ec9a286e1e81f0bca69c7daa213ec1d041be9088d29bfe3db26ebd53a3b174bc" namespace=k8s.io protocol=ttrpc version=3 Nov 24 00:33:04.839113 kubelet[1874]: E1124 00:33:04.839060 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:04.858166 systemd[1]: Started cri-containerd-cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712.scope - libcontainer container cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712. Nov 24 00:33:04.863402 systemd[1]: Started cri-containerd-4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333.scope - libcontainer container 4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333. Nov 24 00:33:04.913586 containerd[1551]: time="2025-11-24T00:33:04.913479074Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-xx4wf,Uid:8eef94cc-ed3f-48b0-9768-e8ae6d3fcf18,Namespace:kube-system,Attempt:0,} returns sandbox id \"cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712\"" Nov 24 00:33:04.915671 kubelet[1874]: E1124 00:33:04.915648 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:04.917940 containerd[1551]: time="2025-11-24T00:33:04.917887558Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.2\"" Nov 24 00:33:04.930306 containerd[1551]: time="2025-11-24T00:33:04.930269351Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k8qxn,Uid:4f359575-baee-4066-a33f-54c279ad716f,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\"" Nov 24 00:33:04.931077 kubelet[1874]: E1124 00:33:04.931054 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:05.839390 kubelet[1874]: E1124 00:33:05.839347 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:06.134401 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1644196343.mount: Deactivated successfully. Nov 24 00:33:06.401158 containerd[1551]: time="2025-11-24T00:33:06.400941401Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:06.402336 containerd[1551]: time="2025-11-24T00:33:06.402129362Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.2: active requests=0, bytes read=25964463" Nov 24 00:33:06.402995 containerd[1551]: time="2025-11-24T00:33:06.402954843Z" level=info msg="ImageCreate event name:\"sha256:8aa150647e88a80f2e8c7bd5beb3b7af1209fb4004a261e86b617f40849c6d45\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:06.404677 containerd[1551]: time="2025-11-24T00:33:06.404652205Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:d8b843ac8a5e861238df24a4db8c2ddced89948633400c4660464472045276f5\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:06.405449 containerd[1551]: time="2025-11-24T00:33:06.405409656Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.2\" with image id \"sha256:8aa150647e88a80f2e8c7bd5beb3b7af1209fb4004a261e86b617f40849c6d45\", repo tag \"registry.k8s.io/kube-proxy:v1.34.2\", repo digest \"registry.k8s.io/kube-proxy@sha256:d8b843ac8a5e861238df24a4db8c2ddced89948633400c4660464472045276f5\", size \"25963482\" in 1.487462947s" Nov 24 00:33:06.405449 containerd[1551]: time="2025-11-24T00:33:06.405445726Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.2\" returns image reference \"sha256:8aa150647e88a80f2e8c7bd5beb3b7af1209fb4004a261e86b617f40849c6d45\"" Nov 24 00:33:06.407478 containerd[1551]: time="2025-11-24T00:33:06.407420258Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Nov 24 00:33:06.411471 containerd[1551]: time="2025-11-24T00:33:06.411416002Z" level=info msg="CreateContainer within sandbox \"cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 24 00:33:06.422052 containerd[1551]: time="2025-11-24T00:33:06.419924790Z" level=info msg="Container 5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:06.428674 containerd[1551]: time="2025-11-24T00:33:06.428489179Z" level=info msg="CreateContainer within sandbox \"cf229438388d5806daf07f14802e8c930d914d95b129b24be31373d546d23712\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a\"" Nov 24 00:33:06.429811 containerd[1551]: time="2025-11-24T00:33:06.429743160Z" level=info msg="StartContainer for \"5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a\"" Nov 24 00:33:06.433291 containerd[1551]: time="2025-11-24T00:33:06.433232183Z" level=info msg="connecting to shim 5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a" address="unix:///run/containerd/s/ec9a286e1e81f0bca69c7daa213ec1d041be9088d29bfe3db26ebd53a3b174bc" protocol=ttrpc version=3 Nov 24 00:33:06.461172 systemd[1]: Started cri-containerd-5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a.scope - libcontainer container 5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a. Nov 24 00:33:06.570887 containerd[1551]: time="2025-11-24T00:33:06.570855141Z" level=info msg="StartContainer for \"5c170e0508e543c77d188fdc81d9372d0c1c7f5111e82239be0490f4a4f10d2a\" returns successfully" Nov 24 00:33:06.840475 kubelet[1874]: E1124 00:33:06.840441 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:06.950669 kubelet[1874]: E1124 00:33:06.950643 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:06.960817 kubelet[1874]: I1124 00:33:06.960761 1874 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-xx4wf" podStartSLOduration=3.472018312 podStartE2EDuration="4.960747101s" podCreationTimestamp="2025-11-24 00:33:02 +0000 UTC" firstStartedPulling="2025-11-24 00:33:04.917571208 +0000 UTC m=+4.183138413" lastFinishedPulling="2025-11-24 00:33:06.406299997 +0000 UTC m=+5.671867202" observedRunningTime="2025-11-24 00:33:06.96038714 +0000 UTC m=+6.225954345" watchObservedRunningTime="2025-11-24 00:33:06.960747101 +0000 UTC m=+6.226314316" Nov 24 00:33:07.134518 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount315303268.mount: Deactivated successfully. Nov 24 00:33:07.156113 containerd[1551]: time="2025-11-24T00:33:07.156013226Z" 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\"}" Nov 24 00:33:07.157396 containerd[1551]: time="2025-11-24T00:33:07.157171467Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Nov 24 00:33:07.158066 containerd[1551]: time="2025-11-24T00:33:07.158010018Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:07.160962 containerd[1551]: time="2025-11-24T00:33:07.160925321Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:07.161896 containerd[1551]: time="2025-11-24T00:33:07.161871482Z" 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 754.390394ms" Nov 24 00:33:07.161979 containerd[1551]: time="2025-11-24T00:33:07.161963122Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Nov 24 00:33:07.165101 containerd[1551]: time="2025-11-24T00:33:07.165065025Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 24 00:33:07.171844 containerd[1551]: time="2025-11-24T00:33:07.171823692Z" level=info msg="Container c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:07.175983 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount289403034.mount: Deactivated successfully. Nov 24 00:33:07.181949 containerd[1551]: time="2025-11-24T00:33:07.181917492Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be\"" Nov 24 00:33:07.183182 containerd[1551]: time="2025-11-24T00:33:07.182377362Z" level=info msg="StartContainer for \"c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be\"" Nov 24 00:33:07.183281 containerd[1551]: time="2025-11-24T00:33:07.183260093Z" level=info msg="connecting to shim c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be" address="unix:///run/containerd/s/3d3fbf8a79ee8e8b1d6b55b6c9c4a51298edd89934962c376e9af1e13453537a" protocol=ttrpc version=3 Nov 24 00:33:07.210160 systemd[1]: Started cri-containerd-c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be.scope - libcontainer container c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be. Nov 24 00:33:07.243443 containerd[1551]: time="2025-11-24T00:33:07.243221953Z" level=info msg="StartContainer for \"c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be\" returns successfully" Nov 24 00:33:07.244197 systemd[1]: cri-containerd-c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be.scope: Deactivated successfully. Nov 24 00:33:07.247581 containerd[1551]: time="2025-11-24T00:33:07.247498898Z" level=info msg="received container exit event container_id:\"c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be\" id:\"c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be\" pid:2212 exited_at:{seconds:1763944387 nanos:247191377}" Nov 24 00:33:07.273183 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-c7a674d9ea8e310eebd48c302d81c4e0f42b81ebecf9bc88e16eecceadc549be-rootfs.mount: Deactivated successfully. Nov 24 00:33:07.841740 kubelet[1874]: E1124 00:33:07.841706 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:07.952338 kubelet[1874]: E1124 00:33:07.952077 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:07.952338 kubelet[1874]: E1124 00:33:07.952115 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:07.953322 containerd[1551]: time="2025-11-24T00:33:07.953295813Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Nov 24 00:33:08.842189 kubelet[1874]: E1124 00:33:08.842146 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:09.228940 containerd[1551]: time="2025-11-24T00:33:09.228775278Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:09.230407 containerd[1551]: time="2025-11-24T00:33:09.230327700Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Nov 24 00:33:09.230864 containerd[1551]: time="2025-11-24T00:33:09.230831220Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:09.233753 containerd[1551]: time="2025-11-24T00:33:09.233721873Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:09.234832 containerd[1551]: time="2025-11-24T00:33:09.234798484Z" 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.281471791s" Nov 24 00:33:09.234869 containerd[1551]: time="2025-11-24T00:33:09.234833364Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Nov 24 00:33:09.238000 containerd[1551]: time="2025-11-24T00:33:09.237965848Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 24 00:33:09.250187 containerd[1551]: time="2025-11-24T00:33:09.249542409Z" level=info msg="Container 7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:09.255700 containerd[1551]: time="2025-11-24T00:33:09.255660175Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2\"" Nov 24 00:33:09.256220 containerd[1551]: time="2025-11-24T00:33:09.256183896Z" level=info msg="StartContainer for \"7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2\"" Nov 24 00:33:09.256908 containerd[1551]: time="2025-11-24T00:33:09.256868466Z" level=info msg="connecting to shim 7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2" address="unix:///run/containerd/s/3d3fbf8a79ee8e8b1d6b55b6c9c4a51298edd89934962c376e9af1e13453537a" protocol=ttrpc version=3 Nov 24 00:33:09.278159 systemd[1]: Started cri-containerd-7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2.scope - libcontainer container 7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2. Nov 24 00:33:09.305546 systemd[1]: cri-containerd-7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2.scope: Deactivated successfully. Nov 24 00:33:09.306978 containerd[1551]: time="2025-11-24T00:33:09.306937927Z" level=info msg="received container exit event container_id:\"7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2\" id:\"7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2\" pid:2288 exited_at:{seconds:1763944389 nanos:306678036}" Nov 24 00:33:09.308478 containerd[1551]: time="2025-11-24T00:33:09.308454058Z" level=info msg="StartContainer for \"7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2\" returns successfully" Nov 24 00:33:09.327302 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-7b046dd2e6a992702b860ee4aeb2eacaad69d4ea0f19a3f4888e71da435b4cf2-rootfs.mount: Deactivated successfully. Nov 24 00:33:09.406508 kubelet[1874]: I1124 00:33:09.406465 1874 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Nov 24 00:33:09.842884 kubelet[1874]: E1124 00:33:09.842630 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:09.958396 kubelet[1874]: E1124 00:33:09.958146 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:09.962101 containerd[1551]: time="2025-11-24T00:33:09.962052311Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 24 00:33:09.973799 containerd[1551]: time="2025-11-24T00:33:09.973752013Z" level=info msg="Container ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:09.978908 containerd[1551]: time="2025-11-24T00:33:09.978859828Z" level=info msg="CreateContainer within sandbox \"4290f9a168659ca94e8df297e412e4ec99df26b222e7547186a7d9d6be986333\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6\"" Nov 24 00:33:09.979540 containerd[1551]: time="2025-11-24T00:33:09.979447859Z" level=info msg="StartContainer for \"ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6\"" Nov 24 00:33:09.980309 containerd[1551]: time="2025-11-24T00:33:09.980280650Z" level=info msg="connecting to shim ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6" address="unix:///run/containerd/s/3d3fbf8a79ee8e8b1d6b55b6c9c4a51298edd89934962c376e9af1e13453537a" protocol=ttrpc version=3 Nov 24 00:33:10.008360 systemd[1]: Started cri-containerd-ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6.scope - libcontainer container ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6. Nov 24 00:33:10.040720 containerd[1551]: time="2025-11-24T00:33:10.040680830Z" level=info msg="StartContainer for \"ecbe466d3bbc3046fd0913d2f610f0ac5b3c7da1504a33d73dd543df2e9495e6\" returns successfully" Nov 24 00:33:10.843759 kubelet[1874]: E1124 00:33:10.843707 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:10.961971 kubelet[1874]: E1124 00:33:10.961934 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:10.971367 kubelet[1874]: I1124 00:33:10.971333 1874 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-k8qxn" podStartSLOduration=4.666643047 podStartE2EDuration="8.971321251s" podCreationTimestamp="2025-11-24 00:33:02 +0000 UTC" firstStartedPulling="2025-11-24 00:33:04.931409352 +0000 UTC m=+4.196976557" lastFinishedPulling="2025-11-24 00:33:09.236087556 +0000 UTC m=+8.501654761" observedRunningTime="2025-11-24 00:33:10.97110187 +0000 UTC m=+10.236669075" watchObservedRunningTime="2025-11-24 00:33:10.971321251 +0000 UTC m=+10.236888456" Nov 24 00:33:11.101353 systemd-networkd[1449]: flannel.1: Link UP Nov 24 00:33:11.101362 systemd-networkd[1449]: flannel.1: Gained carrier Nov 24 00:33:11.844793 kubelet[1874]: E1124 00:33:11.844722 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:11.964055 kubelet[1874]: E1124 00:33:11.963937 1874 dns.go:154] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 172.232.0.17 172.232.0.16 172.232.0.21" Nov 24 00:33:12.845627 kubelet[1874]: E1124 00:33:12.845575 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:12.928281 systemd-networkd[1449]: flannel.1: Gained IPv6LL Nov 24 00:33:13.846230 kubelet[1874]: E1124 00:33:13.846153 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:14.846594 kubelet[1874]: E1124 00:33:14.846543 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:15.075490 systemd[1]: Created slice kubepods-besteffort-podbfec2c0d_fd39_4208_8835_0e1df248e606.slice - libcontainer container kubepods-besteffort-podbfec2c0d_fd39_4208_8835_0e1df248e606.slice. Nov 24 00:33:15.250531 kubelet[1874]: I1124 00:33:15.250425 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-k69vw\" (UniqueName: \"kubernetes.io/projected/bfec2c0d-fd39-4208-8835-0e1df248e606-kube-api-access-k69vw\") pod \"nginx-deployment-bb8f74bfb-wsqkn\" (UID: \"bfec2c0d-fd39-4208-8835-0e1df248e606\") " pod="default/nginx-deployment-bb8f74bfb-wsqkn" Nov 24 00:33:15.380690 containerd[1551]: time="2025-11-24T00:33:15.380637289Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-wsqkn,Uid:bfec2c0d-fd39-4208-8835-0e1df248e606,Namespace:default,Attempt:0,}" Nov 24 00:33:15.395092 systemd-networkd[1449]: cni0: Link UP Nov 24 00:33:15.395099 systemd-networkd[1449]: cni0: Gained carrier Nov 24 00:33:15.401549 systemd-networkd[1449]: cni0: Lost carrier Nov 24 00:33:15.407353 systemd-networkd[1449]: vethafb7f9c5: Link UP Nov 24 00:33:15.409647 kernel: cni0: port 1(vethafb7f9c5) entered blocking state Nov 24 00:33:15.409712 kernel: cni0: port 1(vethafb7f9c5) entered disabled state Nov 24 00:33:15.410405 kernel: vethafb7f9c5: entered allmulticast mode Nov 24 00:33:15.412356 kernel: vethafb7f9c5: entered promiscuous mode Nov 24 00:33:15.422337 kernel: cni0: port 1(vethafb7f9c5) entered blocking state Nov 24 00:33:15.422386 kernel: cni0: port 1(vethafb7f9c5) entered forwarding state Nov 24 00:33:15.423708 systemd-networkd[1449]: vethafb7f9c5: Gained carrier Nov 24 00:33:15.427269 systemd-networkd[1449]: cni0: Gained carrier Nov 24 00:33:15.431482 containerd[1551]: 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"} Nov 24 00:33:15.431482 containerd[1551]: delegateAdd: netconf sent to delegate plugin: Nov 24 00:33:15.456998 containerd[1551]: {"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="2025-11-24T00:33:15.456959435Z" level=info msg="connecting to shim ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24" address="unix:///run/containerd/s/35f255ca770a351aac80bf4692652f81ff8cef60f2bc08a286ab2c360b9cf295" namespace=k8s.io protocol=ttrpc version=3 Nov 24 00:33:15.484153 systemd[1]: Started cri-containerd-ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24.scope - libcontainer container ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24. Nov 24 00:33:15.533913 containerd[1551]: time="2025-11-24T00:33:15.533710862Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-wsqkn,Uid:bfec2c0d-fd39-4208-8835-0e1df248e606,Namespace:default,Attempt:0,} returns sandbox id \"ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24\"" Nov 24 00:33:15.535132 containerd[1551]: time="2025-11-24T00:33:15.534977893Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 24 00:33:15.847312 kubelet[1874]: E1124 00:33:15.847280 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:16.448187 systemd-networkd[1449]: vethafb7f9c5: Gained IPv6LL Nov 24 00:33:16.832843 systemd-networkd[1449]: cni0: Gained IPv6LL Nov 24 00:33:16.847606 kubelet[1874]: E1124 00:33:16.847572 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:17.173089 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1048919259.mount: Deactivated successfully. Nov 24 00:33:17.848774 kubelet[1874]: E1124 00:33:17.848626 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:18.066390 containerd[1551]: time="2025-11-24T00:33:18.066336364Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:18.067551 containerd[1551]: time="2025-11-24T00:33:18.067377045Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73312526" Nov 24 00:33:18.068255 containerd[1551]: time="2025-11-24T00:33:18.068231266Z" level=info msg="ImageCreate event name:\"sha256:28714d18af1a1a1ad4b147eb6fb9b043fd8aa2eec52556c506b532c251870ee0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:18.070331 containerd[1551]: time="2025-11-24T00:33:18.070303078Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:496d316ce5372257a96d0a8d0c61aabe1665f6760bb61fc1cddd40aa5a6b92da\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:18.071405 containerd[1551]: time="2025-11-24T00:33:18.071381999Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:28714d18af1a1a1ad4b147eb6fb9b043fd8aa2eec52556c506b532c251870ee0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:496d316ce5372257a96d0a8d0c61aabe1665f6760bb61fc1cddd40aa5a6b92da\", size \"73312404\" in 2.536253206s" Nov 24 00:33:18.071488 containerd[1551]: time="2025-11-24T00:33:18.071473049Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:28714d18af1a1a1ad4b147eb6fb9b043fd8aa2eec52556c506b532c251870ee0\"" Nov 24 00:33:18.074424 containerd[1551]: time="2025-11-24T00:33:18.074398152Z" level=info msg="CreateContainer within sandbox \"ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 24 00:33:18.083437 containerd[1551]: time="2025-11-24T00:33:18.082162440Z" level=info msg="Container 79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:18.087501 containerd[1551]: time="2025-11-24T00:33:18.087473435Z" level=info msg="CreateContainer within sandbox \"ef308e82d8e1728dc4980f83a86e2592138fe2716dc2bb0ab494eefcf0630c24\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328\"" Nov 24 00:33:18.087930 containerd[1551]: time="2025-11-24T00:33:18.087908156Z" level=info msg="StartContainer for \"79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328\"" Nov 24 00:33:18.088612 containerd[1551]: time="2025-11-24T00:33:18.088585346Z" level=info msg="connecting to shim 79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328" address="unix:///run/containerd/s/35f255ca770a351aac80bf4692652f81ff8cef60f2bc08a286ab2c360b9cf295" protocol=ttrpc version=3 Nov 24 00:33:18.110154 systemd[1]: Started cri-containerd-79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328.scope - libcontainer container 79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328. Nov 24 00:33:18.141383 containerd[1551]: time="2025-11-24T00:33:18.141058269Z" level=info msg="StartContainer for \"79e76fbc1424cd7b4338a1a6d2bc58495de6b392d4938bd746073ada21eef328\" returns successfully" Nov 24 00:33:18.849930 kubelet[1874]: E1124 00:33:18.849843 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:18.983861 kubelet[1874]: I1124 00:33:18.983797 1874 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-wsqkn" podStartSLOduration=1.446291864 podStartE2EDuration="3.983783651s" podCreationTimestamp="2025-11-24 00:33:15 +0000 UTC" firstStartedPulling="2025-11-24 00:33:15.534769623 +0000 UTC m=+14.800336828" lastFinishedPulling="2025-11-24 00:33:18.07226141 +0000 UTC m=+17.337828615" observedRunningTime="2025-11-24 00:33:18.983475131 +0000 UTC m=+18.249042346" watchObservedRunningTime="2025-11-24 00:33:18.983783651 +0000 UTC m=+18.249350866" Nov 24 00:33:19.850160 kubelet[1874]: E1124 00:33:19.850120 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:20.850962 kubelet[1874]: E1124 00:33:20.850926 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:21.838939 kubelet[1874]: E1124 00:33:21.838900 1874 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:21.851516 kubelet[1874]: E1124 00:33:21.851497 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:22.852219 kubelet[1874]: E1124 00:33:22.852181 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:23.274293 systemd[1]: Created slice kubepods-besteffort-podfabe13b0_bce7_46cc_b500_55aac2d20b01.slice - libcontainer container kubepods-besteffort-podfabe13b0_bce7_46cc_b500_55aac2d20b01.slice. Nov 24 00:33:23.391370 kubelet[1874]: I1124 00:33:23.391306 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-x57x4\" (UniqueName: \"kubernetes.io/projected/fabe13b0-bce7-46cc-b500-55aac2d20b01-kube-api-access-x57x4\") pod \"nfs-server-provisioner-0\" (UID: \"fabe13b0-bce7-46cc-b500-55aac2d20b01\") " pod="default/nfs-server-provisioner-0" Nov 24 00:33:23.391370 kubelet[1874]: I1124 00:33:23.391352 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/fabe13b0-bce7-46cc-b500-55aac2d20b01-data\") pod \"nfs-server-provisioner-0\" (UID: \"fabe13b0-bce7-46cc-b500-55aac2d20b01\") " pod="default/nfs-server-provisioner-0" Nov 24 00:33:23.401143 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Nov 24 00:33:23.579359 containerd[1551]: time="2025-11-24T00:33:23.579295326Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:fabe13b0-bce7-46cc-b500-55aac2d20b01,Namespace:default,Attempt:0,}" Nov 24 00:33:23.594305 systemd-networkd[1449]: veth56621cdc: Link UP Nov 24 00:33:23.598910 kernel: cni0: port 2(veth56621cdc) entered blocking state Nov 24 00:33:23.599088 kernel: cni0: port 2(veth56621cdc) entered disabled state Nov 24 00:33:23.599111 kernel: veth56621cdc: entered allmulticast mode Nov 24 00:33:23.601970 kernel: veth56621cdc: entered promiscuous mode Nov 24 00:33:23.611836 kernel: cni0: port 2(veth56621cdc) entered blocking state Nov 24 00:33:23.611868 kernel: cni0: port 2(veth56621cdc) entered forwarding state Nov 24 00:33:23.611929 systemd-networkd[1449]: veth56621cdc: Gained carrier Nov 24 00:33:23.616147 containerd[1551]: 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)(0xc000084950), "name":"cbr0", "type":"bridge"} Nov 24 00:33:23.616147 containerd[1551]: delegateAdd: netconf sent to delegate plugin: Nov 24 00:33:23.640635 containerd[1551]: {"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="2025-11-24T00:33:23.640571357Z" level=info msg="connecting to shim dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f" address="unix:///run/containerd/s/4bd2436b234e8cc454beaaa320b6e4b93f09b748568e10d47c0e2502ee5a071d" namespace=k8s.io protocol=ttrpc version=3 Nov 24 00:33:23.667157 systemd[1]: Started cri-containerd-dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f.scope - libcontainer container dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f. Nov 24 00:33:23.713186 containerd[1551]: time="2025-11-24T00:33:23.713144989Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:fabe13b0-bce7-46cc-b500-55aac2d20b01,Namespace:default,Attempt:0,} returns sandbox id \"dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f\"" Nov 24 00:33:23.714725 containerd[1551]: time="2025-11-24T00:33:23.714703841Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 24 00:33:23.853333 kubelet[1874]: E1124 00:33:23.853228 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:24.854048 kubelet[1874]: E1124 00:33:24.854000 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:25.472422 systemd-networkd[1449]: veth56621cdc: Gained IPv6LL Nov 24 00:33:25.855913 kubelet[1874]: E1124 00:33:25.855882 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:25.861754 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3118508965.mount: Deactivated successfully. Nov 24 00:33:26.857713 kubelet[1874]: E1124 00:33:26.857591 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:27.706635 containerd[1551]: time="2025-11-24T00:33:27.705920123Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:27.708730 containerd[1551]: time="2025-11-24T00:33:27.708711781Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Nov 24 00:33:27.709179 containerd[1551]: time="2025-11-24T00:33:27.709160231Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:27.712303 containerd[1551]: time="2025-11-24T00:33:27.712254318Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:27.713075 containerd[1551]: time="2025-11-24T00:33:27.712837287Z" 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.998108076s" Nov 24 00:33:27.713075 containerd[1551]: time="2025-11-24T00:33:27.712865047Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Nov 24 00:33:27.717097 containerd[1551]: time="2025-11-24T00:33:27.717078042Z" level=info msg="CreateContainer within sandbox \"dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 24 00:33:27.727456 containerd[1551]: time="2025-11-24T00:33:27.727436623Z" level=info msg="Container 1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:27.731291 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1390745308.mount: Deactivated successfully. Nov 24 00:33:27.736867 containerd[1551]: time="2025-11-24T00:33:27.736834593Z" level=info msg="CreateContainer within sandbox \"dbd8fcfcb91c2bb74c87a311d9500cfc8dde09e04ef1646e6a1f94aae54d501f\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30\"" Nov 24 00:33:27.738221 containerd[1551]: time="2025-11-24T00:33:27.737693852Z" level=info msg="StartContainer for \"1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30\"" Nov 24 00:33:27.739545 containerd[1551]: time="2025-11-24T00:33:27.739427091Z" level=info msg="connecting to shim 1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30" address="unix:///run/containerd/s/4bd2436b234e8cc454beaaa320b6e4b93f09b748568e10d47c0e2502ee5a071d" protocol=ttrpc version=3 Nov 24 00:33:27.769220 systemd[1]: Started cri-containerd-1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30.scope - libcontainer container 1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30. Nov 24 00:33:27.818449 containerd[1551]: time="2025-11-24T00:33:27.818288664Z" level=info msg="StartContainer for \"1a5ac40181359bebb2e4783d8f11193e40b87eb9d9e86098d2aba8768f858a30\" returns successfully" Nov 24 00:33:27.859054 kubelet[1874]: E1124 00:33:27.858987 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:28.007714 kubelet[1874]: I1124 00:33:28.007197 1874 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.007236124 podStartE2EDuration="5.007181039s" podCreationTimestamp="2025-11-24 00:33:23 +0000 UTC" firstStartedPulling="2025-11-24 00:33:23.714377201 +0000 UTC m=+22.979944406" lastFinishedPulling="2025-11-24 00:33:27.714322116 +0000 UTC m=+26.979889321" observedRunningTime="2025-11-24 00:33:28.006887028 +0000 UTC m=+27.272454233" watchObservedRunningTime="2025-11-24 00:33:28.007181039 +0000 UTC m=+27.272748254" Nov 24 00:33:28.860149 kubelet[1874]: E1124 00:33:28.860107 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:29.860523 kubelet[1874]: E1124 00:33:29.860473 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:30.860804 kubelet[1874]: E1124 00:33:30.860750 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:31.861178 kubelet[1874]: E1124 00:33:31.861139 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:32.861629 kubelet[1874]: E1124 00:33:32.861586 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:33.046373 systemd[1]: Created slice kubepods-besteffort-pod74d8f44e_c8e7_4a44_bc91_4cffb22f2082.slice - libcontainer container kubepods-besteffort-pod74d8f44e_c8e7_4a44_bc91_4cffb22f2082.slice. Nov 24 00:33:33.142519 kubelet[1874]: I1124 00:33:33.142406 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-339afd7c-fedb-452f-a9b5-58dbca9fb37e\" (UniqueName: \"kubernetes.io/nfs/74d8f44e-c8e7-4a44-bc91-4cffb22f2082-pvc-339afd7c-fedb-452f-a9b5-58dbca9fb37e\") pod \"test-pod-1\" (UID: \"74d8f44e-c8e7-4a44-bc91-4cffb22f2082\") " pod="default/test-pod-1" Nov 24 00:33:33.142940 kubelet[1874]: I1124 00:33:33.142648 1874 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2h6tz\" (UniqueName: \"kubernetes.io/projected/74d8f44e-c8e7-4a44-bc91-4cffb22f2082-kube-api-access-2h6tz\") pod \"test-pod-1\" (UID: \"74d8f44e-c8e7-4a44-bc91-4cffb22f2082\") " pod="default/test-pod-1" Nov 24 00:33:33.282065 kernel: netfs: FS-Cache loaded Nov 24 00:33:33.335383 kernel: RPC: Registered named UNIX socket transport module. Nov 24 00:33:33.335436 kernel: RPC: Registered udp transport module. Nov 24 00:33:33.337714 kernel: RPC: Registered tcp transport module. Nov 24 00:33:33.337741 kernel: RPC: Registered tcp-with-tls transport module. Nov 24 00:33:33.340083 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 24 00:33:33.541870 kernel: NFS: Registering the id_resolver key type Nov 24 00:33:33.541926 kernel: Key type id_resolver registered Nov 24 00:33:33.541946 kernel: Key type id_legacy registered Nov 24 00:33:33.567821 nfsidmap[2856]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 24 00:33:33.569112 nfsidmap[2856]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 24 00:33:33.572196 nfsidmap[2857]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 24 00:33:33.572408 nfsidmap[2857]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 24 00:33:33.581973 nfsrahead[2860]: setting /var/lib/kubelet/pods/74d8f44e-c8e7-4a44-bc91-4cffb22f2082/volumes/kubernetes.io~nfs/pvc-339afd7c-fedb-452f-a9b5-58dbca9fb37e readahead to 128 Nov 24 00:33:33.652553 containerd[1551]: time="2025-11-24T00:33:33.652499928Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:74d8f44e-c8e7-4a44-bc91-4cffb22f2082,Namespace:default,Attempt:0,}" Nov 24 00:33:33.665539 systemd-networkd[1449]: veth263f81a3: Link UP Nov 24 00:33:33.669993 kernel: cni0: port 3(veth263f81a3) entered blocking state Nov 24 00:33:33.670068 kernel: cni0: port 3(veth263f81a3) entered disabled state Nov 24 00:33:33.672314 kernel: veth263f81a3: entered allmulticast mode Nov 24 00:33:33.672350 kernel: veth263f81a3: entered promiscuous mode Nov 24 00:33:33.683365 kernel: cni0: port 3(veth263f81a3) entered blocking state Nov 24 00:33:33.683392 kernel: cni0: port 3(veth263f81a3) entered forwarding state Nov 24 00:33:33.683146 systemd-networkd[1449]: veth263f81a3: Gained carrier Nov 24 00:33:33.684871 containerd[1551]: 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)(0xc0000a2950), "name":"cbr0", "type":"bridge"} Nov 24 00:33:33.684871 containerd[1551]: delegateAdd: netconf sent to delegate plugin: Nov 24 00:33:33.703514 containerd[1551]: {"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="2025-11-24T00:33:33.703484820Z" level=info msg="connecting to shim 1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e" address="unix:///run/containerd/s/c8f39ada40e9d42d7d735c41f6e45ffd411af1111a90f6f3e9651cad9591babe" namespace=k8s.io protocol=ttrpc version=3 Nov 24 00:33:33.729237 systemd[1]: Started cri-containerd-1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e.scope - libcontainer container 1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e. Nov 24 00:33:33.775698 containerd[1551]: time="2025-11-24T00:33:33.775662065Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:74d8f44e-c8e7-4a44-bc91-4cffb22f2082,Namespace:default,Attempt:0,} returns sandbox id \"1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e\"" Nov 24 00:33:33.776776 containerd[1551]: time="2025-11-24T00:33:33.776731664Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 24 00:33:33.862343 kubelet[1874]: E1124 00:33:33.862177 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:33.942076 containerd[1551]: time="2025-11-24T00:33:33.940713488Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 24 00:33:33.942076 containerd[1551]: time="2025-11-24T00:33:33.941224407Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Nov 24 00:33:33.944648 containerd[1551]: time="2025-11-24T00:33:33.944608836Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:28714d18af1a1a1ad4b147eb6fb9b043fd8aa2eec52556c506b532c251870ee0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:496d316ce5372257a96d0a8d0c61aabe1665f6760bb61fc1cddd40aa5a6b92da\", size \"73312404\" in 167.812292ms" Nov 24 00:33:33.944648 containerd[1551]: time="2025-11-24T00:33:33.944638016Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:28714d18af1a1a1ad4b147eb6fb9b043fd8aa2eec52556c506b532c251870ee0\"" Nov 24 00:33:33.948139 containerd[1551]: time="2025-11-24T00:33:33.948089465Z" level=info msg="CreateContainer within sandbox \"1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 24 00:33:33.954591 containerd[1551]: time="2025-11-24T00:33:33.954515993Z" level=info msg="Container a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da: CDI devices from CRI Config.CDIDevices: []" Nov 24 00:33:33.959792 containerd[1551]: time="2025-11-24T00:33:33.959747191Z" level=info msg="CreateContainer within sandbox \"1ef498f3a3f06b0e40d61bea2995e89931c4cf69ece9cd27fdeb2c857607692e\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da\"" Nov 24 00:33:33.960480 containerd[1551]: time="2025-11-24T00:33:33.960363620Z" level=info msg="StartContainer for \"a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da\"" Nov 24 00:33:33.961320 containerd[1551]: time="2025-11-24T00:33:33.961300410Z" level=info msg="connecting to shim a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da" address="unix:///run/containerd/s/c8f39ada40e9d42d7d735c41f6e45ffd411af1111a90f6f3e9651cad9591babe" protocol=ttrpc version=3 Nov 24 00:33:33.984168 systemd[1]: Started cri-containerd-a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da.scope - libcontainer container a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da. Nov 24 00:33:34.018703 containerd[1551]: time="2025-11-24T00:33:34.018660142Z" level=info msg="StartContainer for \"a2385f2476760fd2e976f22e5f44b2dc5c49d59077d1da5d47e6057258eae9da\" returns successfully" Nov 24 00:33:34.863350 kubelet[1874]: E1124 00:33:34.863267 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:34.880267 systemd-networkd[1449]: veth263f81a3: Gained IPv6LL Nov 24 00:33:35.023289 kubelet[1874]: I1124 00:33:35.023252 1874 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=10.854354388 podStartE2EDuration="11.02324203s" podCreationTimestamp="2025-11-24 00:33:24 +0000 UTC" firstStartedPulling="2025-11-24 00:33:33.776311844 +0000 UTC m=+33.041879049" lastFinishedPulling="2025-11-24 00:33:33.945199486 +0000 UTC m=+33.210766691" observedRunningTime="2025-11-24 00:33:35.02309996 +0000 UTC m=+34.288667175" watchObservedRunningTime="2025-11-24 00:33:35.02324203 +0000 UTC m=+34.288809245" Nov 24 00:33:35.864183 kubelet[1874]: E1124 00:33:35.864154 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:36.864720 kubelet[1874]: E1124 00:33:36.864696 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 24 00:33:37.418622 update_engine[1529]: I20251124 00:33:37.418550 1529 update_attempter.cc:509] Updating boot flags... Nov 24 00:33:37.864899 kubelet[1874]: E1124 00:33:37.864789 1874 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"