Jul 11 00:22:03.401047 kernel: Linux version 6.6.96-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Thu Jul 10 22:46:23 -00 2025 Jul 11 00:22:03.401077 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=836a88100946313ecc17069f63287f86e7d91f7c389df4bcd3f3e02beb9683e1 Jul 11 00:22:03.401088 kernel: BIOS-provided physical RAM map: Jul 11 00:22:03.401095 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jul 11 00:22:03.401101 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Jul 11 00:22:03.401107 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Jul 11 00:22:03.401114 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Jul 11 00:22:03.401120 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Jul 11 00:22:03.401127 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Jul 11 00:22:03.401133 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Jul 11 00:22:03.401142 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Jul 11 00:22:03.401148 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Jul 11 00:22:03.401157 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Jul 11 00:22:03.401164 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Jul 11 00:22:03.401174 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Jul 11 00:22:03.401181 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Jul 11 00:22:03.401190 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Jul 11 00:22:03.401197 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Jul 11 00:22:03.401204 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Jul 11 00:22:03.401210 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jul 11 00:22:03.401217 kernel: NX (Execute Disable) protection: active Jul 11 00:22:03.401224 kernel: APIC: Static calls initialized Jul 11 00:22:03.401230 kernel: efi: EFI v2.7 by EDK II Jul 11 00:22:03.401237 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b675198 Jul 11 00:22:03.401244 kernel: SMBIOS 2.8 present. Jul 11 00:22:03.401250 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Jul 11 00:22:03.401257 kernel: Hypervisor detected: KVM Jul 11 00:22:03.401267 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 11 00:22:03.401273 kernel: kvm-clock: using sched offset of 6451980401 cycles Jul 11 00:22:03.401280 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 11 00:22:03.401288 kernel: tsc: Detected 2794.746 MHz processor Jul 11 00:22:03.401295 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 11 00:22:03.401302 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 11 00:22:03.401309 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x400000000 Jul 11 00:22:03.401316 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jul 11 00:22:03.401323 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 11 00:22:03.401332 kernel: Using GB pages for direct mapping Jul 11 00:22:03.401347 kernel: Secure boot disabled Jul 11 00:22:03.401354 kernel: ACPI: Early table checksum verification disabled Jul 11 00:22:03.401361 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Jul 11 00:22:03.401372 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Jul 11 00:22:03.401380 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401388 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401397 kernel: ACPI: FACS 0x000000009CBDD000 000040 Jul 11 00:22:03.401405 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401414 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401421 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401429 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 11 00:22:03.401436 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Jul 11 00:22:03.401443 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Jul 11 00:22:03.401453 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Jul 11 00:22:03.401460 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Jul 11 00:22:03.401467 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Jul 11 00:22:03.401474 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Jul 11 00:22:03.401481 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Jul 11 00:22:03.401488 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Jul 11 00:22:03.401495 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Jul 11 00:22:03.401502 kernel: No NUMA configuration found Jul 11 00:22:03.401512 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Jul 11 00:22:03.401521 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Jul 11 00:22:03.401528 kernel: Zone ranges: Jul 11 00:22:03.401536 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 11 00:22:03.401543 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Jul 11 00:22:03.401550 kernel: Normal empty Jul 11 00:22:03.401557 kernel: Movable zone start for each node Jul 11 00:22:03.401564 kernel: Early memory node ranges Jul 11 00:22:03.401571 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jul 11 00:22:03.401578 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Jul 11 00:22:03.401585 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Jul 11 00:22:03.401595 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Jul 11 00:22:03.401602 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Jul 11 00:22:03.401609 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Jul 11 00:22:03.401619 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Jul 11 00:22:03.401626 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 11 00:22:03.401633 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jul 11 00:22:03.401640 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Jul 11 00:22:03.401647 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 11 00:22:03.401654 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Jul 11 00:22:03.401664 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Jul 11 00:22:03.401672 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Jul 11 00:22:03.401679 kernel: ACPI: PM-Timer IO Port: 0x608 Jul 11 00:22:03.401686 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 11 00:22:03.401693 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 11 00:22:03.401700 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 11 00:22:03.401707 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 11 00:22:03.401714 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 11 00:22:03.401733 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 11 00:22:03.401743 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 11 00:22:03.401750 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 11 00:22:03.401757 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 11 00:22:03.401764 kernel: TSC deadline timer available Jul 11 00:22:03.401771 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Jul 11 00:22:03.401779 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 11 00:22:03.401786 kernel: kvm-guest: KVM setup pv remote TLB flush Jul 11 00:22:03.401793 kernel: kvm-guest: setup PV sched yield Jul 11 00:22:03.401800 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Jul 11 00:22:03.401809 kernel: Booting paravirtualized kernel on KVM Jul 11 00:22:03.401817 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 11 00:22:03.401827 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 11 00:22:03.401836 kernel: percpu: Embedded 58 pages/cpu s197096 r8192 d32280 u524288 Jul 11 00:22:03.401844 kernel: pcpu-alloc: s197096 r8192 d32280 u524288 alloc=1*2097152 Jul 11 00:22:03.401853 kernel: pcpu-alloc: [0] 0 1 2 3 Jul 11 00:22:03.401862 kernel: kvm-guest: PV spinlocks enabled Jul 11 00:22:03.401871 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 11 00:22:03.401882 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=836a88100946313ecc17069f63287f86e7d91f7c389df4bcd3f3e02beb9683e1 Jul 11 00:22:03.401899 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 11 00:22:03.401906 kernel: random: crng init done Jul 11 00:22:03.401913 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 11 00:22:03.401921 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 11 00:22:03.401928 kernel: Fallback order for Node 0: 0 Jul 11 00:22:03.401935 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Jul 11 00:22:03.401942 kernel: Policy zone: DMA32 Jul 11 00:22:03.401949 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 11 00:22:03.401959 kernel: Memory: 2400600K/2567000K available (12288K kernel code, 2295K rwdata, 22744K rodata, 42872K init, 2320K bss, 166140K reserved, 0K cma-reserved) Jul 11 00:22:03.401967 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 11 00:22:03.401974 kernel: ftrace: allocating 37966 entries in 149 pages Jul 11 00:22:03.401981 kernel: ftrace: allocated 149 pages with 4 groups Jul 11 00:22:03.401989 kernel: Dynamic Preempt: voluntary Jul 11 00:22:03.402004 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 11 00:22:03.402014 kernel: rcu: RCU event tracing is enabled. Jul 11 00:22:03.402022 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 11 00:22:03.402031 kernel: Trampoline variant of Tasks RCU enabled. Jul 11 00:22:03.402047 kernel: Rude variant of Tasks RCU enabled. Jul 11 00:22:03.402059 kernel: Tracing variant of Tasks RCU enabled. Jul 11 00:22:03.402070 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 11 00:22:03.402085 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 11 00:22:03.402095 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jul 11 00:22:03.402109 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 11 00:22:03.402117 kernel: Console: colour dummy device 80x25 Jul 11 00:22:03.402124 kernel: printk: console [ttyS0] enabled Jul 11 00:22:03.402134 kernel: ACPI: Core revision 20230628 Jul 11 00:22:03.402142 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 11 00:22:03.402150 kernel: APIC: Switch to symmetric I/O mode setup Jul 11 00:22:03.402157 kernel: x2apic enabled Jul 11 00:22:03.402165 kernel: APIC: Switched APIC routing to: physical x2apic Jul 11 00:22:03.402172 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jul 11 00:22:03.402180 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jul 11 00:22:03.402187 kernel: kvm-guest: setup PV IPIs Jul 11 00:22:03.402195 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 11 00:22:03.402205 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Jul 11 00:22:03.402215 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794746) Jul 11 00:22:03.402225 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 11 00:22:03.402235 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jul 11 00:22:03.402246 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jul 11 00:22:03.402256 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 11 00:22:03.402265 kernel: Spectre V2 : Mitigation: Retpolines Jul 11 00:22:03.402275 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 11 00:22:03.402285 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jul 11 00:22:03.402299 kernel: RETBleed: Mitigation: untrained return thunk Jul 11 00:22:03.402309 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jul 11 00:22:03.402319 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jul 11 00:22:03.402328 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jul 11 00:22:03.402348 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jul 11 00:22:03.402357 kernel: x86/bugs: return thunk changed Jul 11 00:22:03.402365 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jul 11 00:22:03.402372 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 11 00:22:03.402383 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 11 00:22:03.402390 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 11 00:22:03.402398 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 11 00:22:03.402405 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jul 11 00:22:03.402413 kernel: Freeing SMP alternatives memory: 32K Jul 11 00:22:03.402420 kernel: pid_max: default: 32768 minimum: 301 Jul 11 00:22:03.402430 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jul 11 00:22:03.402446 kernel: landlock: Up and running. Jul 11 00:22:03.402456 kernel: SELinux: Initializing. Jul 11 00:22:03.402469 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 11 00:22:03.402479 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 11 00:22:03.402489 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jul 11 00:22:03.402498 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 11 00:22:03.402507 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 11 00:22:03.402517 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 11 00:22:03.402527 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jul 11 00:22:03.402537 kernel: ... version: 0 Jul 11 00:22:03.402547 kernel: ... bit width: 48 Jul 11 00:22:03.402560 kernel: ... generic registers: 6 Jul 11 00:22:03.402569 kernel: ... value mask: 0000ffffffffffff Jul 11 00:22:03.402576 kernel: ... max period: 00007fffffffffff Jul 11 00:22:03.402584 kernel: ... fixed-purpose events: 0 Jul 11 00:22:03.402591 kernel: ... event mask: 000000000000003f Jul 11 00:22:03.402599 kernel: signal: max sigframe size: 1776 Jul 11 00:22:03.402606 kernel: rcu: Hierarchical SRCU implementation. Jul 11 00:22:03.402614 kernel: rcu: Max phase no-delay instances is 400. Jul 11 00:22:03.402622 kernel: smp: Bringing up secondary CPUs ... Jul 11 00:22:03.402632 kernel: smpboot: x86: Booting SMP configuration: Jul 11 00:22:03.402639 kernel: .... node #0, CPUs: #1 #2 #3 Jul 11 00:22:03.402647 kernel: smp: Brought up 1 node, 4 CPUs Jul 11 00:22:03.402655 kernel: smpboot: Max logical packages: 1 Jul 11 00:22:03.402662 kernel: smpboot: Total of 4 processors activated (22357.96 BogoMIPS) Jul 11 00:22:03.402670 kernel: devtmpfs: initialized Jul 11 00:22:03.402677 kernel: x86/mm: Memory block size: 128MB Jul 11 00:22:03.402685 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Jul 11 00:22:03.402693 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Jul 11 00:22:03.402703 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Jul 11 00:22:03.402710 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Jul 11 00:22:03.402742 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Jul 11 00:22:03.402750 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 11 00:22:03.402757 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 11 00:22:03.402766 kernel: pinctrl core: initialized pinctrl subsystem Jul 11 00:22:03.402776 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 11 00:22:03.402785 kernel: audit: initializing netlink subsys (disabled) Jul 11 00:22:03.402795 kernel: audit: type=2000 audit(1752193321.076:1): state=initialized audit_enabled=0 res=1 Jul 11 00:22:03.402809 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 11 00:22:03.402819 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 11 00:22:03.402829 kernel: cpuidle: using governor menu Jul 11 00:22:03.402838 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 11 00:22:03.402848 kernel: dca service started, version 1.12.1 Jul 11 00:22:03.402858 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jul 11 00:22:03.402868 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jul 11 00:22:03.402878 kernel: PCI: Using configuration type 1 for base access Jul 11 00:22:03.402886 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 11 00:22:03.402896 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 11 00:22:03.402904 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 11 00:22:03.402911 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 11 00:22:03.402919 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 11 00:22:03.402926 kernel: ACPI: Added _OSI(Module Device) Jul 11 00:22:03.402934 kernel: ACPI: Added _OSI(Processor Device) Jul 11 00:22:03.402944 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 11 00:22:03.402954 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 11 00:22:03.402962 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jul 11 00:22:03.402972 kernel: ACPI: Interpreter enabled Jul 11 00:22:03.402979 kernel: ACPI: PM: (supports S0 S3 S5) Jul 11 00:22:03.402987 kernel: ACPI: Using IOAPIC for interrupt routing Jul 11 00:22:03.402995 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 11 00:22:03.403002 kernel: PCI: Using E820 reservations for host bridge windows Jul 11 00:22:03.403010 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jul 11 00:22:03.403017 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 11 00:22:03.403273 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 11 00:22:03.403431 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jul 11 00:22:03.403557 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jul 11 00:22:03.403570 kernel: PCI host bridge to bus 0000:00 Jul 11 00:22:03.403767 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 11 00:22:03.403885 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 11 00:22:03.403998 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 11 00:22:03.404111 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Jul 11 00:22:03.404229 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jul 11 00:22:03.404365 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Jul 11 00:22:03.404489 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 11 00:22:03.404662 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jul 11 00:22:03.404857 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Jul 11 00:22:03.404997 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] Jul 11 00:22:03.405257 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xc1044000-0xc1044fff] Jul 11 00:22:03.405433 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] Jul 11 00:22:03.405688 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Jul 11 00:22:03.405841 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 11 00:22:03.406000 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Jul 11 00:22:03.406132 kernel: pci 0000:00:02.0: reg 0x10: [io 0x6100-0x611f] Jul 11 00:22:03.406264 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xc1043000-0xc1043fff] Jul 11 00:22:03.406414 kernel: pci 0000:00:02.0: reg 0x20: [mem 0x800000000-0x800003fff 64bit pref] Jul 11 00:22:03.406567 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Jul 11 00:22:03.406700 kernel: pci 0000:00:03.0: reg 0x10: [io 0x6000-0x607f] Jul 11 00:22:03.406848 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xc1042000-0xc1042fff] Jul 11 00:22:03.406982 kernel: pci 0000:00:03.0: reg 0x20: [mem 0x800004000-0x800007fff 64bit pref] Jul 11 00:22:03.407263 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Jul 11 00:22:03.407420 kernel: pci 0000:00:04.0: reg 0x10: [io 0x60e0-0x60ff] Jul 11 00:22:03.407605 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xc1041000-0xc1041fff] Jul 11 00:22:03.407776 kernel: pci 0000:00:04.0: reg 0x20: [mem 0x800008000-0x80000bfff 64bit pref] Jul 11 00:22:03.407904 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] Jul 11 00:22:03.408094 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jul 11 00:22:03.408223 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jul 11 00:22:03.408448 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jul 11 00:22:03.408589 kernel: pci 0000:00:1f.2: reg 0x20: [io 0x60c0-0x60df] Jul 11 00:22:03.408731 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xc1040000-0xc1040fff] Jul 11 00:22:03.408887 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jul 11 00:22:03.409012 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x6080-0x60bf] Jul 11 00:22:03.409022 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 11 00:22:03.409031 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 11 00:22:03.409039 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 11 00:22:03.409047 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 11 00:22:03.409060 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jul 11 00:22:03.409068 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jul 11 00:22:03.409076 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jul 11 00:22:03.409084 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jul 11 00:22:03.409092 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jul 11 00:22:03.409099 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jul 11 00:22:03.409107 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jul 11 00:22:03.409115 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jul 11 00:22:03.409122 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jul 11 00:22:03.409133 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jul 11 00:22:03.409140 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jul 11 00:22:03.409148 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jul 11 00:22:03.409156 kernel: iommu: Default domain type: Translated Jul 11 00:22:03.409163 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 11 00:22:03.409172 kernel: efivars: Registered efivars operations Jul 11 00:22:03.409179 kernel: PCI: Using ACPI for IRQ routing Jul 11 00:22:03.409187 kernel: PCI: pci_cache_line_size set to 64 bytes Jul 11 00:22:03.409195 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Jul 11 00:22:03.409205 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Jul 11 00:22:03.409212 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Jul 11 00:22:03.409220 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Jul 11 00:22:03.409355 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jul 11 00:22:03.409479 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jul 11 00:22:03.409688 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 11 00:22:03.409737 kernel: vgaarb: loaded Jul 11 00:22:03.409747 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 11 00:22:03.409755 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 11 00:22:03.409768 kernel: clocksource: Switched to clocksource kvm-clock Jul 11 00:22:03.409776 kernel: VFS: Disk quotas dquot_6.6.0 Jul 11 00:22:03.409784 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 11 00:22:03.409792 kernel: pnp: PnP ACPI init Jul 11 00:22:03.409958 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Jul 11 00:22:03.409971 kernel: pnp: PnP ACPI: found 6 devices Jul 11 00:22:03.409979 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 11 00:22:03.409987 kernel: NET: Registered PF_INET protocol family Jul 11 00:22:03.409999 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 11 00:22:03.410007 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 11 00:22:03.410015 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 11 00:22:03.410023 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 11 00:22:03.410032 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 11 00:22:03.410040 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 11 00:22:03.410048 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 11 00:22:03.410056 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 11 00:22:03.410064 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 11 00:22:03.410075 kernel: NET: Registered PF_XDP protocol family Jul 11 00:22:03.410201 kernel: pci 0000:00:04.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window Jul 11 00:22:03.410327 kernel: pci 0000:00:04.0: BAR 6: assigned [mem 0x9d000000-0x9d03ffff pref] Jul 11 00:22:03.410454 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 11 00:22:03.410581 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 11 00:22:03.410807 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 11 00:22:03.410952 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Jul 11 00:22:03.411065 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jul 11 00:22:03.411181 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Jul 11 00:22:03.411191 kernel: PCI: CLS 0 bytes, default 64 Jul 11 00:22:03.411200 kernel: Initialise system trusted keyrings Jul 11 00:22:03.411208 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 11 00:22:03.411216 kernel: Key type asymmetric registered Jul 11 00:22:03.411223 kernel: Asymmetric key parser 'x509' registered Jul 11 00:22:03.411231 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jul 11 00:22:03.411239 kernel: io scheduler mq-deadline registered Jul 11 00:22:03.411247 kernel: io scheduler kyber registered Jul 11 00:22:03.411258 kernel: io scheduler bfq registered Jul 11 00:22:03.411266 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 11 00:22:03.411276 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jul 11 00:22:03.411286 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jul 11 00:22:03.411295 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jul 11 00:22:03.411305 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 11 00:22:03.411315 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 11 00:22:03.411324 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 11 00:22:03.411334 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 11 00:22:03.411358 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 11 00:22:03.411531 kernel: rtc_cmos 00:04: RTC can wake from S4 Jul 11 00:22:03.411545 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jul 11 00:22:03.411670 kernel: rtc_cmos 00:04: registered as rtc0 Jul 11 00:22:03.411809 kernel: rtc_cmos 00:04: setting system clock to 2025-07-11T00:22:02 UTC (1752193322) Jul 11 00:22:03.411924 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Jul 11 00:22:03.411934 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jul 11 00:22:03.411944 kernel: efifb: probing for efifb Jul 11 00:22:03.411959 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Jul 11 00:22:03.411967 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Jul 11 00:22:03.411974 kernel: efifb: scrolling: redraw Jul 11 00:22:03.411982 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Jul 11 00:22:03.411990 kernel: Console: switching to colour frame buffer device 100x37 Jul 11 00:22:03.411998 kernel: fb0: EFI VGA frame buffer device Jul 11 00:22:03.412023 kernel: pstore: Using crash dump compression: deflate Jul 11 00:22:03.412033 kernel: pstore: Registered efi_pstore as persistent store backend Jul 11 00:22:03.412041 kernel: NET: Registered PF_INET6 protocol family Jul 11 00:22:03.412051 kernel: Segment Routing with IPv6 Jul 11 00:22:03.412059 kernel: In-situ OAM (IOAM) with IPv6 Jul 11 00:22:03.412068 kernel: NET: Registered PF_PACKET protocol family Jul 11 00:22:03.412076 kernel: Key type dns_resolver registered Jul 11 00:22:03.412084 kernel: IPI shorthand broadcast: enabled Jul 11 00:22:03.412092 kernel: sched_clock: Marking stable (1610002575, 477594113)->(2224954354, -137357666) Jul 11 00:22:03.412100 kernel: registered taskstats version 1 Jul 11 00:22:03.412108 kernel: Loading compiled-in X.509 certificates Jul 11 00:22:03.412116 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.96-flatcar: 5956f0842928c96096c398e9db55919cd236a39f' Jul 11 00:22:03.412127 kernel: Key type .fscrypt registered Jul 11 00:22:03.412135 kernel: Key type fscrypt-provisioning registered Jul 11 00:22:03.412143 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 11 00:22:03.412151 kernel: ima: Allocated hash algorithm: sha1 Jul 11 00:22:03.412159 kernel: ima: No architecture policies found Jul 11 00:22:03.412167 kernel: clk: Disabling unused clocks Jul 11 00:22:03.412175 kernel: Freeing unused kernel image (initmem) memory: 42872K Jul 11 00:22:03.412183 kernel: Write protecting the kernel read-only data: 36864k Jul 11 00:22:03.412194 kernel: Freeing unused kernel image (rodata/data gap) memory: 1832K Jul 11 00:22:03.412202 kernel: Run /init as init process Jul 11 00:22:03.412210 kernel: with arguments: Jul 11 00:22:03.412218 kernel: /init Jul 11 00:22:03.412225 kernel: with environment: Jul 11 00:22:03.412233 kernel: HOME=/ Jul 11 00:22:03.412241 kernel: TERM=linux Jul 11 00:22:03.412249 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 11 00:22:03.412259 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 11 00:22:03.412272 systemd[1]: Detected virtualization kvm. Jul 11 00:22:03.412281 systemd[1]: Detected architecture x86-64. Jul 11 00:22:03.412289 systemd[1]: Running in initrd. Jul 11 00:22:03.412298 systemd[1]: No hostname configured, using default hostname. Jul 11 00:22:03.412306 systemd[1]: Hostname set to . Jul 11 00:22:03.412318 systemd[1]: Initializing machine ID from VM UUID. Jul 11 00:22:03.412326 systemd[1]: Queued start job for default target initrd.target. Jul 11 00:22:03.412343 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 11 00:22:03.412352 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 11 00:22:03.412361 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 11 00:22:03.412371 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 11 00:22:03.412379 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 11 00:22:03.412390 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 11 00:22:03.412401 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 11 00:22:03.412410 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 11 00:22:03.412418 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 11 00:22:03.412427 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 11 00:22:03.412435 systemd[1]: Reached target paths.target - Path Units. Jul 11 00:22:03.412443 systemd[1]: Reached target slices.target - Slice Units. Jul 11 00:22:03.412454 systemd[1]: Reached target swap.target - Swaps. Jul 11 00:22:03.412463 systemd[1]: Reached target timers.target - Timer Units. Jul 11 00:22:03.412471 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 11 00:22:03.412480 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 11 00:22:03.412488 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 11 00:22:03.412497 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jul 11 00:22:03.412505 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 11 00:22:03.412514 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 11 00:22:03.412522 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 11 00:22:03.412533 systemd[1]: Reached target sockets.target - Socket Units. Jul 11 00:22:03.412542 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 11 00:22:03.412550 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 11 00:22:03.412558 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 11 00:22:03.412567 systemd[1]: Starting systemd-fsck-usr.service... Jul 11 00:22:03.412575 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 11 00:22:03.412584 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 11 00:22:03.412592 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:03.412603 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 11 00:22:03.412611 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 11 00:22:03.412620 systemd[1]: Finished systemd-fsck-usr.service. Jul 11 00:22:03.412629 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 11 00:22:03.412660 systemd-journald[194]: Collecting audit messages is disabled. Jul 11 00:22:03.412684 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:03.412693 systemd-journald[194]: Journal started Jul 11 00:22:03.412713 systemd-journald[194]: Runtime Journal (/run/log/journal/890e1aa6be45452b9cc7205b9f62428c) is 6.0M, max 48.3M, 42.2M free. Jul 11 00:22:03.407795 systemd-modules-load[195]: Inserted module 'overlay' Jul 11 00:22:03.509276 systemd[1]: Started systemd-journald.service - Journal Service. Jul 11 00:22:03.509714 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 11 00:22:03.516752 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 11 00:22:03.519935 systemd-modules-load[195]: Inserted module 'br_netfilter' Jul 11 00:22:03.521071 kernel: Bridge firewalling registered Jul 11 00:22:03.524989 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 11 00:22:03.527446 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 11 00:22:03.530441 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 11 00:22:03.533522 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 11 00:22:03.541900 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 11 00:22:03.544501 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 11 00:22:03.646248 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 11 00:22:03.657268 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 11 00:22:03.660273 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 11 00:22:03.671320 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 11 00:22:03.679096 dracut-cmdline[227]: dracut-dracut-053 Jul 11 00:22:03.681918 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 11 00:22:03.685215 dracut-cmdline[227]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=836a88100946313ecc17069f63287f86e7d91f7c389df4bcd3f3e02beb9683e1 Jul 11 00:22:03.822066 systemd-resolved[234]: Positive Trust Anchors: Jul 11 00:22:03.822098 systemd-resolved[234]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 11 00:22:03.822141 systemd-resolved[234]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 11 00:22:03.825059 systemd-resolved[234]: Defaulting to hostname 'linux'. Jul 11 00:22:03.826413 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 11 00:22:03.846230 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 11 00:22:03.914767 kernel: SCSI subsystem initialized Jul 11 00:22:03.927754 kernel: Loading iSCSI transport class v2.0-870. Jul 11 00:22:03.941749 kernel: iscsi: registered transport (tcp) Jul 11 00:22:04.001993 kernel: iscsi: registered transport (qla4xxx) Jul 11 00:22:04.002088 kernel: QLogic iSCSI HBA Driver Jul 11 00:22:04.065455 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 11 00:22:04.083991 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 11 00:22:04.111758 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 11 00:22:04.111836 kernel: device-mapper: uevent: version 1.0.3 Jul 11 00:22:04.111849 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jul 11 00:22:04.172767 kernel: raid6: avx2x4 gen() 22246 MB/s Jul 11 00:22:04.189770 kernel: raid6: avx2x2 gen() 25230 MB/s Jul 11 00:22:04.207240 kernel: raid6: avx2x1 gen() 17854 MB/s Jul 11 00:22:04.207340 kernel: raid6: using algorithm avx2x2 gen() 25230 MB/s Jul 11 00:22:04.225250 kernel: raid6: .... xor() 17691 MB/s, rmw enabled Jul 11 00:22:04.225414 kernel: raid6: using avx2x2 recovery algorithm Jul 11 00:22:04.274778 kernel: xor: automatically using best checksumming function avx Jul 11 00:22:04.471770 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 11 00:22:04.488968 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 11 00:22:04.509049 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 11 00:22:04.526781 systemd-udevd[414]: Using default interface naming scheme 'v255'. Jul 11 00:22:04.533063 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 11 00:22:04.540054 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 11 00:22:04.606891 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Jul 11 00:22:04.680973 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 11 00:22:04.742011 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 11 00:22:04.825381 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 11 00:22:04.839932 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 11 00:22:04.853052 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 11 00:22:04.857637 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 11 00:22:04.862838 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jul 11 00:22:04.858986 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 11 00:22:04.859049 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 11 00:22:04.869465 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jul 11 00:22:04.869989 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 11 00:22:04.874835 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 11 00:22:04.874865 kernel: GPT:9289727 != 19775487 Jul 11 00:22:04.874876 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 11 00:22:04.874886 kernel: GPT:9289727 != 19775487 Jul 11 00:22:04.875967 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 11 00:22:04.875990 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 11 00:22:04.881766 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 11 00:22:04.920867 kernel: cryptd: max_cpu_qlen set to 1000 Jul 11 00:22:04.926305 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 11 00:22:04.926475 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 11 00:22:04.933013 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 11 00:22:04.946122 kernel: libata version 3.00 loaded. Jul 11 00:22:04.946145 kernel: AVX2 version of gcm_enc/dec engaged. Jul 11 00:22:04.946157 kernel: AES CTR mode by8 optimization enabled Jul 11 00:22:04.938759 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 11 00:22:04.938977 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:04.944829 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:04.954408 kernel: ahci 0000:00:1f.2: version 3.0 Jul 11 00:22:04.954651 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jul 11 00:22:04.957080 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jul 11 00:22:04.957318 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jul 11 00:22:04.957945 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (475) Jul 11 00:22:05.023004 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:05.032744 kernel: scsi host0: ahci Jul 11 00:22:05.033008 kernel: scsi host1: ahci Jul 11 00:22:05.033210 kernel: scsi host2: ahci Jul 11 00:22:05.038758 kernel: scsi host3: ahci Jul 11 00:22:05.040788 kernel: scsi host4: ahci Jul 11 00:22:05.043253 kernel: scsi host5: ahci Jul 11 00:22:05.043449 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Jul 11 00:22:05.043464 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Jul 11 00:22:05.044062 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Jul 11 00:22:05.046007 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Jul 11 00:22:05.046042 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Jul 11 00:22:05.047816 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Jul 11 00:22:05.050573 kernel: BTRFS: device fsid 54fb9359-b495-4b0c-b313-b0e2955e4a38 devid 1 transid 34 /dev/vda3 scanned by (udev-worker) (466) Jul 11 00:22:05.056558 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 11 00:22:05.062440 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 11 00:22:05.116853 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 11 00:22:05.122787 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 11 00:22:05.122866 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 11 00:22:05.198870 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 11 00:22:05.198959 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 11 00:22:05.199018 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:05.201367 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:05.205572 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:05.293141 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:05.294515 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 11 00:22:05.317650 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 11 00:22:05.392092 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jul 11 00:22:05.392119 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 11 00:22:05.392129 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 11 00:22:05.392139 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 11 00:22:05.392149 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 11 00:22:05.393142 kernel: ata3.00: applying bridge limits Jul 11 00:22:05.393751 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jul 11 00:22:05.394750 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jul 11 00:22:05.394788 kernel: ata3.00: configured for UDMA/100 Jul 11 00:22:05.395751 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 11 00:22:05.510809 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 11 00:22:05.511204 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 11 00:22:05.523751 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 11 00:22:05.996432 disk-uuid[569]: Primary Header is updated. Jul 11 00:22:05.996432 disk-uuid[569]: Secondary Entries is updated. Jul 11 00:22:05.996432 disk-uuid[569]: Secondary Header is updated. Jul 11 00:22:06.060760 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 11 00:22:06.066770 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 11 00:22:07.110768 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 11 00:22:07.112773 disk-uuid[586]: The operation has completed successfully. Jul 11 00:22:07.147636 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 11 00:22:07.147816 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 11 00:22:07.212253 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 11 00:22:07.253016 sh[597]: Success Jul 11 00:22:07.348776 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Jul 11 00:22:07.393433 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 11 00:22:07.444605 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 11 00:22:07.447446 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 11 00:22:07.461781 kernel: BTRFS info (device dm-0): first mount of filesystem 54fb9359-b495-4b0c-b313-b0e2955e4a38 Jul 11 00:22:07.461838 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 11 00:22:07.461850 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jul 11 00:22:07.498073 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jul 11 00:22:07.498155 kernel: BTRFS info (device dm-0): using free space tree Jul 11 00:22:07.599460 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 11 00:22:07.600342 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 11 00:22:07.618943 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 11 00:22:07.619860 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 11 00:22:07.655990 kernel: BTRFS info (device vda6): first mount of filesystem 71430075-b555-475f-bdad-1d4a4e6e1dbe Jul 11 00:22:07.656058 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 11 00:22:07.656070 kernel: BTRFS info (device vda6): using free space tree Jul 11 00:22:07.691768 kernel: BTRFS info (device vda6): auto enabling async discard Jul 11 00:22:07.707918 systemd[1]: mnt-oem.mount: Deactivated successfully. Jul 11 00:22:07.719757 kernel: BTRFS info (device vda6): last unmount of filesystem 71430075-b555-475f-bdad-1d4a4e6e1dbe Jul 11 00:22:07.761250 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 11 00:22:07.777082 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 11 00:22:07.805997 systemd-networkd[776]: lo: Link UP Jul 11 00:22:07.806007 systemd-networkd[776]: lo: Gained carrier Jul 11 00:22:07.823895 systemd-networkd[776]: Enumeration completed Jul 11 00:22:07.824249 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 11 00:22:07.826073 systemd-networkd[776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 11 00:22:07.826077 systemd-networkd[776]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 11 00:22:07.826443 systemd[1]: Reached target network.target - Network. Jul 11 00:22:07.827140 systemd-networkd[776]: eth0: Link UP Jul 11 00:22:07.827144 systemd-networkd[776]: eth0: Gained carrier Jul 11 00:22:07.827152 systemd-networkd[776]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 11 00:22:07.844376 systemd-networkd[776]: eth0: DHCPv4 address 10.0.0.105/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 11 00:22:08.140800 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 11 00:22:08.212093 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 11 00:22:08.593383 ignition[781]: Ignition 2.19.0 Jul 11 00:22:08.593629 ignition[781]: Stage: fetch-offline Jul 11 00:22:08.593686 ignition[781]: no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:08.593701 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:08.593851 ignition[781]: parsed url from cmdline: "" Jul 11 00:22:08.593856 ignition[781]: no config URL provided Jul 11 00:22:08.593864 ignition[781]: reading system config file "/usr/lib/ignition/user.ign" Jul 11 00:22:08.593887 ignition[781]: no config at "/usr/lib/ignition/user.ign" Jul 11 00:22:08.593923 ignition[781]: op(1): [started] loading QEMU firmware config module Jul 11 00:22:08.593930 ignition[781]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 11 00:22:08.694269 ignition[781]: op(1): [finished] loading QEMU firmware config module Jul 11 00:22:08.702301 ignition[781]: parsing config with SHA512: 132f5f1e536332cb78c4d1111e8a85110c843f13574ab2b393e6bd796211ad7398e0b687ab10ea6cc246540d14b7ef9d28d6fc894d04903054e48d8116735863 Jul 11 00:22:08.705866 unknown[781]: fetched base config from "system" Jul 11 00:22:08.705880 unknown[781]: fetched user config from "qemu" Jul 11 00:22:08.706244 ignition[781]: fetch-offline: fetch-offline passed Jul 11 00:22:08.706334 ignition[781]: Ignition finished successfully Jul 11 00:22:08.708980 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 11 00:22:08.711171 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 11 00:22:08.727384 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 11 00:22:08.742415 ignition[791]: Ignition 2.19.0 Jul 11 00:22:08.742428 ignition[791]: Stage: kargs Jul 11 00:22:08.742642 ignition[791]: no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:08.746998 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 11 00:22:08.742658 ignition[791]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:08.743466 ignition[791]: kargs: kargs passed Jul 11 00:22:08.749804 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 11 00:22:08.743525 ignition[791]: Ignition finished successfully Jul 11 00:22:08.769052 ignition[800]: Ignition 2.19.0 Jul 11 00:22:08.769068 ignition[800]: Stage: disks Jul 11 00:22:08.769304 ignition[800]: no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:08.769320 ignition[800]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:08.772227 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 11 00:22:08.770129 ignition[800]: disks: disks passed Jul 11 00:22:08.774904 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 11 00:22:08.770175 ignition[800]: Ignition finished successfully Jul 11 00:22:08.776820 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 11 00:22:08.779043 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 11 00:22:08.782283 systemd[1]: Reached target sysinit.target - System Initialization. Jul 11 00:22:08.785574 systemd[1]: Reached target basic.target - Basic System. Jul 11 00:22:08.802950 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 11 00:22:08.828252 systemd-fsck[810]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jul 11 00:22:09.085034 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 11 00:22:09.108087 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 11 00:22:09.267750 kernel: EXT4-fs (vda9): mounted filesystem 66ba5133-8c5a-461b-b2c1-a823c72af79b r/w with ordered data mode. Quota mode: none. Jul 11 00:22:09.268377 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 11 00:22:09.270595 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 11 00:22:09.288968 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 11 00:22:09.329750 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (818) Jul 11 00:22:09.332187 kernel: BTRFS info (device vda6): first mount of filesystem 71430075-b555-475f-bdad-1d4a4e6e1dbe Jul 11 00:22:09.332219 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 11 00:22:09.332234 kernel: BTRFS info (device vda6): using free space tree Jul 11 00:22:09.335760 kernel: BTRFS info (device vda6): auto enabling async discard Jul 11 00:22:09.337851 systemd-networkd[776]: eth0: Gained IPv6LL Jul 11 00:22:09.347871 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 11 00:22:09.349426 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 11 00:22:09.349491 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 11 00:22:09.349528 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 11 00:22:09.353184 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 11 00:22:09.356527 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 11 00:22:09.361301 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 11 00:22:09.642587 initrd-setup-root[842]: cut: /sysroot/etc/passwd: No such file or directory Jul 11 00:22:09.654584 initrd-setup-root[849]: cut: /sysroot/etc/group: No such file or directory Jul 11 00:22:09.695707 initrd-setup-root[856]: cut: /sysroot/etc/shadow: No such file or directory Jul 11 00:22:09.700697 initrd-setup-root[863]: cut: /sysroot/etc/gshadow: No such file or directory Jul 11 00:22:10.052986 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 11 00:22:10.090861 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 11 00:22:10.092799 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 11 00:22:10.099761 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 11 00:22:10.101500 kernel: BTRFS info (device vda6): last unmount of filesystem 71430075-b555-475f-bdad-1d4a4e6e1dbe Jul 11 00:22:10.189401 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 11 00:22:10.224359 ignition[934]: INFO : Ignition 2.19.0 Jul 11 00:22:10.224359 ignition[934]: INFO : Stage: mount Jul 11 00:22:10.227014 ignition[934]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:10.227014 ignition[934]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:10.227014 ignition[934]: INFO : mount: mount passed Jul 11 00:22:10.227014 ignition[934]: INFO : Ignition finished successfully Jul 11 00:22:10.233487 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 11 00:22:10.243109 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 11 00:22:10.254189 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 11 00:22:10.268785 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (944) Jul 11 00:22:10.271809 kernel: BTRFS info (device vda6): first mount of filesystem 71430075-b555-475f-bdad-1d4a4e6e1dbe Jul 11 00:22:10.271835 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 11 00:22:10.271849 kernel: BTRFS info (device vda6): using free space tree Jul 11 00:22:10.277198 kernel: BTRFS info (device vda6): auto enabling async discard Jul 11 00:22:10.278636 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 11 00:22:10.313028 ignition[961]: INFO : Ignition 2.19.0 Jul 11 00:22:10.313028 ignition[961]: INFO : Stage: files Jul 11 00:22:10.322196 ignition[961]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:10.322196 ignition[961]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:10.322196 ignition[961]: DEBUG : files: compiled without relabeling support, skipping Jul 11 00:22:10.326655 ignition[961]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 11 00:22:10.326655 ignition[961]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 11 00:22:10.344513 ignition[961]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 11 00:22:10.346210 ignition[961]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 11 00:22:10.346210 ignition[961]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 11 00:22:10.345329 unknown[961]: wrote ssh authorized keys file for user: core Jul 11 00:22:10.352318 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jul 11 00:22:10.354331 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-x86-64.raw: attempt #1 Jul 11 00:22:11.094950 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jul 11 00:22:12.593892 ignition[961]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jul 11 00:22:12.593892 ignition[961]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jul 11 00:22:12.598550 ignition[961]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 11 00:22:12.598550 ignition[961]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 11 00:22:12.598550 ignition[961]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jul 11 00:22:12.598550 ignition[961]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jul 11 00:22:12.757662 ignition[961]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 11 00:22:12.814946 ignition[961]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 11 00:22:12.814946 ignition[961]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jul 11 00:22:12.818371 ignition[961]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 11 00:22:12.820816 ignition[961]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 11 00:22:12.820816 ignition[961]: INFO : files: files passed Jul 11 00:22:12.820816 ignition[961]: INFO : Ignition finished successfully Jul 11 00:22:12.826651 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 11 00:22:12.842094 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 11 00:22:12.845741 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 11 00:22:12.857823 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 11 00:22:12.857979 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 11 00:22:12.888584 initrd-setup-root-after-ignition[989]: grep: /sysroot/oem/oem-release: No such file or directory Jul 11 00:22:12.899254 initrd-setup-root-after-ignition[991]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 11 00:22:12.899254 initrd-setup-root-after-ignition[991]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 11 00:22:12.903575 initrd-setup-root-after-ignition[995]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 11 00:22:12.909313 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 11 00:22:12.911470 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 11 00:22:12.933100 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 11 00:22:12.973487 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 11 00:22:12.973676 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 11 00:22:12.976540 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 11 00:22:12.979103 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 11 00:22:12.995893 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 11 00:22:12.998282 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 11 00:22:13.025899 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 11 00:22:13.037199 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 11 00:22:13.049215 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 11 00:22:13.051051 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 11 00:22:13.053677 systemd[1]: Stopped target timers.target - Timer Units. Jul 11 00:22:13.057089 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 11 00:22:13.057289 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 11 00:22:13.061846 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 11 00:22:13.062313 systemd[1]: Stopped target basic.target - Basic System. Jul 11 00:22:13.071324 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 11 00:22:13.075580 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 11 00:22:13.078482 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 11 00:22:13.081210 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 11 00:22:13.081415 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 11 00:22:13.085410 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 11 00:22:13.087960 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 11 00:22:13.088478 systemd[1]: Stopped target swap.target - Swaps. Jul 11 00:22:13.090609 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 11 00:22:13.090836 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 11 00:22:13.095496 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 11 00:22:13.096018 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 11 00:22:13.100347 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 11 00:22:13.105440 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 11 00:22:13.108432 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 11 00:22:13.108670 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 11 00:22:13.112364 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 11 00:22:13.112636 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 11 00:22:13.115015 systemd[1]: Stopped target paths.target - Path Units. Jul 11 00:22:13.117294 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 11 00:22:13.117615 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 11 00:22:13.118276 systemd[1]: Stopped target slices.target - Slice Units. Jul 11 00:22:13.129783 systemd[1]: Stopped target sockets.target - Socket Units. Jul 11 00:22:13.132662 systemd[1]: iscsid.socket: Deactivated successfully. Jul 11 00:22:13.132845 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 11 00:22:13.134530 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 11 00:22:13.134714 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 11 00:22:13.136831 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 11 00:22:13.137121 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 11 00:22:13.139519 systemd[1]: ignition-files.service: Deactivated successfully. Jul 11 00:22:13.139636 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 11 00:22:13.151934 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 11 00:22:13.152928 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 11 00:22:13.154700 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 11 00:22:13.154911 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 11 00:22:13.155419 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 11 00:22:13.155560 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 11 00:22:13.159755 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 11 00:22:13.159914 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 11 00:22:13.189243 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 11 00:22:13.215732 ignition[1015]: INFO : Ignition 2.19.0 Jul 11 00:22:13.215732 ignition[1015]: INFO : Stage: umount Jul 11 00:22:13.232189 ignition[1015]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 11 00:22:13.232189 ignition[1015]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 11 00:22:13.235186 ignition[1015]: INFO : umount: umount passed Jul 11 00:22:13.236126 ignition[1015]: INFO : Ignition finished successfully Jul 11 00:22:13.248466 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 11 00:22:13.248642 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 11 00:22:13.252959 systemd[1]: Stopped target network.target - Network. Jul 11 00:22:13.254406 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 11 00:22:13.254527 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 11 00:22:13.256892 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 11 00:22:13.256970 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 11 00:22:13.259284 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 11 00:22:13.259350 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 11 00:22:13.261808 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 11 00:22:13.261884 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 11 00:22:13.264193 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 11 00:22:13.266205 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 11 00:22:13.271809 systemd-networkd[776]: eth0: DHCPv6 lease lost Jul 11 00:22:13.274564 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 11 00:22:13.274756 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 11 00:22:13.276460 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 11 00:22:13.276513 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 11 00:22:13.287224 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 11 00:22:13.288408 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 11 00:22:13.288486 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 11 00:22:13.291404 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 11 00:22:13.297933 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 11 00:22:13.298132 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 11 00:22:13.302159 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 11 00:22:13.302333 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 11 00:22:13.311294 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 11 00:22:13.311418 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 11 00:22:13.313613 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 11 00:22:13.313681 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 11 00:22:13.314173 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 11 00:22:13.314230 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 11 00:22:13.314475 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 11 00:22:13.314520 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 11 00:22:13.328623 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 11 00:22:13.328901 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 11 00:22:13.332819 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 11 00:22:13.333012 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 11 00:22:13.335358 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 11 00:22:13.335479 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 11 00:22:13.337660 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 11 00:22:13.337822 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 11 00:22:13.342118 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 11 00:22:13.342226 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 11 00:22:13.346044 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 11 00:22:13.346172 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 11 00:22:13.347021 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 11 00:22:13.347104 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 11 00:22:13.361451 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 11 00:22:13.363076 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 11 00:22:13.363228 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 11 00:22:13.364953 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 11 00:22:13.365022 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 11 00:22:13.368392 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 11 00:22:13.368493 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 11 00:22:13.371323 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 11 00:22:13.371410 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:13.374509 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 11 00:22:13.374631 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 11 00:22:13.380294 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 11 00:22:13.395490 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 11 00:22:13.407368 systemd[1]: Switching root. Jul 11 00:22:13.454098 systemd-journald[194]: Journal stopped Jul 11 00:22:15.770215 systemd-journald[194]: Received SIGTERM from PID 1 (systemd). Jul 11 00:22:15.770305 kernel: SELinux: policy capability network_peer_controls=1 Jul 11 00:22:15.770323 kernel: SELinux: policy capability open_perms=1 Jul 11 00:22:15.770337 kernel: SELinux: policy capability extended_socket_class=1 Jul 11 00:22:15.770352 kernel: SELinux: policy capability always_check_network=0 Jul 11 00:22:15.770366 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 11 00:22:15.770387 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 11 00:22:15.770401 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 11 00:22:15.770425 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 11 00:22:15.770437 kernel: audit: type=1403 audit(1752193334.589:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 11 00:22:15.770451 systemd[1]: Successfully loaded SELinux policy in 59.039ms. Jul 11 00:22:15.770473 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 15.944ms. Jul 11 00:22:15.770486 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jul 11 00:22:15.770511 systemd[1]: Detected virtualization kvm. Jul 11 00:22:15.770529 systemd[1]: Detected architecture x86-64. Jul 11 00:22:15.770545 systemd[1]: Detected first boot. Jul 11 00:22:15.770562 systemd[1]: Initializing machine ID from VM UUID. Jul 11 00:22:15.770577 zram_generator::config[1060]: No configuration found. Jul 11 00:22:15.770605 systemd[1]: Populated /etc with preset unit settings. Jul 11 00:22:15.770621 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 11 00:22:15.770640 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 11 00:22:15.770656 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 11 00:22:15.770672 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 11 00:22:15.770688 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 11 00:22:15.770704 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 11 00:22:15.770739 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 11 00:22:15.770756 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 11 00:22:15.770772 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 11 00:22:15.770788 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 11 00:22:15.770805 systemd[1]: Created slice user.slice - User and Session Slice. Jul 11 00:22:15.770826 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 11 00:22:15.770843 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 11 00:22:15.770859 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 11 00:22:15.770874 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 11 00:22:15.770891 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 11 00:22:15.770908 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 11 00:22:15.770925 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 11 00:22:15.770941 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 11 00:22:15.770956 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 11 00:22:15.770974 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 11 00:22:15.771000 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 11 00:22:15.771016 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 11 00:22:15.771031 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 11 00:22:15.771047 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 11 00:22:15.771062 systemd[1]: Reached target slices.target - Slice Units. Jul 11 00:22:15.771078 systemd[1]: Reached target swap.target - Swaps. Jul 11 00:22:15.771094 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 11 00:22:15.771113 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 11 00:22:15.771130 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 11 00:22:15.771147 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 11 00:22:15.771163 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 11 00:22:15.771179 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 11 00:22:15.771201 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 11 00:22:15.771216 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 11 00:22:15.771231 systemd[1]: Mounting media.mount - External Media Directory... Jul 11 00:22:15.771248 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 11 00:22:15.771266 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 11 00:22:15.771282 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 11 00:22:15.771298 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 11 00:22:15.771314 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 11 00:22:15.771329 systemd[1]: Reached target machines.target - Containers. Jul 11 00:22:15.771345 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 11 00:22:15.771361 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 11 00:22:15.771375 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 11 00:22:15.771393 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 11 00:22:15.771411 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 11 00:22:15.771428 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 11 00:22:15.771445 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 11 00:22:15.771460 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 11 00:22:15.771476 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 11 00:22:15.771493 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 11 00:22:15.771509 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 11 00:22:15.771525 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 11 00:22:15.771544 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 11 00:22:15.771557 systemd[1]: Stopped systemd-fsck-usr.service. Jul 11 00:22:15.771569 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 11 00:22:15.771582 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 11 00:22:15.771593 kernel: loop: module loaded Jul 11 00:22:15.771607 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 11 00:22:15.771623 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 11 00:22:15.771640 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 11 00:22:15.771656 systemd[1]: verity-setup.service: Deactivated successfully. Jul 11 00:22:15.771676 systemd[1]: Stopped verity-setup.service. Jul 11 00:22:15.771691 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 11 00:22:15.771708 kernel: fuse: init (API version 7.39) Jul 11 00:22:15.771739 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 11 00:22:15.771755 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 11 00:22:15.771771 systemd[1]: Mounted media.mount - External Media Directory. Jul 11 00:22:15.771787 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 11 00:22:15.771806 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 11 00:22:15.771821 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 11 00:22:15.771837 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 11 00:22:15.771852 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 11 00:22:15.771868 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 11 00:22:15.771880 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 11 00:22:15.771894 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 11 00:22:15.771906 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 11 00:22:15.771919 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 11 00:22:15.771935 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 11 00:22:15.771950 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 11 00:22:15.771993 systemd-journald[1123]: Collecting audit messages is disabled. Jul 11 00:22:15.772022 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 11 00:22:15.772038 systemd-journald[1123]: Journal started Jul 11 00:22:15.772067 systemd-journald[1123]: Runtime Journal (/run/log/journal/890e1aa6be45452b9cc7205b9f62428c) is 6.0M, max 48.3M, 42.2M free. Jul 11 00:22:15.379304 systemd[1]: Queued start job for default target multi-user.target. Jul 11 00:22:15.399145 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 11 00:22:15.399650 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 11 00:22:15.776754 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 11 00:22:15.779744 systemd[1]: Started systemd-journald.service - Journal Service. Jul 11 00:22:15.781401 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 11 00:22:15.783069 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 11 00:22:15.785659 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 11 00:22:15.810719 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 11 00:22:15.816750 kernel: ACPI: bus type drm_connector registered Jul 11 00:22:15.823038 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 11 00:22:15.835798 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 11 00:22:15.837702 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 11 00:22:15.837761 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 11 00:22:15.840445 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jul 11 00:22:15.848698 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 11 00:22:15.853744 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 11 00:22:15.855281 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 11 00:22:15.860576 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 11 00:22:15.864145 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 11 00:22:15.866222 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 11 00:22:15.870108 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 11 00:22:15.871603 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 11 00:22:15.873192 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 11 00:22:15.877968 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 11 00:22:15.882029 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 11 00:22:15.885562 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 11 00:22:15.885900 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 11 00:22:15.923924 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 11 00:22:15.938707 systemd-journald[1123]: Time spent on flushing to /var/log/journal/890e1aa6be45452b9cc7205b9f62428c is 16.512ms for 979 entries. Jul 11 00:22:15.938707 systemd-journald[1123]: System Journal (/var/log/journal/890e1aa6be45452b9cc7205b9f62428c) is 8.0M, max 195.6M, 187.6M free. Jul 11 00:22:16.388648 systemd-journald[1123]: Received client request to flush runtime journal. Jul 11 00:22:16.388751 kernel: loop0: detected capacity change from 0 to 140768 Jul 11 00:22:16.388787 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 11 00:22:15.930233 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 11 00:22:15.932089 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 11 00:22:15.933863 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 11 00:22:15.952172 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jul 11 00:22:15.996248 udevadm[1181]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jul 11 00:22:15.998043 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 11 00:22:16.107123 systemd-tmpfiles[1173]: ACLs are not supported, ignoring. Jul 11 00:22:16.107141 systemd-tmpfiles[1173]: ACLs are not supported, ignoring. Jul 11 00:22:16.110482 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 11 00:22:16.143623 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 11 00:22:16.154035 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 11 00:22:16.191772 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 11 00:22:16.205144 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 11 00:22:16.214160 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 11 00:22:16.238236 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 11 00:22:16.248145 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jul 11 00:22:16.252595 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Jul 11 00:22:16.252610 systemd-tmpfiles[1188]: ACLs are not supported, ignoring. Jul 11 00:22:16.258447 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 11 00:22:16.391224 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 11 00:22:16.511760 kernel: loop1: detected capacity change from 0 to 142488 Jul 11 00:22:17.109779 kernel: loop2: detected capacity change from 0 to 224512 Jul 11 00:22:17.527784 kernel: loop3: detected capacity change from 0 to 140768 Jul 11 00:22:17.750780 kernel: loop4: detected capacity change from 0 to 142488 Jul 11 00:22:17.835773 kernel: loop5: detected capacity change from 0 to 224512 Jul 11 00:22:18.357606 (sd-merge)[1200]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jul 11 00:22:18.358414 (sd-merge)[1200]: Merged extensions into '/usr'. Jul 11 00:22:18.376515 systemd[1]: Reloading requested from client PID 1172 ('systemd-sysext') (unit systemd-sysext.service)... Jul 11 00:22:18.376536 systemd[1]: Reloading... Jul 11 00:22:18.475769 zram_generator::config[1226]: No configuration found. Jul 11 00:22:18.578943 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 11 00:22:18.634366 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 11 00:22:18.634506 systemd[1]: Reloading finished in 257 ms. Jul 11 00:22:18.672804 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 11 00:22:18.675103 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jul 11 00:22:18.693997 systemd[1]: Starting ensure-sysext.service... Jul 11 00:22:18.716305 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 11 00:22:18.718603 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 11 00:22:18.723646 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 11 00:22:18.742848 systemd[1]: Reloading requested from client PID 1264 ('systemctl') (unit ensure-sysext.service)... Jul 11 00:22:18.742867 systemd[1]: Reloading... Jul 11 00:22:18.757059 systemd-tmpfiles[1265]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 11 00:22:18.757456 systemd-tmpfiles[1265]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 11 00:22:18.758478 systemd-tmpfiles[1265]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 11 00:22:18.758806 systemd-tmpfiles[1265]: ACLs are not supported, ignoring. Jul 11 00:22:18.758886 systemd-tmpfiles[1265]: ACLs are not supported, ignoring. Jul 11 00:22:18.773400 systemd-udevd[1267]: Using default interface naming scheme 'v255'. Jul 11 00:22:18.792085 systemd-tmpfiles[1265]: Detected autofs mount point /boot during canonicalization of boot. Jul 11 00:22:18.792101 systemd-tmpfiles[1265]: Skipping /boot Jul 11 00:22:18.803041 zram_generator::config[1295]: No configuration found. Jul 11 00:22:18.807483 systemd-tmpfiles[1265]: Detected autofs mount point /boot during canonicalization of boot. Jul 11 00:22:18.807499 systemd-tmpfiles[1265]: Skipping /boot Jul 11 00:22:18.920112 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 11 00:22:18.989441 systemd[1]: Reloading finished in 246 ms. Jul 11 00:22:19.009821 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jul 11 00:22:19.014300 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 11 00:22:19.046808 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1341) Jul 11 00:22:19.050015 kernel: ACPI: button: Power Button [PWRF] Jul 11 00:22:19.051983 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 11 00:22:19.067187 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 11 00:22:19.085773 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jul 11 00:22:19.092542 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 11 00:22:19.110841 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Jul 11 00:22:19.111284 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jul 11 00:22:19.111795 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jul 11 00:22:19.114011 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 11 00:22:19.118737 kernel: mousedev: PS/2 mouse device common for all mice Jul 11 00:22:19.135247 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 11 00:22:19.145232 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jul 11 00:22:19.209319 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 11 00:22:19.211089 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 11 00:22:19.215456 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 11 00:22:19.219119 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 11 00:22:19.233159 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 11 00:22:19.248546 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 11 00:22:19.250173 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 11 00:22:19.251958 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 11 00:22:19.258959 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 11 00:22:19.267846 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 11 00:22:19.284577 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 11 00:22:19.290869 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 11 00:22:19.295145 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 11 00:22:19.296467 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 11 00:22:19.304827 systemd[1]: Finished ensure-sysext.service. Jul 11 00:22:19.306985 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 11 00:22:19.307832 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 11 00:22:19.312521 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 11 00:22:19.313824 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 11 00:22:19.316562 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 11 00:22:19.317396 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 11 00:22:19.324009 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jul 11 00:22:19.330139 augenrules[1390]: No rules Jul 11 00:22:19.349369 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 11 00:22:19.349625 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 11 00:22:19.352101 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 11 00:22:19.380265 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 11 00:22:19.380465 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 11 00:22:19.410759 kernel: kvm_amd: TSC scaling supported Jul 11 00:22:19.411031 kernel: kvm_amd: Nested Virtualization enabled Jul 11 00:22:19.411096 kernel: kvm_amd: Nested Paging enabled Jul 11 00:22:19.411116 kernel: kvm_amd: LBR virtualization supported Jul 11 00:22:19.413742 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jul 11 00:22:19.413795 kernel: kvm_amd: Virtual GIF supported Jul 11 00:22:19.417198 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 11 00:22:19.429612 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 11 00:22:19.433704 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 11 00:22:19.447949 kernel: EDAC MC: Ver: 3.0.0 Jul 11 00:22:19.467233 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 11 00:22:19.480497 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jul 11 00:22:19.487046 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jul 11 00:22:19.500864 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 11 00:22:19.504960 lvm[1411]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 11 00:22:19.538019 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 11 00:22:19.551521 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jul 11 00:22:19.554465 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 11 00:22:19.581807 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jul 11 00:22:19.600920 lvm[1423]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jul 11 00:22:19.603840 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 11 00:22:19.606415 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 11 00:22:19.618633 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 11 00:22:19.620543 systemd[1]: Reached target time-set.target - System Time Set. Jul 11 00:22:19.625891 systemd-networkd[1383]: lo: Link UP Jul 11 00:22:19.625907 systemd-networkd[1383]: lo: Gained carrier Jul 11 00:22:19.628116 systemd-networkd[1383]: Enumeration completed Jul 11 00:22:19.628267 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 11 00:22:19.631007 systemd-networkd[1383]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 11 00:22:19.631245 systemd-networkd[1383]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 11 00:22:19.632509 systemd-networkd[1383]: eth0: Link UP Jul 11 00:22:19.632521 systemd-networkd[1383]: eth0: Gained carrier Jul 11 00:22:19.632538 systemd-networkd[1383]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 11 00:22:19.636810 systemd-resolved[1386]: Positive Trust Anchors: Jul 11 00:22:19.636836 systemd-resolved[1386]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 11 00:22:19.636897 systemd-resolved[1386]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 11 00:22:19.640694 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 11 00:22:19.641871 systemd-networkd[1383]: eth0: DHCPv4 address 10.0.0.105/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 11 00:22:19.642446 systemd-resolved[1386]: Defaulting to hostname 'linux'. Jul 11 00:22:19.642871 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jul 11 00:22:19.643326 systemd-timesyncd[1403]: Network configuration changed, trying to establish connection. Jul 11 00:22:20.119940 systemd-timesyncd[1403]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 11 00:22:20.120028 systemd-timesyncd[1403]: Initial clock synchronization to Fri 2025-07-11 00:22:20.119735 UTC. Jul 11 00:22:20.120410 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 11 00:22:20.120590 systemd-resolved[1386]: Clock change detected. Flushing caches. Jul 11 00:22:20.123989 systemd[1]: Reached target network.target - Network. Jul 11 00:22:20.125178 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 11 00:22:20.132169 ldconfig[1167]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 11 00:22:20.149322 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 11 00:22:20.162918 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 11 00:22:20.186486 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 11 00:22:20.188459 systemd[1]: Reached target sysinit.target - System Initialization. Jul 11 00:22:20.190292 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 11 00:22:20.191954 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 11 00:22:20.195561 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 11 00:22:20.196823 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 11 00:22:20.198068 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 11 00:22:20.199459 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 11 00:22:20.199516 systemd[1]: Reached target paths.target - Path Units. Jul 11 00:22:20.200609 systemd[1]: Reached target timers.target - Timer Units. Jul 11 00:22:20.203518 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 11 00:22:20.207204 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 11 00:22:20.224393 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 11 00:22:20.226469 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 11 00:22:20.227880 systemd[1]: Reached target sockets.target - Socket Units. Jul 11 00:22:20.229563 systemd[1]: Reached target basic.target - Basic System. Jul 11 00:22:20.230810 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 11 00:22:20.230859 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 11 00:22:20.232852 systemd[1]: Starting containerd.service - containerd container runtime... Jul 11 00:22:20.237082 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 11 00:22:20.242517 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 11 00:22:20.245521 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 11 00:22:20.246810 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jul 11 00:22:20.250624 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 11 00:22:20.254573 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 11 00:22:20.257868 jq[1436]: false Jul 11 00:22:20.260542 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 11 00:22:20.270735 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 11 00:22:20.272652 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 11 00:22:20.274026 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 11 00:22:20.275316 systemd[1]: Starting update-engine.service - Update Engine... Jul 11 00:22:20.277835 extend-filesystems[1437]: Found loop3 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found loop4 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found loop5 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found sr0 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda1 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda2 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda3 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found usr Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda4 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda6 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda7 Jul 11 00:22:20.278979 extend-filesystems[1437]: Found vda9 Jul 11 00:22:20.278979 extend-filesystems[1437]: Checking size of /dev/vda9 Jul 11 00:22:20.299697 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 11 00:22:20.302907 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 11 00:22:20.303138 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 11 00:22:20.303540 systemd[1]: motdgen.service: Deactivated successfully. Jul 11 00:22:20.303749 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 11 00:22:20.305054 jq[1452]: true Jul 11 00:22:20.305403 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 11 00:22:20.305686 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 11 00:22:20.321266 extend-filesystems[1437]: Resized partition /dev/vda9 Jul 11 00:22:20.337535 jq[1456]: true Jul 11 00:22:20.349362 extend-filesystems[1466]: resize2fs 1.47.1 (20-May-2024) Jul 11 00:22:20.361510 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1338) Jul 11 00:22:20.359862 (ntainerd)[1460]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 11 00:22:20.357544 dbus-daemon[1435]: [system] SELinux support is enabled Jul 11 00:22:20.362840 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 11 00:22:20.378350 update_engine[1446]: I20250711 00:22:20.378189 1446 main.cc:92] Flatcar Update Engine starting Jul 11 00:22:20.380467 update_engine[1446]: I20250711 00:22:20.380419 1446 update_check_scheduler.cc:74] Next update check in 5m7s Jul 11 00:22:20.386439 systemd[1]: Started update-engine.service - Update Engine. Jul 11 00:22:20.391214 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jul 11 00:22:20.391253 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 11 00:22:20.392703 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 11 00:22:20.392726 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 11 00:22:20.413696 sshd_keygen[1454]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 11 00:22:20.417006 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 11 00:22:20.444018 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 11 00:22:20.480694 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 11 00:22:20.495729 systemd[1]: issuegen.service: Deactivated successfully. Jul 11 00:22:20.495963 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 11 00:22:20.536440 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jul 11 00:22:20.538390 systemd-logind[1444]: Watching system buttons on /dev/input/event1 (Power Button) Jul 11 00:22:20.538420 systemd-logind[1444]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 11 00:22:20.539126 systemd-logind[1444]: New seat seat0. Jul 11 00:22:20.542412 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 11 00:22:20.544610 systemd[1]: Started systemd-logind.service - User Login Management. Jul 11 00:22:20.640752 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 11 00:22:20.700870 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 11 00:22:20.711096 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 11 00:22:20.713445 systemd[1]: Reached target getty.target - Login Prompts. Jul 11 00:22:20.721377 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 11 00:22:20.724787 systemd[1]: Started sshd@0-10.0.0.105:22-10.0.0.1:49600.service - OpenSSH per-connection server daemon (10.0.0.1:49600). Jul 11 00:22:20.766173 locksmithd[1483]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 11 00:22:20.952394 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jul 11 00:22:21.320269 sshd[1503]: Connection closed by authenticating user core 10.0.0.1 port 49600 [preauth] Jul 11 00:22:21.051679 systemd[1]: sshd@0-10.0.0.105:22-10.0.0.1:49600.service: Deactivated successfully. Jul 11 00:22:21.324048 extend-filesystems[1466]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jul 11 00:22:21.324048 extend-filesystems[1466]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 11 00:22:21.324048 extend-filesystems[1466]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jul 11 00:22:21.322706 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 11 00:22:21.329048 extend-filesystems[1437]: Resized filesystem in /dev/vda9 Jul 11 00:22:21.322960 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 11 00:22:21.332526 systemd-networkd[1383]: eth0: Gained IPv6LL Jul 11 00:22:21.339005 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 11 00:22:21.346388 systemd[1]: Reached target network-online.target - Network is Online. Jul 11 00:22:21.361805 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 11 00:22:21.364753 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 11 00:22:21.369519 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 11 00:22:21.403207 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 11 00:22:21.405150 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 11 00:22:21.405467 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 11 00:22:21.408704 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 11 00:22:21.417355 bash[1492]: Updated "/home/core/.ssh/authorized_keys" Jul 11 00:22:21.420294 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 11 00:22:21.422988 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 11 00:22:21.441426 containerd[1460]: time="2025-07-11T00:22:21.441250110Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jul 11 00:22:21.498811 containerd[1460]: time="2025-07-11T00:22:21.498683198Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.501373 containerd[1460]: time="2025-07-11T00:22:21.501308514Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.96-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jul 11 00:22:21.501468 containerd[1460]: time="2025-07-11T00:22:21.501370660Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jul 11 00:22:21.501468 containerd[1460]: time="2025-07-11T00:22:21.501394565Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jul 11 00:22:21.501740 containerd[1460]: time="2025-07-11T00:22:21.501699487Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jul 11 00:22:21.501740 containerd[1460]: time="2025-07-11T00:22:21.501731437Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.501879 containerd[1460]: time="2025-07-11T00:22:21.501847374Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jul 11 00:22:21.501879 containerd[1460]: time="2025-07-11T00:22:21.501872932Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502259 containerd[1460]: time="2025-07-11T00:22:21.502209855Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502259 containerd[1460]: time="2025-07-11T00:22:21.502236665Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502259 containerd[1460]: time="2025-07-11T00:22:21.502256572Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502369 containerd[1460]: time="2025-07-11T00:22:21.502272562Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502518 containerd[1460]: time="2025-07-11T00:22:21.502481113Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.502891 containerd[1460]: time="2025-07-11T00:22:21.502839175Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jul 11 00:22:21.503062 containerd[1460]: time="2025-07-11T00:22:21.503023050Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jul 11 00:22:21.503062 containerd[1460]: time="2025-07-11T00:22:21.503053247Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jul 11 00:22:21.503280 containerd[1460]: time="2025-07-11T00:22:21.503247892Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jul 11 00:22:21.503395 containerd[1460]: time="2025-07-11T00:22:21.503374620Z" level=info msg="metadata content store policy set" policy=shared Jul 11 00:22:21.758909 containerd[1460]: time="2025-07-11T00:22:21.758608326Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jul 11 00:22:21.758909 containerd[1460]: time="2025-07-11T00:22:21.758744091Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jul 11 00:22:21.758909 containerd[1460]: time="2025-07-11T00:22:21.758775991Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jul 11 00:22:21.758909 containerd[1460]: time="2025-07-11T00:22:21.758811668Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jul 11 00:22:21.758909 containerd[1460]: time="2025-07-11T00:22:21.758884164Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jul 11 00:22:21.759278 containerd[1460]: time="2025-07-11T00:22:21.759230023Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jul 11 00:22:21.759695 containerd[1460]: time="2025-07-11T00:22:21.759648929Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jul 11 00:22:21.759830 containerd[1460]: time="2025-07-11T00:22:21.759808859Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jul 11 00:22:21.759893 containerd[1460]: time="2025-07-11T00:22:21.759828756Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jul 11 00:22:21.759893 containerd[1460]: time="2025-07-11T00:22:21.759848233Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jul 11 00:22:21.759893 containerd[1460]: time="2025-07-11T00:22:21.759866898Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.759893 containerd[1460]: time="2025-07-11T00:22:21.759882447Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759897976Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759917242Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759936638Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759953760Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759972295Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760000 containerd[1460]: time="2025-07-11T00:22:21.759989998Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760015677Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760039040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760078805Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760099263Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760133177Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760160 containerd[1460]: time="2025-07-11T00:22:21.760153465Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760170066Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760188321Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760207717Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760245758Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760265425Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760282668Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760301072Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760325 containerd[1460]: time="2025-07-11T00:22:21.760321841Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760370773Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760389758Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760405428Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760492301Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760524171Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jul 11 00:22:21.760574 containerd[1460]: time="2025-07-11T00:22:21.760539710Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jul 11 00:22:21.760845 containerd[1460]: time="2025-07-11T00:22:21.760577170Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jul 11 00:22:21.760845 containerd[1460]: time="2025-07-11T00:22:21.760592158Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.760845 containerd[1460]: time="2025-07-11T00:22:21.760631933Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jul 11 00:22:21.760845 containerd[1460]: time="2025-07-11T00:22:21.760768649Z" level=info msg="NRI interface is disabled by configuration." Jul 11 00:22:21.760845 containerd[1460]: time="2025-07-11T00:22:21.760786102Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jul 11 00:22:21.761245 containerd[1460]: time="2025-07-11T00:22:21.761172747Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jul 11 00:22:21.761245 containerd[1460]: time="2025-07-11T00:22:21.761234012Z" level=info msg="Connect containerd service" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.761287382Z" level=info msg="using legacy CRI server" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.761297221Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.761439748Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762283692Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762476994Z" level=info msg="Start subscribing containerd event" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762622658Z" level=info msg="Start recovering state" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762768651Z" level=info msg="Start event monitor" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762798447Z" level=info msg="Start snapshots syncer" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762817112Z" level=info msg="Start cni network conf syncer for default" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762831329Z" level=info msg="Start streaming server" Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.762770635Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.787657725Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 11 00:22:21.787989 containerd[1460]: time="2025-07-11T00:22:21.787813477Z" level=info msg="containerd successfully booted in 0.350620s" Jul 11 00:22:21.788006 systemd[1]: Started containerd.service - containerd container runtime. Jul 11 00:22:22.748394 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 11 00:22:22.750175 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 11 00:22:22.752480 systemd[1]: Startup finished in 1.777s (kernel) + 11.774s (initrd) + 7.746s (userspace) = 21.298s. Jul 11 00:22:22.754289 (kubelet)[1546]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jul 11 00:22:24.260299 kubelet[1546]: E0711 00:22:24.260202 1546 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Jul 11 00:22:24.264937 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jul 11 00:22:24.265167 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jul 11 00:22:24.265654 systemd[1]: kubelet.service: Consumed 2.022s CPU time. Jul 11 00:22:31.068695 systemd[1]: Started sshd@1-10.0.0.105:22-10.0.0.1:54186.service - OpenSSH per-connection server daemon (10.0.0.1:54186). Jul 11 00:22:31.119706 sshd[1560]: Accepted publickey for core from 10.0.0.1 port 54186 ssh2: RSA SHA256:FCL55Ve/xvuldIyR2b7eMaaOT6EnxAosit+pdkZfXh0 Jul 11 00:22:31.123611 sshd[1560]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 11 00:22:31.134757 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 11 00:22:31.151964 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 11 00:22:31.155088 systemd-logind[1444]: New session 1 of user core. Jul 11 00:22:31.170286 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 11 00:22:31.183857 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 11 00:22:31.187862 (systemd)[1564]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 11 00:22:31.330864 systemd[1564]: Queued start job for default target default.target. Jul 11 00:22:31.340397 systemd[1564]: Created slice app.slice - User Application Slice. Jul 11 00:22:31.340441 systemd[1564]: Reached target paths.target - Paths. Jul 11 00:22:31.340462 systemd[1564]: Reached target timers.target - Timers. Jul 11 00:22:31.342771 systemd[1564]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 11 00:22:31.359192 systemd[1564]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 11 00:22:31.359410 systemd[1564]: Reached target sockets.target - Sockets. Jul 11 00:22:31.359436 systemd[1564]: Reached target basic.target - Basic System. Jul 11 00:22:31.359495 systemd[1564]: Reached target default.target - Main User Target. Jul 11 00:22:31.359539 systemd[1564]: Startup finished in 162ms. Jul 11 00:22:31.360098 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 11 00:22:31.362426 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 11 00:22:31.427699 systemd[1]: Started sshd@2-10.0.0.105:22-10.0.0.1:54190.service - OpenSSH per-connection server daemon (10.0.0.1:54190). Jul 11 00:22:31.472799 sshd[1575]: Accepted publickey for core from 10.0.0.1 port 54190 ssh2: RSA SHA256:FCL55Ve/xvuldIyR2b7eMaaOT6EnxAosit+pdkZfXh0 Jul 11 00:22:31.474870 sshd[1575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 11 00:22:31.480252 systemd-logind[1444]: New session 2 of user core. Jul 11 00:22:31.489614 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 11 00:22:31.550020 sshd[1575]: pam_unix(sshd:session): session closed for user core Jul 11 00:22:31.563504 systemd[1]: sshd@2-10.0.0.105:22-10.0.0.1:54190.service: Deactivated successfully. Jul 11 00:22:31.566542 systemd[1]: session-2.scope: Deactivated successfully. Jul 11 00:22:31.569300 systemd-logind[1444]: Session 2 logged out. Waiting for processes to exit. Jul 11 00:22:31.576946 systemd[1]: Started sshd@3-10.0.0.105:22-10.0.0.1:54194.service - OpenSSH per-connection server daemon (10.0.0.1:54194). Jul 11 00:22:31.580011 systemd-logind[1444]: Removed session 2. Jul 11 00:22:31.613409 sshd[1582]: Accepted publickey for core from 10.0.0.1 port 54194 ssh2: RSA SHA256:FCL55Ve/xvuldIyR2b7eMaaOT6EnxAosit+pdkZfXh0 Jul 11 00:22:31.615988 sshd[1582]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 11 00:22:31.623653 systemd-logind[1444]: New session 3 of user core. Jul 11 00:22:31.633644 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 11 00:22:31.687490 sshd[1582]: pam_unix(sshd:session): session closed for user core Jul 11 00:22:31.700394 systemd[1]: sshd@3-10.0.0.105:22-10.0.0.1:54194.service: Deactivated successfully. Jul 11 00:22:31.702742 systemd[1]: session-3.scope: Deactivated successfully. Jul 11 00:22:31.704853 systemd-logind[1444]: Session 3 logged out. Waiting for processes to exit. Jul 11 00:22:31.715929 systemd[1]: Started sshd@4-10.0.0.105:22-10.0.0.1:54200.service - OpenSSH per-connection server daemon (10.0.0.1:54200). Jul 11 00:22:31.717621 systemd-logind[1444]: Removed session 3. Jul 11 00:22:31.753707 sshd[1589]: Accepted publickey for core from 10.0.0.1 port 54200 ssh2: RSA SHA256:FCL55Ve/xvuldIyR2b7eMaaOT6EnxAosit+pdkZfXh0 Jul 11 00:22:31.756018 sshd[1589]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 11 00:22:31.762311 systemd-logind[1444]: New session 4 of user core. Jul 11 00:22:31.769569 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 11 00:22:31.826889 sshd[1589]: pam_unix(sshd:session): session closed for user core Jul 11 00:22:31.841063 systemd[1]: sshd@4-10.0.0.105:22-10.0.0.1:54200.service: Deactivated successfully. Jul 11 00:22:31.843227 systemd[1]: session-4.scope: Deactivated successfully. Jul 11 00:22:31.844837 systemd-logind[1444]: Session 4 logged out. Waiting for processes to exit. Jul 11 00:22:31.858862 systemd[1]: Started sshd@5-10.0.0.105:22-10.0.0.1:54210.service - OpenSSH per-connection server daemon (10.0.0.1:54210). Jul 11 00:22:31.860386 systemd-logind[1444]: Removed session 4. Jul 11 00:22:31.898939 sshd[1596]: Accepted publickey for core from 10.0.0.1 port 54210 ssh2: RSA SHA256:FCL55Ve/xvuldIyR2b7eMaaOT6EnxAosit+pdkZfXh0 Jul 11 00:22:31.901003 sshd[1596]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 11 00:22:31.908399 systemd-logind[1444]: New session 5 of user core. Jul 11 00:22:31.917695 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 11 00:22:31.984579 sudo[1599]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jul 11 00:22:31.985014 sudo[1599]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 11 00:22:32.021446 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 11 00:22:32.047455 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 11 00:22:32.047739 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 11 00:22:32.826059 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 11 00:22:32.826328 systemd[1]: kubelet.service: Consumed 2.022s CPU time. Jul 11 00:22:32.839710 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 11 00:22:32.875196 systemd[1]: Reloading requested from client PID 1641 ('systemctl') (unit session-5.scope)... Jul 11 00:22:32.875214 systemd[1]: Reloading... Jul 11 00:22:32.973440 zram_generator::config[1679]: No configuration found. Jul 11 00:22:33.302232 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 11 00:22:33.384687 systemd[1]: Reloading finished in 508 ms. Jul 11 00:22:33.439767 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 11 00:22:33.444312 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Jul 11 00:22:33.445180 systemd[1]: kubelet.service: Deactivated successfully. Jul 11 00:22:33.445515 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 11 00:22:33.447701 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 11 00:22:33.630881 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 11 00:22:33.643789 (kubelet)[1729]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jul 11 00:22:33.706538 kubelet[1729]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jul 11 00:22:33.706538 kubelet[1729]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Jul 11 00:22:33.706538 kubelet[1729]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jul 11 00:22:33.707027 kubelet[1729]: I0711 00:22:33.706667 1729 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jul 11 00:22:34.250687 kubelet[1729]: I0711 00:22:34.250613 1729 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Jul 11 00:22:34.250687 kubelet[1729]: I0711 00:22:34.250667 1729 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jul 11 00:22:34.250983 kubelet[1729]: I0711 00:22:34.250967 1729 server.go:954] "Client rotation is on, will bootstrap in background" Jul 11 00:22:34.303485 kubelet[1729]: I0711 00:22:34.303404 1729 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jul 11 00:22:34.311158 kubelet[1729]: E0711 00:22:34.311097 1729 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Jul 11 00:22:34.311158 kubelet[1729]: I0711 00:22:34.311144 1729 server.go:1421] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Jul 11 00:22:34.319929 kubelet[1729]: I0711 00:22:34.319875 1729 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jul 11 00:22:34.320264 kubelet[1729]: I0711 00:22:34.320215 1729 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jul 11 00:22:34.320533 kubelet[1729]: I0711 00:22:34.320259 1729 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.105","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,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Jul 11 00:22:34.320671 kubelet[1729]: I0711 00:22:34.320554 1729 topology_manager.go:138] "Creating topology manager with none policy" Jul 11 00:22:34.320671 kubelet[1729]: I0711 00:22:34.320571 1729 container_manager_linux.go:304] "Creating device plugin manager" Jul 11 00:22:34.320795 kubelet[1729]: I0711 00:22:34.320778 1729 state_mem.go:36] "Initialized new in-memory state store" Jul 11 00:22:34.324919 kubelet[1729]: I0711 00:22:34.324878 1729 kubelet.go:446] "Attempting to sync node with API server" Jul 11 00:22:34.324919 kubelet[1729]: I0711 00:22:34.324917 1729 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Jul 11 00:22:34.325121 kubelet[1729]: I0711 00:22:34.324939 1729 kubelet.go:352] "Adding apiserver pod source" Jul 11 00:22:34.325121 kubelet[1729]: I0711 00:22:34.324952 1729 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jul 11 00:22:34.325179 kubelet[1729]: E0711 00:22:34.325139 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:34.325229 kubelet[1729]: E0711 00:22:34.325203 1729 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:34.347115 kubelet[1729]: I0711 00:22:34.347062 1729 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Jul 11 00:22:34.347648 kubelet[1729]: I0711 00:22:34.347632 1729 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Jul 11 00:22:34.348466 kubelet[1729]: W0711 00:22:34.348435 1729 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jul 11 00:22:34.350640 kubelet[1729]: I0711 00:22:34.350602 1729 watchdog_linux.go:99] "Systemd watchdog is not enabled" Jul 11 00:22:34.350640 kubelet[1729]: I0711 00:22:34.350644 1729 server.go:1287] "Started kubelet" Jul 11 00:22:34.352941 kubelet[1729]: I0711 00:22:34.350839 1729 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jul 11 00:22:34.352941 kubelet[1729]: I0711 00:22:34.351256 1729 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jul 11 00:22:34.352941 kubelet[1729]: I0711 00:22:34.351326 1729 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Jul 11 00:22:34.352941 kubelet[1729]: I0711 00:22:34.352198 1729 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jul 11 00:22:34.352941 kubelet[1729]: I0711 00:22:34.352396 1729 server.go:479] "Adding debug handlers to kubelet server" Jul 11 00:22:34.356763 kubelet[1729]: I0711 00:22:34.356742 1729 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jul 11 00:22:34.358589 kubelet[1729]: W0711 00:22:34.358481 1729 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Jul 11 00:22:34.358589 kubelet[1729]: E0711 00:22:34.358550 1729 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Jul 11 00:22:34.358921 kubelet[1729]: W0711 00:22:34.358686 1729 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.105" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Jul 11 00:22:34.358921 kubelet[1729]: E0711 00:22:34.358707 1729 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.105\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Jul 11 00:22:34.360052 kubelet[1729]: E0711 00:22:34.359068 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.360052 kubelet[1729]: I0711 00:22:34.359138 1729 volume_manager.go:297] "Starting Kubelet Volume Manager" Jul 11 00:22:34.360052 kubelet[1729]: I0711 00:22:34.359351 1729 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Jul 11 00:22:34.360052 kubelet[1729]: I0711 00:22:34.359520 1729 reconciler.go:26] "Reconciler: start to sync state" Jul 11 00:22:34.361266 kubelet[1729]: I0711 00:22:34.360987 1729 factory.go:221] Registration of the systemd container factory successfully Jul 11 00:22:34.361266 kubelet[1729]: I0711 00:22:34.361195 1729 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Jul 11 00:22:34.361585 kubelet[1729]: E0711 00:22:34.361565 1729 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jul 11 00:22:34.363074 kubelet[1729]: I0711 00:22:34.362983 1729 factory.go:221] Registration of the containerd container factory successfully Jul 11 00:22:34.368535 kubelet[1729]: E0711 00:22:34.366428 1729 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.105.18510a927fde6274 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.350617204 +0000 UTC m=+0.701389057,LastTimestamp:2025-07-11 00:22:34.350617204 +0000 UTC m=+0.701389057,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:34.379841 kubelet[1729]: E0711 00:22:34.379700 1729 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.105.18510a9280851f24 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.361544484 +0000 UTC m=+0.712316337,LastTimestamp:2025-07-11 00:22:34.361544484 +0000 UTC m=+0.712316337,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:34.384710 kubelet[1729]: E0711 00:22:34.383660 1729 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.105.18510a9281c24a48 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.105 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.38233044 +0000 UTC m=+0.733102293,LastTimestamp:2025-07-11 00:22:34.38233044 +0000 UTC m=+0.733102293,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:34.384710 kubelet[1729]: I0711 00:22:34.384138 1729 cpu_manager.go:221] "Starting CPU manager" policy="none" Jul 11 00:22:34.384710 kubelet[1729]: I0711 00:22:34.384161 1729 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Jul 11 00:22:34.384710 kubelet[1729]: I0711 00:22:34.384196 1729 state_mem.go:36] "Initialized new in-memory state store" Jul 11 00:22:34.384710 kubelet[1729]: E0711 00:22:34.384463 1729 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.105\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Jul 11 00:22:34.384710 kubelet[1729]: W0711 00:22:34.384574 1729 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Jul 11 00:22:34.386007 kubelet[1729]: E0711 00:22:34.384614 1729 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Jul 11 00:22:34.386007 kubelet[1729]: E0711 00:22:34.385903 1729 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.105.18510a9281c35327 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasNoDiskPressure,Message:Node 10.0.0.105 status is now: NodeHasNoDiskPressure,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.382398247 +0000 UTC m=+0.733170100,LastTimestamp:2025-07-11 00:22:34.382398247 +0000 UTC m=+0.733170100,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:34.390651 kubelet[1729]: E0711 00:22:34.390454 1729 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.105.18510a9281c35eef default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.105 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.382401263 +0000 UTC m=+0.733173116,LastTimestamp:2025-07-11 00:22:34.382401263 +0000 UTC m=+0.733173116,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:34.459803 kubelet[1729]: E0711 00:22:34.459721 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.560241 kubelet[1729]: E0711 00:22:34.560006 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.660312 kubelet[1729]: E0711 00:22:34.660250 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.698069 kubelet[1729]: E0711 00:22:34.697944 1729 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.105\" not found" node="10.0.0.105" Jul 11 00:22:34.760444 kubelet[1729]: E0711 00:22:34.760382 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.861244 kubelet[1729]: E0711 00:22:34.861002 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:34.961491 kubelet[1729]: E0711 00:22:34.961400 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.062326 kubelet[1729]: E0711 00:22:35.062240 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.144729 kubelet[1729]: I0711 00:22:35.144564 1729 policy_none.go:49] "None policy: Start" Jul 11 00:22:35.144729 kubelet[1729]: I0711 00:22:35.144617 1729 memory_manager.go:186] "Starting memorymanager" policy="None" Jul 11 00:22:35.144729 kubelet[1729]: I0711 00:22:35.144685 1729 state_mem.go:35] "Initializing new in-memory state store" Jul 11 00:22:35.155029 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jul 11 00:22:35.162911 kubelet[1729]: E0711 00:22:35.162859 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.167975 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jul 11 00:22:35.172947 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jul 11 00:22:35.187200 kubelet[1729]: I0711 00:22:35.185832 1729 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Jul 11 00:22:35.187200 kubelet[1729]: I0711 00:22:35.186150 1729 eviction_manager.go:189] "Eviction manager: starting control loop" Jul 11 00:22:35.187200 kubelet[1729]: I0711 00:22:35.186164 1729 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jul 11 00:22:35.187200 kubelet[1729]: I0711 00:22:35.186525 1729 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jul 11 00:22:35.187972 kubelet[1729]: E0711 00:22:35.187950 1729 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jul 11 00:22:35.188050 kubelet[1729]: E0711 00:22:35.188010 1729 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.105\" not found" Jul 11 00:22:35.258548 kubelet[1729]: I0711 00:22:35.258459 1729 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Jul 11 00:22:35.261158 kubelet[1729]: I0711 00:22:35.261096 1729 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Jul 11 00:22:35.261239 kubelet[1729]: I0711 00:22:35.261176 1729 status_manager.go:227] "Starting to sync pod status with apiserver" Jul 11 00:22:35.261269 kubelet[1729]: I0711 00:22:35.261235 1729 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jul 11 00:22:35.261269 kubelet[1729]: I0711 00:22:35.261250 1729 kubelet.go:2382] "Starting kubelet main sync loop" Jul 11 00:22:35.261416 kubelet[1729]: E0711 00:22:35.261387 1729 kubelet.go:2406] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jul 11 00:22:35.287624 kubelet[1729]: I0711 00:22:35.287582 1729 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.105" Jul 11 00:22:35.293514 kubelet[1729]: I0711 00:22:35.293415 1729 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jul 11 00:22:35.293777 kubelet[1729]: W0711 00:22:35.293741 1729 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Jul 11 00:22:35.293843 kubelet[1729]: E0711 00:22:35.293770 1729 kubelet_node_status.go:107] "Unable to register node with API server" err="Post \"https://10.0.0.93:6443/api/v1/nodes\": read tcp 10.0.0.105:56708->10.0.0.93:6443: use of closed network connection" node="10.0.0.105" Jul 11 00:22:35.293912 kubelet[1729]: E0711 00:22:35.293758 1729 event.go:368] "Unable to write event (may retry after sleeping)" err="Post \"https://10.0.0.93:6443/api/v1/namespaces/default/events\": write tcp 10.0.0.105:56708->10.0.0.93:6443: use of closed network connection" event="&Event{ObjectMeta:{10.0.0.105.18510a9281c24a48 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.105,UID:10.0.0.105,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.105 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.105,},FirstTimestamp:2025-07-11 00:22:34.38233044 +0000 UTC m=+0.733102293,LastTimestamp:2025-07-11 00:22:35.287510142 +0000 UTC m=+1.638281995,Count:2,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.105,}" Jul 11 00:22:35.326097 kubelet[1729]: E0711 00:22:35.325992 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:35.495855 kubelet[1729]: I0711 00:22:35.495611 1729 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.105" Jul 11 00:22:35.506128 kubelet[1729]: I0711 00:22:35.506042 1729 kubelet_node_status.go:124] "Node was previously registered" node="10.0.0.105" Jul 11 00:22:35.506273 kubelet[1729]: I0711 00:22:35.506173 1729 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.105" Jul 11 00:22:35.506273 kubelet[1729]: E0711 00:22:35.506197 1729 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.105\": node \"10.0.0.105\" not found" Jul 11 00:22:35.509710 kubelet[1729]: I0711 00:22:35.509647 1729 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jul 11 00:22:35.510515 containerd[1460]: time="2025-07-11T00:22:35.510308097Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jul 11 00:22:35.511141 kubelet[1729]: I0711 00:22:35.510643 1729 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jul 11 00:22:35.522878 kubelet[1729]: E0711 00:22:35.522808 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.623965 kubelet[1729]: E0711 00:22:35.623842 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.725027 kubelet[1729]: E0711 00:22:35.724942 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.825482 kubelet[1729]: E0711 00:22:35.825194 1729 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.105\" not found" Jul 11 00:22:35.867890 sudo[1599]: pam_unix(sudo:session): session closed for user root Jul 11 00:22:35.870488 sshd[1596]: pam_unix(sshd:session): session closed for user core Jul 11 00:22:35.875554 systemd[1]: sshd@5-10.0.0.105:22-10.0.0.1:54210.service: Deactivated successfully. Jul 11 00:22:35.877686 systemd[1]: session-5.scope: Deactivated successfully. Jul 11 00:22:35.879501 systemd-logind[1444]: Session 5 logged out. Waiting for processes to exit. Jul 11 00:22:35.880558 systemd-logind[1444]: Removed session 5. Jul 11 00:22:36.327095 kubelet[1729]: I0711 00:22:36.327051 1729 apiserver.go:52] "Watching apiserver" Jul 11 00:22:36.327263 kubelet[1729]: E0711 00:22:36.327058 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:36.336453 systemd[1]: Created slice kubepods-besteffort-podd6302ea9_aeb4_4824_b144_ac1382c99dbc.slice - libcontainer container kubepods-besteffort-podd6302ea9_aeb4_4824_b144_ac1382c99dbc.slice. Jul 11 00:22:36.359055 systemd[1]: Created slice kubepods-burstable-poddd1fa3bc_f7f4_4a3e_b73c_fe58cd500be6.slice - libcontainer container kubepods-burstable-poddd1fa3bc_f7f4_4a3e_b73c_fe58cd500be6.slice. Jul 11 00:22:36.359771 kubelet[1729]: I0711 00:22:36.359727 1729 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Jul 11 00:22:36.369527 kubelet[1729]: I0711 00:22:36.369484 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-run\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369527 kubelet[1729]: I0711 00:22:36.369522 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-flannel-cfg\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369626 kubelet[1729]: I0711 00:22:36.369551 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-xtables-lock\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369626 kubelet[1729]: I0711 00:22:36.369582 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-t8fvv\" (UniqueName: \"kubernetes.io/projected/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-kube-api-access-t8fvv\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369626 kubelet[1729]: I0711 00:22:36.369609 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/d6302ea9-aeb4-4824-b144-ac1382c99dbc-kube-proxy\") pod \"kube-proxy-t4hw2\" (UID: \"d6302ea9-aeb4-4824-b144-ac1382c99dbc\") " pod="kube-system/kube-proxy-t4hw2" Jul 11 00:22:36.369700 kubelet[1729]: I0711 00:22:36.369635 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d6302ea9-aeb4-4824-b144-ac1382c99dbc-xtables-lock\") pod \"kube-proxy-t4hw2\" (UID: \"d6302ea9-aeb4-4824-b144-ac1382c99dbc\") " pod="kube-system/kube-proxy-t4hw2" Jul 11 00:22:36.369700 kubelet[1729]: I0711 00:22:36.369658 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-cni-plugin\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369700 kubelet[1729]: I0711 00:22:36.369686 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6-cni\") pod \"kube-flannel-ds-nvp9l\" (UID: \"dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6\") " pod="kube-flannel/kube-flannel-ds-nvp9l" Jul 11 00:22:36.369759 kubelet[1729]: I0711 00:22:36.369706 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/d6302ea9-aeb4-4824-b144-ac1382c99dbc-lib-modules\") pod \"kube-proxy-t4hw2\" (UID: \"d6302ea9-aeb4-4824-b144-ac1382c99dbc\") " pod="kube-system/kube-proxy-t4hw2" Jul 11 00:22:36.369759 kubelet[1729]: I0711 00:22:36.369737 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8k5d4\" (UniqueName: \"kubernetes.io/projected/d6302ea9-aeb4-4824-b144-ac1382c99dbc-kube-api-access-8k5d4\") pod \"kube-proxy-t4hw2\" (UID: \"d6302ea9-aeb4-4824-b144-ac1382c99dbc\") " pod="kube-system/kube-proxy-t4hw2" Jul 11 00:22:36.656373 kubelet[1729]: E0711 00:22:36.656207 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:36.657376 containerd[1460]: time="2025-07-11T00:22:36.657297922Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-t4hw2,Uid:d6302ea9-aeb4-4824-b144-ac1382c99dbc,Namespace:kube-system,Attempt:0,}" Jul 11 00:22:36.675957 kubelet[1729]: E0711 00:22:36.675872 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:36.676656 containerd[1460]: time="2025-07-11T00:22:36.676595645Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-nvp9l,Uid:dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6,Namespace:kube-flannel,Attempt:0,}" Jul 11 00:22:37.327491 kubelet[1729]: E0711 00:22:37.327320 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:38.230494 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount324589883.mount: Deactivated successfully. Jul 11 00:22:38.247630 containerd[1460]: time="2025-07-11T00:22:38.247486649Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 11 00:22:38.252222 containerd[1460]: time="2025-07-11T00:22:38.252175616Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 11 00:22:38.254758 containerd[1460]: time="2025-07-11T00:22:38.254657432Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312056" Jul 11 00:22:38.256997 containerd[1460]: time="2025-07-11T00:22:38.256901692Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Jul 11 00:22:38.263484 containerd[1460]: time="2025-07-11T00:22:38.263392299Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 11 00:22:38.269823 containerd[1460]: time="2025-07-11T00:22:38.269761508Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 11 00:22:38.270817 containerd[1460]: time="2025-07-11T00:22:38.270767886Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.594074718s" Jul 11 00:22:38.275243 containerd[1460]: time="2025-07-11T00:22:38.275190063Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.617717784s" Jul 11 00:22:38.328034 kubelet[1729]: E0711 00:22:38.327810 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:38.432449 containerd[1460]: time="2025-07-11T00:22:38.432315421Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 11 00:22:38.432449 containerd[1460]: time="2025-07-11T00:22:38.432402404Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 11 00:22:38.432449 containerd[1460]: time="2025-07-11T00:22:38.432413154Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:22:38.432701 containerd[1460]: time="2025-07-11T00:22:38.432489377Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:22:38.432701 containerd[1460]: time="2025-07-11T00:22:38.432389039Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 11 00:22:38.432701 containerd[1460]: time="2025-07-11T00:22:38.432465392Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 11 00:22:38.432701 containerd[1460]: time="2025-07-11T00:22:38.432479579Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:22:38.432880 containerd[1460]: time="2025-07-11T00:22:38.432593473Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:22:38.511714 systemd[1]: Started cri-containerd-3b2edf66b5cbecb01448d3a61238cb2792dc324b8bc58f8ec3840a46b554ca0b.scope - libcontainer container 3b2edf66b5cbecb01448d3a61238cb2792dc324b8bc58f8ec3840a46b554ca0b. Jul 11 00:22:38.514793 systemd[1]: Started cri-containerd-99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b.scope - libcontainer container 99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b. Jul 11 00:22:38.540754 containerd[1460]: time="2025-07-11T00:22:38.540664181Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-t4hw2,Uid:d6302ea9-aeb4-4824-b144-ac1382c99dbc,Namespace:kube-system,Attempt:0,} returns sandbox id \"3b2edf66b5cbecb01448d3a61238cb2792dc324b8bc58f8ec3840a46b554ca0b\"" Jul 11 00:22:38.542120 kubelet[1729]: E0711 00:22:38.542084 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:38.544081 containerd[1460]: time="2025-07-11T00:22:38.543838066Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.6\"" Jul 11 00:22:38.558731 containerd[1460]: time="2025-07-11T00:22:38.558668939Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-nvp9l,Uid:dd1fa3bc-f7f4-4a3e-b73c-fe58cd500be6,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\"" Jul 11 00:22:38.559737 kubelet[1729]: E0711 00:22:38.559712 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:39.328386 kubelet[1729]: E0711 00:22:39.328302 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:40.248562 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount655422556.mount: Deactivated successfully. Jul 11 00:22:40.328810 kubelet[1729]: E0711 00:22:40.328721 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:41.215707 containerd[1460]: time="2025-07-11T00:22:41.215579493Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.6\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:41.218130 containerd[1460]: time="2025-07-11T00:22:41.217821339Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.6: active requests=0, bytes read=30895363" Jul 11 00:22:41.220804 containerd[1460]: time="2025-07-11T00:22:41.220699499Z" level=info msg="ImageCreate event name:\"sha256:63f0cbe3b7339c5d006efc9964228e48271bae73039320037c451b5e8f763e02\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:41.226152 containerd[1460]: time="2025-07-11T00:22:41.226059635Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:b13d9da413b983d130bf090b83fce12e1ccc704e95f366da743c18e964d9d7e9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:41.226990 containerd[1460]: time="2025-07-11T00:22:41.226926972Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.32.6\" with image id \"sha256:63f0cbe3b7339c5d006efc9964228e48271bae73039320037c451b5e8f763e02\", repo tag \"registry.k8s.io/kube-proxy:v1.32.6\", repo digest \"registry.k8s.io/kube-proxy@sha256:b13d9da413b983d130bf090b83fce12e1ccc704e95f366da743c18e964d9d7e9\", size \"30894382\" in 2.68303755s" Jul 11 00:22:41.226990 containerd[1460]: time="2025-07-11T00:22:41.226969081Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.6\" returns image reference \"sha256:63f0cbe3b7339c5d006efc9964228e48271bae73039320037c451b5e8f763e02\"" Jul 11 00:22:41.228952 containerd[1460]: time="2025-07-11T00:22:41.228795898Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Jul 11 00:22:41.231028 containerd[1460]: time="2025-07-11T00:22:41.230988802Z" level=info msg="CreateContainer within sandbox \"3b2edf66b5cbecb01448d3a61238cb2792dc324b8bc58f8ec3840a46b554ca0b\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jul 11 00:22:41.259161 containerd[1460]: time="2025-07-11T00:22:41.259045508Z" level=info msg="CreateContainer within sandbox \"3b2edf66b5cbecb01448d3a61238cb2792dc324b8bc58f8ec3840a46b554ca0b\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"e852a77a91c56ae30c3a8ba7db50fac3eb635cfcd4489aa1cfc14ddce842e4a8\"" Jul 11 00:22:41.260027 containerd[1460]: time="2025-07-11T00:22:41.259960205Z" level=info msg="StartContainer for \"e852a77a91c56ae30c3a8ba7db50fac3eb635cfcd4489aa1cfc14ddce842e4a8\"" Jul 11 00:22:41.329785 kubelet[1729]: E0711 00:22:41.329695 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:41.373629 systemd[1]: Started cri-containerd-e852a77a91c56ae30c3a8ba7db50fac3eb635cfcd4489aa1cfc14ddce842e4a8.scope - libcontainer container e852a77a91c56ae30c3a8ba7db50fac3eb635cfcd4489aa1cfc14ddce842e4a8. Jul 11 00:22:41.419186 containerd[1460]: time="2025-07-11T00:22:41.419101645Z" level=info msg="StartContainer for \"e852a77a91c56ae30c3a8ba7db50fac3eb635cfcd4489aa1cfc14ddce842e4a8\" returns successfully" Jul 11 00:22:42.282738 kubelet[1729]: E0711 00:22:42.282692 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:42.330497 kubelet[1729]: E0711 00:22:42.330416 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:42.445364 kubelet[1729]: I0711 00:22:42.445189 1729 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-t4hw2" podStartSLOduration=4.759875398 podStartE2EDuration="7.445161176s" podCreationTimestamp="2025-07-11 00:22:35 +0000 UTC" firstStartedPulling="2025-07-11 00:22:38.543173569 +0000 UTC m=+4.893945422" lastFinishedPulling="2025-07-11 00:22:41.228459347 +0000 UTC m=+7.579231200" observedRunningTime="2025-07-11 00:22:42.444754293 +0000 UTC m=+8.795526176" watchObservedRunningTime="2025-07-11 00:22:42.445161176 +0000 UTC m=+8.795933029" Jul 11 00:22:43.284205 kubelet[1729]: E0711 00:22:43.284148 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:43.331661 kubelet[1729]: E0711 00:22:43.331616 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:44.332829 kubelet[1729]: E0711 00:22:44.332715 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:44.702439 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1084014267.mount: Deactivated successfully. Jul 11 00:22:44.766534 containerd[1460]: time="2025-07-11T00:22:44.766474115Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:44.768299 containerd[1460]: time="2025-07-11T00:22:44.768233556Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852937" Jul 11 00:22:44.770592 containerd[1460]: time="2025-07-11T00:22:44.770506670Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:44.774966 containerd[1460]: time="2025-07-11T00:22:44.774840962Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:44.775820 containerd[1460]: time="2025-07-11T00:22:44.775741822Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3842055\" in 3.54688523s" Jul 11 00:22:44.775890 containerd[1460]: time="2025-07-11T00:22:44.775817364Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Jul 11 00:22:44.779252 containerd[1460]: time="2025-07-11T00:22:44.779204408Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jul 11 00:22:44.890136 containerd[1460]: time="2025-07-11T00:22:44.889878160Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963\"" Jul 11 00:22:44.891542 containerd[1460]: time="2025-07-11T00:22:44.891083100Z" level=info msg="StartContainer for \"32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963\"" Jul 11 00:22:44.954742 systemd[1]: Started cri-containerd-32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963.scope - libcontainer container 32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963. Jul 11 00:22:44.999778 systemd[1]: cri-containerd-32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963.scope: Deactivated successfully. Jul 11 00:22:45.049397 containerd[1460]: time="2025-07-11T00:22:45.049293875Z" level=info msg="StartContainer for \"32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963\" returns successfully" Jul 11 00:22:45.291003 kubelet[1729]: E0711 00:22:45.290824 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:45.333869 kubelet[1729]: E0711 00:22:45.333802 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:45.609706 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963-rootfs.mount: Deactivated successfully. Jul 11 00:22:46.062422 containerd[1460]: time="2025-07-11T00:22:46.062015513Z" level=info msg="shim disconnected" id=32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963 namespace=k8s.io Jul 11 00:22:46.062422 containerd[1460]: time="2025-07-11T00:22:46.062124277Z" level=warning msg="cleaning up after shim disconnected" id=32df67a860ebf91c6049172b0d0578b641adeb7b32c812185e8f6070353c4963 namespace=k8s.io Jul 11 00:22:46.062422 containerd[1460]: time="2025-07-11T00:22:46.062140187Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 11 00:22:46.334484 kubelet[1729]: E0711 00:22:46.334296 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:46.351031 kubelet[1729]: E0711 00:22:46.350989 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:46.351813 containerd[1460]: time="2025-07-11T00:22:46.351764643Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Jul 11 00:22:47.335064 kubelet[1729]: E0711 00:22:47.334982 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:48.335927 kubelet[1729]: E0711 00:22:48.335842 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:49.336405 kubelet[1729]: E0711 00:22:49.336315 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:50.337159 kubelet[1729]: E0711 00:22:50.337018 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:50.659467 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2703344032.mount: Deactivated successfully. Jul 11 00:22:51.338039 kubelet[1729]: E0711 00:22:51.337867 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:51.928752 containerd[1460]: time="2025-07-11T00:22:51.928413875Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:51.933379 containerd[1460]: time="2025-07-11T00:22:51.933244398Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866358" Jul 11 00:22:51.934997 containerd[1460]: time="2025-07-11T00:22:51.934932414Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:51.938481 containerd[1460]: time="2025-07-11T00:22:51.938302357Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:22:51.940285 containerd[1460]: time="2025-07-11T00:22:51.940209024Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26855532\" in 5.58839566s" Jul 11 00:22:51.940285 containerd[1460]: time="2025-07-11T00:22:51.940281249Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Jul 11 00:22:51.943101 containerd[1460]: time="2025-07-11T00:22:51.943063349Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jul 11 00:22:51.993710 containerd[1460]: time="2025-07-11T00:22:51.993636067Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8\"" Jul 11 00:22:51.994292 containerd[1460]: time="2025-07-11T00:22:51.994246412Z" level=info msg="StartContainer for \"ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8\"" Jul 11 00:22:52.062672 systemd[1]: Started cri-containerd-ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8.scope - libcontainer container ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8. Jul 11 00:22:52.101018 systemd[1]: cri-containerd-ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8.scope: Deactivated successfully. Jul 11 00:22:52.195917 kubelet[1729]: I0711 00:22:52.195856 1729 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Jul 11 00:22:52.272218 containerd[1460]: time="2025-07-11T00:22:52.272127827Z" level=info msg="StartContainer for \"ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8\" returns successfully" Jul 11 00:22:52.296075 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8-rootfs.mount: Deactivated successfully. Jul 11 00:22:52.338263 kubelet[1729]: E0711 00:22:52.338072 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:57.121817 kubelet[1729]: E0711 00:22:52.367938 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:57.127484 kubelet[1729]: E0711 00:22:57.126497 1729 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:57.128488 kubelet[1729]: E0711 00:22:57.128142 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:57.131539 kubelet[1729]: E0711 00:22:57.131454 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:58.129990 kubelet[1729]: E0711 00:22:58.129921 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:58.203812 containerd[1460]: time="2025-07-11T00:22:58.203720953Z" level=info msg="shim disconnected" id=ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8 namespace=k8s.io Jul 11 00:22:58.203812 containerd[1460]: time="2025-07-11T00:22:58.203804144Z" level=warning msg="cleaning up after shim disconnected" id=ca5a840fb7a8f212008a849717e6bacc0cf7fb24255b87424a3a7da51fa930e8 namespace=k8s.io Jul 11 00:22:58.203812 containerd[1460]: time="2025-07-11T00:22:58.203816266Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jul 11 00:22:58.506486 systemd[1]: Created slice kubepods-besteffort-pod46e679b9_b913_48c0_b81d_8f4db6a87630.slice - libcontainer container kubepods-besteffort-pod46e679b9_b913_48c0_b81d_8f4db6a87630.slice. Jul 11 00:22:58.635124 kubelet[1729]: I0711 00:22:58.634990 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qqzsk\" (UniqueName: \"kubernetes.io/projected/46e679b9-b913-48c0-b81d-8f4db6a87630-kube-api-access-qqzsk\") pod \"nginx-deployment-7fcdb87857-9856v\" (UID: \"46e679b9-b913-48c0-b81d-8f4db6a87630\") " pod="default/nginx-deployment-7fcdb87857-9856v" Jul 11 00:22:58.810869 containerd[1460]: time="2025-07-11T00:22:58.810651032Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-9856v,Uid:46e679b9-b913-48c0-b81d-8f4db6a87630,Namespace:default,Attempt:0,}" Jul 11 00:22:58.868888 systemd[1]: run-netns-cni\x2d3d519f49\x2daf80\x2d4150\x2dd4d5\x2dc9c189dbd196.mount: Deactivated successfully. Jul 11 00:22:58.869058 systemd[1]: run-containerd-io.containerd.grpc.v1.cri-sandboxes-257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47-shm.mount: Deactivated successfully. Jul 11 00:22:58.873779 containerd[1460]: time="2025-07-11T00:22:58.873704961Z" level=error msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-9856v,Uid:46e679b9-b913-48c0-b81d-8f4db6a87630,Namespace:default,Attempt:0,} failed, error" error="failed to setup network for sandbox \"257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jul 11 00:22:58.874141 kubelet[1729]: E0711 00:22:58.874079 1729 log.go:32] "RunPodSandbox from runtime service failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jul 11 00:22:58.874217 kubelet[1729]: E0711 00:22:58.874186 1729 kuberuntime_sandbox.go:72] "Failed to create sandbox for pod" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-7fcdb87857-9856v" Jul 11 00:22:58.874260 kubelet[1729]: E0711 00:22:58.874216 1729 kuberuntime_manager.go:1237] "CreatePodSandbox for pod failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-7fcdb87857-9856v" Jul 11 00:22:58.874327 kubelet[1729]: E0711 00:22:58.874286 1729 pod_workers.go:1301] "Error syncing pod, skipping" err="failed to \"CreatePodSandbox\" for \"nginx-deployment-7fcdb87857-9856v_default(46e679b9-b913-48c0-b81d-8f4db6a87630)\" with CreatePodSandboxError: \"Failed to create sandbox for pod \\\"nginx-deployment-7fcdb87857-9856v_default(46e679b9-b913-48c0-b81d-8f4db6a87630)\\\": rpc error: code = Unknown desc = failed to setup network for sandbox \\\"257f889e33604525bbbef53dc3d1fe48400235f2b8dbb8c488817d7e7a429f47\\\": plugin type=\\\"flannel\\\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory\"" pod="default/nginx-deployment-7fcdb87857-9856v" podUID="46e679b9-b913-48c0-b81d-8f4db6a87630" Jul 11 00:22:59.131000 kubelet[1729]: E0711 00:22:59.130810 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:22:59.139133 kubelet[1729]: E0711 00:22:59.139013 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:22:59.141452 containerd[1460]: time="2025-07-11T00:22:59.141414292Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jul 11 00:22:59.160997 containerd[1460]: time="2025-07-11T00:22:59.160910909Z" level=info msg="CreateContainer within sandbox \"99198bc830dc549c713e742cd6dd85809d4d0288b4a6821332bad7c9864d841b\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"2847a3189f8b94f7646a351ef33eec21a789d46617098b10b3b06f9a0a868346\"" Jul 11 00:22:59.161696 containerd[1460]: time="2025-07-11T00:22:59.161655106Z" level=info msg="StartContainer for \"2847a3189f8b94f7646a351ef33eec21a789d46617098b10b3b06f9a0a868346\"" Jul 11 00:22:59.202664 systemd[1]: Started cri-containerd-2847a3189f8b94f7646a351ef33eec21a789d46617098b10b3b06f9a0a868346.scope - libcontainer container 2847a3189f8b94f7646a351ef33eec21a789d46617098b10b3b06f9a0a868346. Jul 11 00:22:59.301836 containerd[1460]: time="2025-07-11T00:22:59.301624110Z" level=info msg="StartContainer for \"2847a3189f8b94f7646a351ef33eec21a789d46617098b10b3b06f9a0a868346\" returns successfully" Jul 11 00:23:00.131164 kubelet[1729]: E0711 00:23:00.131043 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:00.144292 kubelet[1729]: E0711 00:23:00.144247 1729 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Jul 11 00:23:00.162058 kubelet[1729]: I0711 00:23:00.161941 1729 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-nvp9l" podStartSLOduration=11.780732071 podStartE2EDuration="25.161920395s" podCreationTimestamp="2025-07-11 00:22:35 +0000 UTC" firstStartedPulling="2025-07-11 00:22:38.560264443 +0000 UTC m=+4.911036296" lastFinishedPulling="2025-07-11 00:22:51.941452767 +0000 UTC m=+18.292224620" observedRunningTime="2025-07-11 00:23:00.161825372 +0000 UTC m=+26.512597225" watchObservedRunningTime="2025-07-11 00:23:00.161920395 +0000 UTC m=+26.512692248" Jul 11 00:23:00.365627 systemd-networkd[1383]: flannel.1: Link UP Jul 11 00:23:00.365644 systemd-networkd[1383]: flannel.1: Gained carrier Jul 11 00:23:01.132248 kubelet[1729]: E0711 00:23:01.132090 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:02.036655 systemd-networkd[1383]: flannel.1: Gained IPv6LL Jul 11 00:23:02.132806 kubelet[1729]: E0711 00:23:02.132740 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:03.134032 kubelet[1729]: E0711 00:23:03.133858 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:04.135130 kubelet[1729]: E0711 00:23:04.135006 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:05.135698 kubelet[1729]: E0711 00:23:05.135578 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:05.460550 update_engine[1446]: I20250711 00:23:05.460451 1446 update_attempter.cc:509] Updating boot flags... Jul 11 00:23:05.604396 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2359) Jul 11 00:23:05.648385 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2362) Jul 11 00:23:05.686370 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2362) Jul 11 00:23:06.135964 kubelet[1729]: E0711 00:23:06.135883 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:07.136318 kubelet[1729]: E0711 00:23:07.136243 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:08.137440 kubelet[1729]: E0711 00:23:08.137318 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:09.138255 kubelet[1729]: E0711 00:23:09.138171 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:10.138730 kubelet[1729]: E0711 00:23:10.138648 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:11.138885 kubelet[1729]: E0711 00:23:11.138818 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:12.139002 kubelet[1729]: E0711 00:23:12.138924 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:13.139158 kubelet[1729]: E0711 00:23:13.139071 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:13.262291 containerd[1460]: time="2025-07-11T00:23:13.262192178Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-9856v,Uid:46e679b9-b913-48c0-b81d-8f4db6a87630,Namespace:default,Attempt:0,}" Jul 11 00:23:13.396718 systemd-networkd[1383]: cni0: Link UP Jul 11 00:23:13.396730 systemd-networkd[1383]: cni0: Gained carrier Jul 11 00:23:13.400394 systemd-networkd[1383]: cni0: Lost carrier Jul 11 00:23:13.412042 systemd-networkd[1383]: veth74e22d06: Link UP Jul 11 00:23:13.418744 kernel: cni0: port 1(veth74e22d06) entered blocking state Jul 11 00:23:13.418953 kernel: cni0: port 1(veth74e22d06) entered disabled state Jul 11 00:23:13.418980 kernel: veth74e22d06: entered allmulticast mode Jul 11 00:23:13.422649 kernel: veth74e22d06: entered promiscuous mode Jul 11 00:23:13.422756 kernel: cni0: port 1(veth74e22d06) entered blocking state Jul 11 00:23:13.422785 kernel: cni0: port 1(veth74e22d06) entered forwarding state Jul 11 00:23:13.422839 kernel: cni0: port 1(veth74e22d06) entered disabled state Jul 11 00:23:13.429769 kernel: cni0: port 1(veth74e22d06) entered blocking state Jul 11 00:23:13.429910 kernel: cni0: port 1(veth74e22d06) entered forwarding state Jul 11 00:23:13.429918 systemd-networkd[1383]: veth74e22d06: Gained carrier Jul 11 00:23:13.430318 systemd-networkd[1383]: cni0: Gained carrier Jul 11 00:23:13.435451 containerd[1460]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000ae8e8), "name":"cbr0", "type":"bridge"} Jul 11 00:23:13.435451 containerd[1460]: delegateAdd: netconf sent to delegate plugin: Jul 11 00:23:13.494494 containerd[1460]: {"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-07-11T00:23:13.494368920Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 11 00:23:13.494494 containerd[1460]: time="2025-07-11T00:23:13.494448803Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 11 00:23:13.494494 containerd[1460]: time="2025-07-11T00:23:13.494468226Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:13.494706 containerd[1460]: time="2025-07-11T00:23:13.494585319Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:13.523779 systemd[1]: Started cri-containerd-bb4969f5019f6ff3c2e54181ad007be37d1ef411b60c69d51ba948f6794648f3.scope - libcontainer container bb4969f5019f6ff3c2e54181ad007be37d1ef411b60c69d51ba948f6794648f3. Jul 11 00:23:13.538852 systemd-resolved[1386]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 11 00:23:13.566603 containerd[1460]: time="2025-07-11T00:23:13.566558704Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-9856v,Uid:46e679b9-b913-48c0-b81d-8f4db6a87630,Namespace:default,Attempt:0,} returns sandbox id \"bb4969f5019f6ff3c2e54181ad007be37d1ef411b60c69d51ba948f6794648f3\"" Jul 11 00:23:13.567977 containerd[1460]: time="2025-07-11T00:23:13.567949283Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 11 00:23:14.139583 kubelet[1729]: E0711 00:23:14.139515 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:14.326205 kubelet[1729]: E0711 00:23:14.326120 1729 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:14.644612 systemd-networkd[1383]: veth74e22d06: Gained IPv6LL Jul 11 00:23:15.028740 systemd-networkd[1383]: cni0: Gained IPv6LL Jul 11 00:23:15.140042 kubelet[1729]: E0711 00:23:15.139957 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:16.141194 kubelet[1729]: E0711 00:23:16.141121 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:17.073973 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1628601121.mount: Deactivated successfully. Jul 11 00:23:17.141930 kubelet[1729]: E0711 00:23:17.141861 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:18.142806 kubelet[1729]: E0711 00:23:18.142748 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:19.143580 kubelet[1729]: E0711 00:23:19.143417 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:19.249319 containerd[1460]: time="2025-07-11T00:23:19.247945437Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:19.250801 containerd[1460]: time="2025-07-11T00:23:19.250690105Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73309401" Jul 11 00:23:19.254759 containerd[1460]: time="2025-07-11T00:23:19.254609272Z" level=info msg="ImageCreate event name:\"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:19.261642 containerd[1460]: time="2025-07-11T00:23:19.261470468Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:19.262891 containerd[1460]: time="2025-07-11T00:23:19.262740575Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"73309279\" in 5.69475285s" Jul 11 00:23:19.262891 containerd[1460]: time="2025-07-11T00:23:19.262792863Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\"" Jul 11 00:23:19.265164 containerd[1460]: time="2025-07-11T00:23:19.265124004Z" level=info msg="CreateContainer within sandbox \"bb4969f5019f6ff3c2e54181ad007be37d1ef411b60c69d51ba948f6794648f3\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jul 11 00:23:19.290294 containerd[1460]: time="2025-07-11T00:23:19.290226432Z" level=info msg="CreateContainer within sandbox \"bb4969f5019f6ff3c2e54181ad007be37d1ef411b60c69d51ba948f6794648f3\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"6fce68accda9d7c2fb75d7c54778235630128a802d43ea022f6b1158803a074f\"" Jul 11 00:23:19.291505 containerd[1460]: time="2025-07-11T00:23:19.291404107Z" level=info msg="StartContainer for \"6fce68accda9d7c2fb75d7c54778235630128a802d43ea022f6b1158803a074f\"" Jul 11 00:23:19.372042 systemd[1]: Started cri-containerd-6fce68accda9d7c2fb75d7c54778235630128a802d43ea022f6b1158803a074f.scope - libcontainer container 6fce68accda9d7c2fb75d7c54778235630128a802d43ea022f6b1158803a074f. Jul 11 00:23:19.438870 containerd[1460]: time="2025-07-11T00:23:19.438795075Z" level=info msg="StartContainer for \"6fce68accda9d7c2fb75d7c54778235630128a802d43ea022f6b1158803a074f\" returns successfully" Jul 11 00:23:20.144368 kubelet[1729]: E0711 00:23:20.144263 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:20.335390 kubelet[1729]: I0711 00:23:20.335243 1729 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-9856v" podStartSLOduration=16.638930783 podStartE2EDuration="22.335219647s" podCreationTimestamp="2025-07-11 00:22:58 +0000 UTC" firstStartedPulling="2025-07-11 00:23:13.567605877 +0000 UTC m=+39.918377730" lastFinishedPulling="2025-07-11 00:23:19.263894741 +0000 UTC m=+45.614666594" observedRunningTime="2025-07-11 00:23:20.335060458 +0000 UTC m=+46.685832311" watchObservedRunningTime="2025-07-11 00:23:20.335219647 +0000 UTC m=+46.685991500" Jul 11 00:23:21.144657 kubelet[1729]: E0711 00:23:21.144566 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:22.145185 kubelet[1729]: E0711 00:23:22.145073 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:23.145492 kubelet[1729]: E0711 00:23:23.145377 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:24.146260 kubelet[1729]: E0711 00:23:24.146156 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:25.147306 kubelet[1729]: E0711 00:23:25.147180 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:26.148273 kubelet[1729]: E0711 00:23:26.148192 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:27.149030 kubelet[1729]: E0711 00:23:27.148954 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:27.701082 systemd[1]: Created slice kubepods-besteffort-pod178faec0_7f7b_4250_80d2_5b0d0bce7c24.slice - libcontainer container kubepods-besteffort-pod178faec0_7f7b_4250_80d2_5b0d0bce7c24.slice. Jul 11 00:23:27.751525 kubelet[1729]: I0711 00:23:27.751435 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/178faec0-7f7b-4250-80d2-5b0d0bce7c24-data\") pod \"nfs-server-provisioner-0\" (UID: \"178faec0-7f7b-4250-80d2-5b0d0bce7c24\") " pod="default/nfs-server-provisioner-0" Jul 11 00:23:27.751525 kubelet[1729]: I0711 00:23:27.751499 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-g5b5f\" (UniqueName: \"kubernetes.io/projected/178faec0-7f7b-4250-80d2-5b0d0bce7c24-kube-api-access-g5b5f\") pod \"nfs-server-provisioner-0\" (UID: \"178faec0-7f7b-4250-80d2-5b0d0bce7c24\") " pod="default/nfs-server-provisioner-0" Jul 11 00:23:28.149656 kubelet[1729]: E0711 00:23:28.149399 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:28.304635 containerd[1460]: time="2025-07-11T00:23:28.304565822Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:178faec0-7f7b-4250-80d2-5b0d0bce7c24,Namespace:default,Attempt:0,}" Jul 11 00:23:28.486707 systemd-networkd[1383]: veth66a95a17: Link UP Jul 11 00:23:28.496075 kernel: cni0: port 2(veth66a95a17) entered blocking state Jul 11 00:23:28.496171 kernel: cni0: port 2(veth66a95a17) entered disabled state Jul 11 00:23:28.496194 kernel: veth66a95a17: entered allmulticast mode Jul 11 00:23:28.497097 kernel: veth66a95a17: entered promiscuous mode Jul 11 00:23:28.510304 kernel: cni0: port 2(veth66a95a17) entered blocking state Jul 11 00:23:28.510456 kernel: cni0: port 2(veth66a95a17) entered forwarding state Jul 11 00:23:28.510581 systemd-networkd[1383]: veth66a95a17: Gained carrier Jul 11 00:23:28.513045 containerd[1460]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00001a938), "name":"cbr0", "type":"bridge"} Jul 11 00:23:28.513045 containerd[1460]: delegateAdd: netconf sent to delegate plugin: Jul 11 00:23:28.573769 containerd[1460]: {"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-07-11T00:23:28.573616428Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 11 00:23:28.575155 containerd[1460]: time="2025-07-11T00:23:28.575092562Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 11 00:23:28.575504 containerd[1460]: time="2025-07-11T00:23:28.575168003Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:28.575504 containerd[1460]: time="2025-07-11T00:23:28.575429653Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:28.662710 systemd[1]: Started cri-containerd-aaab239285db9c90ff80f060b1b7a5dee951d7aaea3c2bb5abedb046f29c68ce.scope - libcontainer container aaab239285db9c90ff80f060b1b7a5dee951d7aaea3c2bb5abedb046f29c68ce. Jul 11 00:23:28.682354 systemd-resolved[1386]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 11 00:23:28.725211 containerd[1460]: time="2025-07-11T00:23:28.725132771Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:178faec0-7f7b-4250-80d2-5b0d0bce7c24,Namespace:default,Attempt:0,} returns sandbox id \"aaab239285db9c90ff80f060b1b7a5dee951d7aaea3c2bb5abedb046f29c68ce\"" Jul 11 00:23:28.727577 containerd[1460]: time="2025-07-11T00:23:28.727544997Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jul 11 00:23:29.150440 kubelet[1729]: E0711 00:23:29.150285 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:29.684580 systemd-networkd[1383]: veth66a95a17: Gained IPv6LL Jul 11 00:23:30.151024 kubelet[1729]: E0711 00:23:30.150947 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:31.151412 kubelet[1729]: E0711 00:23:31.151345 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:32.152482 kubelet[1729]: E0711 00:23:32.152430 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:32.193249 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2907631678.mount: Deactivated successfully. Jul 11 00:23:33.152615 kubelet[1729]: E0711 00:23:33.152545 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:34.153720 kubelet[1729]: E0711 00:23:34.153599 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:34.325646 kubelet[1729]: E0711 00:23:34.325542 1729 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:35.154608 kubelet[1729]: E0711 00:23:35.154482 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:36.155358 kubelet[1729]: E0711 00:23:36.155272 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:37.155536 kubelet[1729]: E0711 00:23:37.155468 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:37.826800 containerd[1460]: time="2025-07-11T00:23:37.826697188Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:37.929071 containerd[1460]: time="2025-07-11T00:23:37.928990014Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Jul 11 00:23:38.156459 kubelet[1729]: E0711 00:23:38.156282 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:38.202640 containerd[1460]: time="2025-07-11T00:23:38.202563372Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:38.335957 containerd[1460]: time="2025-07-11T00:23:38.335850876Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:38.337142 containerd[1460]: time="2025-07-11T00:23:38.337057211Z" 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 9.609468017s" Jul 11 00:23:38.337142 containerd[1460]: time="2025-07-11T00:23:38.337127286Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jul 11 00:23:38.340487 containerd[1460]: time="2025-07-11T00:23:38.340428944Z" level=info msg="CreateContainer within sandbox \"aaab239285db9c90ff80f060b1b7a5dee951d7aaea3c2bb5abedb046f29c68ce\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jul 11 00:23:39.157265 kubelet[1729]: E0711 00:23:39.157179 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:40.193440 kubelet[1729]: E0711 00:23:40.190193 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:41.193303 kubelet[1729]: E0711 00:23:41.193236 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:42.948507 kubelet[1729]: E0711 00:23:42.947216 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:43.948269 kubelet[1729]: E0711 00:23:43.948163 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:43.995534 containerd[1460]: time="2025-07-11T00:23:43.995402505Z" level=info msg="CreateContainer within sandbox \"aaab239285db9c90ff80f060b1b7a5dee951d7aaea3c2bb5abedb046f29c68ce\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261\"" Jul 11 00:23:43.996730 containerd[1460]: time="2025-07-11T00:23:43.996643526Z" level=info msg="StartContainer for \"7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261\"" Jul 11 00:23:44.221582 systemd[1]: run-containerd-runc-k8s.io-7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261-runc.K1kSLf.mount: Deactivated successfully. Jul 11 00:23:44.232600 systemd[1]: Started cri-containerd-7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261.scope - libcontainer container 7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261. Jul 11 00:23:44.655878 containerd[1460]: time="2025-07-11T00:23:44.655692815Z" level=info msg="StartContainer for \"7bf14562d703e2872f17169bda0db2df37544c52336f7c66be8243a72ceb9261\" returns successfully" Jul 11 00:23:44.948853 kubelet[1729]: E0711 00:23:44.948786 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:44.985757 kubelet[1729]: I0711 00:23:44.985675 1729 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=8.374226125 podStartE2EDuration="17.985655937s" podCreationTimestamp="2025-07-11 00:23:27 +0000 UTC" firstStartedPulling="2025-07-11 00:23:28.727011256 +0000 UTC m=+55.077783109" lastFinishedPulling="2025-07-11 00:23:38.338441068 +0000 UTC m=+64.689212921" observedRunningTime="2025-07-11 00:23:44.985227316 +0000 UTC m=+71.335999179" watchObservedRunningTime="2025-07-11 00:23:44.985655937 +0000 UTC m=+71.336427790" Jul 11 00:23:45.949648 kubelet[1729]: E0711 00:23:45.949576 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:46.950477 kubelet[1729]: E0711 00:23:46.950326 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:47.951064 kubelet[1729]: E0711 00:23:47.950997 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:48.952195 kubelet[1729]: E0711 00:23:48.952033 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:49.952492 kubelet[1729]: E0711 00:23:49.952419 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:50.953366 kubelet[1729]: E0711 00:23:50.953283 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:51.954190 kubelet[1729]: E0711 00:23:51.954106 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:52.954535 kubelet[1729]: E0711 00:23:52.954467 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:53.955671 kubelet[1729]: E0711 00:23:53.955545 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:54.073666 systemd[1]: Created slice kubepods-besteffort-pod77e4ed36_3809_4175_a100_8b0b08b46532.slice - libcontainer container kubepods-besteffort-pod77e4ed36_3809_4175_a100_8b0b08b46532.slice. Jul 11 00:23:54.201605 kubelet[1729]: I0711 00:23:54.201506 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-c2763b0c-a77e-48bc-b6d2-2ac51d8b577a\" (UniqueName: \"kubernetes.io/nfs/77e4ed36-3809-4175-a100-8b0b08b46532-pvc-c2763b0c-a77e-48bc-b6d2-2ac51d8b577a\") pod \"test-pod-1\" (UID: \"77e4ed36-3809-4175-a100-8b0b08b46532\") " pod="default/test-pod-1" Jul 11 00:23:54.201605 kubelet[1729]: I0711 00:23:54.201591 1729 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2d759\" (UniqueName: \"kubernetes.io/projected/77e4ed36-3809-4175-a100-8b0b08b46532-kube-api-access-2d759\") pod \"test-pod-1\" (UID: \"77e4ed36-3809-4175-a100-8b0b08b46532\") " pod="default/test-pod-1" Jul 11 00:23:54.325790 kubelet[1729]: E0711 00:23:54.325648 1729 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:54.359404 kernel: FS-Cache: Loaded Jul 11 00:23:54.558675 kernel: RPC: Registered named UNIX socket transport module. Jul 11 00:23:54.558853 kernel: RPC: Registered udp transport module. Jul 11 00:23:54.558906 kernel: RPC: Registered tcp transport module. Jul 11 00:23:54.560004 kernel: RPC: Registered tcp-with-tls transport module. Jul 11 00:23:54.560071 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jul 11 00:23:54.956180 kubelet[1729]: E0711 00:23:54.956058 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:55.005001 kernel: NFS: Registering the id_resolver key type Jul 11 00:23:55.005751 kernel: Key type id_resolver registered Jul 11 00:23:55.005832 kernel: Key type id_legacy registered Jul 11 00:23:55.057827 nfsidmap[2946]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 11 00:23:55.064231 nfsidmap[2949]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 11 00:23:55.279930 containerd[1460]: time="2025-07-11T00:23:55.279705330Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:77e4ed36-3809-4175-a100-8b0b08b46532,Namespace:default,Attempt:0,}" Jul 11 00:23:55.355698 systemd-networkd[1383]: veth9cd5eb4e: Link UP Jul 11 00:23:55.357844 kernel: cni0: port 3(veth9cd5eb4e) entered blocking state Jul 11 00:23:55.357933 kernel: cni0: port 3(veth9cd5eb4e) entered disabled state Jul 11 00:23:55.357963 kernel: veth9cd5eb4e: entered allmulticast mode Jul 11 00:23:55.359501 kernel: veth9cd5eb4e: entered promiscuous mode Jul 11 00:23:55.374488 kernel: cni0: port 3(veth9cd5eb4e) entered blocking state Jul 11 00:23:55.374602 kernel: cni0: port 3(veth9cd5eb4e) entered forwarding state Jul 11 00:23:55.374602 systemd-networkd[1383]: veth9cd5eb4e: Gained carrier Jul 11 00:23:55.377628 containerd[1460]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc000024938), "name":"cbr0", "type":"bridge"} Jul 11 00:23:55.377628 containerd[1460]: delegateAdd: netconf sent to delegate plugin: Jul 11 00:23:55.565233 containerd[1460]: {"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-07-11T00:23:55.564811551Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jul 11 00:23:55.565233 containerd[1460]: time="2025-07-11T00:23:55.564916700Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jul 11 00:23:55.565233 containerd[1460]: time="2025-07-11T00:23:55.564932910Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:55.565233 containerd[1460]: time="2025-07-11T00:23:55.565057847Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jul 11 00:23:55.694780 systemd[1]: Started cri-containerd-ae76337aa82c9a55272e2f48ca1747237b7b181e3538e4dd1e3aab9be1fe53d1.scope - libcontainer container ae76337aa82c9a55272e2f48ca1747237b7b181e3538e4dd1e3aab9be1fe53d1. Jul 11 00:23:55.713838 systemd-resolved[1386]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 11 00:23:55.824853 containerd[1460]: time="2025-07-11T00:23:55.824492352Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:77e4ed36-3809-4175-a100-8b0b08b46532,Namespace:default,Attempt:0,} returns sandbox id \"ae76337aa82c9a55272e2f48ca1747237b7b181e3538e4dd1e3aab9be1fe53d1\"" Jul 11 00:23:55.826175 containerd[1460]: time="2025-07-11T00:23:55.826149022Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 11 00:23:55.957487 kubelet[1729]: E0711 00:23:55.957133 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:56.820652 systemd-networkd[1383]: veth9cd5eb4e: Gained IPv6LL Jul 11 00:23:56.917115 containerd[1460]: time="2025-07-11T00:23:56.916987550Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 11 00:23:56.958103 kubelet[1729]: E0711 00:23:56.958029 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:57.063045 containerd[1460]: time="2025-07-11T00:23:57.062875884Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jul 11 00:23:57.066505 containerd[1460]: time="2025-07-11T00:23:57.066445182Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"73309279\" in 1.240263968s" Jul 11 00:23:57.066505 containerd[1460]: time="2025-07-11T00:23:57.066498653Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\"" Jul 11 00:23:57.069260 containerd[1460]: time="2025-07-11T00:23:57.069233081Z" level=info msg="CreateContainer within sandbox \"ae76337aa82c9a55272e2f48ca1747237b7b181e3538e4dd1e3aab9be1fe53d1\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jul 11 00:23:57.292355 containerd[1460]: time="2025-07-11T00:23:57.292109895Z" level=info msg="CreateContainer within sandbox \"ae76337aa82c9a55272e2f48ca1747237b7b181e3538e4dd1e3aab9be1fe53d1\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"866e21722d407b20167540546eeef83bc4f8ea069cad5e120e3f7ae6cc7f015e\"" Jul 11 00:23:57.294524 containerd[1460]: time="2025-07-11T00:23:57.293224356Z" level=info msg="StartContainer for \"866e21722d407b20167540546eeef83bc4f8ea069cad5e120e3f7ae6cc7f015e\"" Jul 11 00:23:57.356732 systemd[1]: Started cri-containerd-866e21722d407b20167540546eeef83bc4f8ea069cad5e120e3f7ae6cc7f015e.scope - libcontainer container 866e21722d407b20167540546eeef83bc4f8ea069cad5e120e3f7ae6cc7f015e. Jul 11 00:23:57.399178 containerd[1460]: time="2025-07-11T00:23:57.398876788Z" level=info msg="StartContainer for \"866e21722d407b20167540546eeef83bc4f8ea069cad5e120e3f7ae6cc7f015e\" returns successfully" Jul 11 00:23:57.959113 kubelet[1729]: E0711 00:23:57.959066 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:58.067916 kubelet[1729]: I0711 00:23:58.067814 1729 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=29.826103251 podStartE2EDuration="31.067790255s" podCreationTimestamp="2025-07-11 00:23:27 +0000 UTC" firstStartedPulling="2025-07-11 00:23:55.825716512 +0000 UTC m=+82.176488365" lastFinishedPulling="2025-07-11 00:23:57.067403516 +0000 UTC m=+83.418175369" observedRunningTime="2025-07-11 00:23:58.067271764 +0000 UTC m=+84.418043627" watchObservedRunningTime="2025-07-11 00:23:58.067790255 +0000 UTC m=+84.418562108" Jul 11 00:23:58.959831 kubelet[1729]: E0711 00:23:58.959738 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:23:59.960764 kubelet[1729]: E0711 00:23:59.960691 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 11 00:24:00.961391 kubelet[1729]: E0711 00:24:00.961274 1729 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"