Jun 21 04:44:08.864390 kernel: Linux version 6.12.34-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT_DYNAMIC Fri Jun 20 23:59:04 -00 2025 Jun 21 04:44:08.864412 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:44:08.864423 kernel: BIOS-provided physical RAM map: Jun 21 04:44:08.864442 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jun 21 04:44:08.864448 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Jun 21 04:44:08.864455 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Jun 21 04:44:08.864462 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Jun 21 04:44:08.864469 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Jun 21 04:44:08.864482 kernel: BIOS-e820: [mem 0x000000000080c000-0x0000000000810fff] usable Jun 21 04:44:08.864489 kernel: BIOS-e820: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Jun 21 04:44:08.864496 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009bd3efff] usable Jun 21 04:44:08.864502 kernel: BIOS-e820: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Jun 21 04:44:08.864509 kernel: BIOS-e820: [mem 0x000000009be00000-0x000000009c8ecfff] usable Jun 21 04:44:08.864515 kernel: BIOS-e820: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Jun 21 04:44:08.864526 kernel: BIOS-e820: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Jun 21 04:44:08.864533 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Jun 21 04:44:08.864543 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009ce90fff] usable Jun 21 04:44:08.864550 kernel: BIOS-e820: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Jun 21 04:44:08.864557 kernel: BIOS-e820: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Jun 21 04:44:08.864564 kernel: BIOS-e820: [mem 0x000000009ce97000-0x000000009cedbfff] usable Jun 21 04:44:08.864571 kernel: BIOS-e820: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Jun 21 04:44:08.864577 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Jun 21 04:44:08.864584 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jun 21 04:44:08.864591 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 21 04:44:08.864598 kernel: BIOS-e820: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Jun 21 04:44:08.864609 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jun 21 04:44:08.864617 kernel: NX (Execute Disable) protection: active Jun 21 04:44:08.864626 kernel: APIC: Static calls initialized Jun 21 04:44:08.864634 kernel: e820: update [mem 0x9b320018-0x9b329c57] usable ==> usable Jun 21 04:44:08.864643 kernel: e820: update [mem 0x9b2e3018-0x9b31fe57] usable ==> usable Jun 21 04:44:08.864652 kernel: extended physical RAM map: Jun 21 04:44:08.864661 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000009ffff] usable Jun 21 04:44:08.864669 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000007fffff] usable Jun 21 04:44:08.864678 kernel: reserve setup_data: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Jun 21 04:44:08.864687 kernel: reserve setup_data: [mem 0x0000000000808000-0x000000000080afff] usable Jun 21 04:44:08.864696 kernel: reserve setup_data: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Jun 21 04:44:08.864707 kernel: reserve setup_data: [mem 0x000000000080c000-0x0000000000810fff] usable Jun 21 04:44:08.864719 kernel: reserve setup_data: [mem 0x0000000000811000-0x00000000008fffff] ACPI NVS Jun 21 04:44:08.864727 kernel: reserve setup_data: [mem 0x0000000000900000-0x000000009b2e3017] usable Jun 21 04:44:08.864736 kernel: reserve setup_data: [mem 0x000000009b2e3018-0x000000009b31fe57] usable Jun 21 04:44:08.864749 kernel: reserve setup_data: [mem 0x000000009b31fe58-0x000000009b320017] usable Jun 21 04:44:08.864757 kernel: reserve setup_data: [mem 0x000000009b320018-0x000000009b329c57] usable Jun 21 04:44:08.864766 kernel: reserve setup_data: [mem 0x000000009b329c58-0x000000009bd3efff] usable Jun 21 04:44:08.864776 kernel: reserve setup_data: [mem 0x000000009bd3f000-0x000000009bdfffff] reserved Jun 21 04:44:08.864783 kernel: reserve setup_data: [mem 0x000000009be00000-0x000000009c8ecfff] usable Jun 21 04:44:08.864790 kernel: reserve setup_data: [mem 0x000000009c8ed000-0x000000009cb6cfff] reserved Jun 21 04:44:08.864798 kernel: reserve setup_data: [mem 0x000000009cb6d000-0x000000009cb7efff] ACPI data Jun 21 04:44:08.864805 kernel: reserve setup_data: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Jun 21 04:44:08.864814 kernel: reserve setup_data: [mem 0x000000009cbff000-0x000000009ce90fff] usable Jun 21 04:44:08.864822 kernel: reserve setup_data: [mem 0x000000009ce91000-0x000000009ce94fff] reserved Jun 21 04:44:08.864829 kernel: reserve setup_data: [mem 0x000000009ce95000-0x000000009ce96fff] ACPI NVS Jun 21 04:44:08.864859 kernel: reserve setup_data: [mem 0x000000009ce97000-0x000000009cedbfff] usable Jun 21 04:44:08.864867 kernel: reserve setup_data: [mem 0x000000009cedc000-0x000000009cf5ffff] reserved Jun 21 04:44:08.864880 kernel: reserve setup_data: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Jun 21 04:44:08.864892 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jun 21 04:44:08.864902 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jun 21 04:44:08.864911 kernel: reserve setup_data: [mem 0x00000000ffc00000-0x00000000ffffffff] reserved Jun 21 04:44:08.864920 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jun 21 04:44:08.864932 kernel: efi: EFI v2.7 by EDK II Jun 21 04:44:08.864940 kernel: efi: SMBIOS=0x9c988000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b9e4198 RNG=0x9cb73018 Jun 21 04:44:08.864947 kernel: random: crng init done Jun 21 04:44:08.864956 kernel: efi: Remove mem151: MMIO range=[0xffc00000-0xffffffff] (4MB) from e820 map Jun 21 04:44:08.864964 kernel: e820: remove [mem 0xffc00000-0xffffffff] reserved Jun 21 04:44:08.864977 kernel: secureboot: Secure boot disabled Jun 21 04:44:08.864984 kernel: SMBIOS 2.8 present. Jun 21 04:44:08.864991 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Jun 21 04:44:08.864999 kernel: DMI: Memory slots populated: 1/1 Jun 21 04:44:08.865006 kernel: Hypervisor detected: KVM Jun 21 04:44:08.865013 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 21 04:44:08.865020 kernel: kvm-clock: using sched offset of 4591197901 cycles Jun 21 04:44:08.865037 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 21 04:44:08.865048 kernel: tsc: Detected 2794.746 MHz processor Jun 21 04:44:08.865055 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 21 04:44:08.865066 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 21 04:44:08.865073 kernel: last_pfn = 0x9cedc max_arch_pfn = 0x400000000 Jun 21 04:44:08.865081 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jun 21 04:44:08.865088 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 21 04:44:08.865096 kernel: Using GB pages for direct mapping Jun 21 04:44:08.865103 kernel: ACPI: Early table checksum verification disabled Jun 21 04:44:08.865111 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Jun 21 04:44:08.865118 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Jun 21 04:44:08.865128 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865138 kernel: ACPI: DSDT 0x000000009CB7A000 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865145 kernel: ACPI: FACS 0x000000009CBDD000 000040 Jun 21 04:44:08.865153 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865160 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865180 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865188 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jun 21 04:44:08.865195 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Jun 21 04:44:08.865202 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Jun 21 04:44:08.865219 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1b9] Jun 21 04:44:08.865230 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Jun 21 04:44:08.865247 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Jun 21 04:44:08.865254 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Jun 21 04:44:08.865284 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Jun 21 04:44:08.865299 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Jun 21 04:44:08.865306 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Jun 21 04:44:08.865314 kernel: No NUMA configuration found Jun 21 04:44:08.865322 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cedbfff] Jun 21 04:44:08.865331 kernel: NODE_DATA(0) allocated [mem 0x9ce36dc0-0x9ce3dfff] Jun 21 04:44:08.865342 kernel: Zone ranges: Jun 21 04:44:08.865350 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 21 04:44:08.865366 kernel: DMA32 [mem 0x0000000001000000-0x000000009cedbfff] Jun 21 04:44:08.865374 kernel: Normal empty Jun 21 04:44:08.865381 kernel: Device empty Jun 21 04:44:08.865404 kernel: Movable zone start for each node Jun 21 04:44:08.865423 kernel: Early memory node ranges Jun 21 04:44:08.865431 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jun 21 04:44:08.865438 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Jun 21 04:44:08.865448 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Jun 21 04:44:08.865459 kernel: node 0: [mem 0x000000000080c000-0x0000000000810fff] Jun 21 04:44:08.865466 kernel: node 0: [mem 0x0000000000900000-0x000000009bd3efff] Jun 21 04:44:08.865473 kernel: node 0: [mem 0x000000009be00000-0x000000009c8ecfff] Jun 21 04:44:08.865481 kernel: node 0: [mem 0x000000009cbff000-0x000000009ce90fff] Jun 21 04:44:08.865488 kernel: node 0: [mem 0x000000009ce97000-0x000000009cedbfff] Jun 21 04:44:08.865495 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cedbfff] Jun 21 04:44:08.865505 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 21 04:44:08.865513 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jun 21 04:44:08.865530 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Jun 21 04:44:08.865537 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 21 04:44:08.865545 kernel: On node 0, zone DMA: 239 pages in unavailable ranges Jun 21 04:44:08.865553 kernel: On node 0, zone DMA32: 193 pages in unavailable ranges Jun 21 04:44:08.865563 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Jun 21 04:44:08.865570 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Jun 21 04:44:08.865578 kernel: On node 0, zone DMA32: 12580 pages in unavailable ranges Jun 21 04:44:08.865586 kernel: ACPI: PM-Timer IO Port: 0x608 Jun 21 04:44:08.865594 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 21 04:44:08.865604 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jun 21 04:44:08.865611 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jun 21 04:44:08.865625 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 21 04:44:08.865634 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 21 04:44:08.865642 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 21 04:44:08.865650 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 21 04:44:08.865657 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 21 04:44:08.865665 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 21 04:44:08.865673 kernel: TSC deadline timer available Jun 21 04:44:08.865692 kernel: CPU topo: Max. logical packages: 1 Jun 21 04:44:08.865702 kernel: CPU topo: Max. logical dies: 1 Jun 21 04:44:08.865711 kernel: CPU topo: Max. dies per package: 1 Jun 21 04:44:08.865721 kernel: CPU topo: Max. threads per core: 1 Jun 21 04:44:08.865730 kernel: CPU topo: Num. cores per package: 4 Jun 21 04:44:08.865742 kernel: CPU topo: Num. threads per package: 4 Jun 21 04:44:08.865752 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jun 21 04:44:08.865766 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jun 21 04:44:08.865776 kernel: kvm-guest: KVM setup pv remote TLB flush Jun 21 04:44:08.865789 kernel: kvm-guest: setup PV sched yield Jun 21 04:44:08.865798 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Jun 21 04:44:08.865808 kernel: Booting paravirtualized kernel on KVM Jun 21 04:44:08.865818 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 21 04:44:08.865827 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jun 21 04:44:08.865854 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Jun 21 04:44:08.865864 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Jun 21 04:44:08.865873 kernel: pcpu-alloc: [0] 0 1 2 3 Jun 21 04:44:08.865882 kernel: kvm-guest: PV spinlocks enabled Jun 21 04:44:08.865896 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 21 04:44:08.865916 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=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:44:08.865928 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jun 21 04:44:08.865935 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jun 21 04:44:08.865943 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 21 04:44:08.865951 kernel: Fallback order for Node 0: 0 Jun 21 04:44:08.865959 kernel: Built 1 zonelists, mobility grouping on. Total pages: 641450 Jun 21 04:44:08.865966 kernel: Policy zone: DMA32 Jun 21 04:44:08.865977 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 21 04:44:08.865990 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jun 21 04:44:08.866005 kernel: ftrace: allocating 40093 entries in 157 pages Jun 21 04:44:08.866015 kernel: ftrace: allocated 157 pages with 5 groups Jun 21 04:44:08.866022 kernel: Dynamic Preempt: voluntary Jun 21 04:44:08.866030 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 21 04:44:08.866041 kernel: rcu: RCU event tracing is enabled. Jun 21 04:44:08.866048 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jun 21 04:44:08.866056 kernel: Trampoline variant of Tasks RCU enabled. Jun 21 04:44:08.866067 kernel: Rude variant of Tasks RCU enabled. Jun 21 04:44:08.866075 kernel: Tracing variant of Tasks RCU enabled. Jun 21 04:44:08.866083 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 21 04:44:08.866099 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jun 21 04:44:08.866112 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 04:44:08.866120 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 04:44:08.866130 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jun 21 04:44:08.866139 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jun 21 04:44:08.866146 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 21 04:44:08.866158 kernel: Console: colour dummy device 80x25 Jun 21 04:44:08.866165 kernel: printk: legacy console [ttyS0] enabled Jun 21 04:44:08.866173 kernel: ACPI: Core revision 20240827 Jun 21 04:44:08.866181 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jun 21 04:44:08.866189 kernel: APIC: Switch to symmetric I/O mode setup Jun 21 04:44:08.866196 kernel: x2apic enabled Jun 21 04:44:08.866204 kernel: APIC: Switched APIC routing to: physical x2apic Jun 21 04:44:08.866212 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jun 21 04:44:08.866220 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jun 21 04:44:08.866230 kernel: kvm-guest: setup PV IPIs Jun 21 04:44:08.866237 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jun 21 04:44:08.866245 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jun 21 04:44:08.866253 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794746) Jun 21 04:44:08.866261 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jun 21 04:44:08.866269 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jun 21 04:44:08.866277 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jun 21 04:44:08.866284 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 21 04:44:08.866299 kernel: Spectre V2 : Mitigation: Retpolines Jun 21 04:44:08.866309 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jun 21 04:44:08.866317 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jun 21 04:44:08.866328 kernel: RETBleed: Mitigation: untrained return thunk Jun 21 04:44:08.866336 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jun 21 04:44:08.866346 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jun 21 04:44:08.866360 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jun 21 04:44:08.866371 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jun 21 04:44:08.866379 kernel: x86/bugs: return thunk changed Jun 21 04:44:08.866387 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jun 21 04:44:08.866398 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 21 04:44:08.866405 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 21 04:44:08.866413 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 21 04:44:08.866421 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 21 04:44:08.866431 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jun 21 04:44:08.866439 kernel: Freeing SMP alternatives memory: 32K Jun 21 04:44:08.866446 kernel: pid_max: default: 32768 minimum: 301 Jun 21 04:44:08.866454 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jun 21 04:44:08.866464 kernel: landlock: Up and running. Jun 21 04:44:08.866472 kernel: SELinux: Initializing. Jun 21 04:44:08.866480 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 04:44:08.866488 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jun 21 04:44:08.866498 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jun 21 04:44:08.866505 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jun 21 04:44:08.866513 kernel: ... version: 0 Jun 21 04:44:08.866521 kernel: ... bit width: 48 Jun 21 04:44:08.866528 kernel: ... generic registers: 6 Jun 21 04:44:08.866537 kernel: ... value mask: 0000ffffffffffff Jun 21 04:44:08.866547 kernel: ... max period: 00007fffffffffff Jun 21 04:44:08.866554 kernel: ... fixed-purpose events: 0 Jun 21 04:44:08.866562 kernel: ... event mask: 000000000000003f Jun 21 04:44:08.866570 kernel: signal: max sigframe size: 1776 Jun 21 04:44:08.866577 kernel: rcu: Hierarchical SRCU implementation. Jun 21 04:44:08.866585 kernel: rcu: Max phase no-delay instances is 400. Jun 21 04:44:08.866596 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jun 21 04:44:08.866604 kernel: smp: Bringing up secondary CPUs ... Jun 21 04:44:08.866614 kernel: smpboot: x86: Booting SMP configuration: Jun 21 04:44:08.866624 kernel: .... node #0, CPUs: #1 #2 #3 Jun 21 04:44:08.866632 kernel: smp: Brought up 1 node, 4 CPUs Jun 21 04:44:08.866639 kernel: smpboot: Total of 4 processors activated (22357.96 BogoMIPS) Jun 21 04:44:08.866647 kernel: Memory: 2422664K/2565800K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54424K init, 2544K bss, 137196K reserved, 0K cma-reserved) Jun 21 04:44:08.866655 kernel: devtmpfs: initialized Jun 21 04:44:08.866663 kernel: x86/mm: Memory block size: 128MB Jun 21 04:44:08.866671 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Jun 21 04:44:08.866679 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Jun 21 04:44:08.866687 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00811000-0x008fffff] (978944 bytes) Jun 21 04:44:08.866696 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Jun 21 04:44:08.866704 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9ce95000-0x9ce96fff] (8192 bytes) Jun 21 04:44:08.866712 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Jun 21 04:44:08.866720 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 21 04:44:08.866728 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jun 21 04:44:08.866740 kernel: pinctrl core: initialized pinctrl subsystem Jun 21 04:44:08.866748 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 21 04:44:08.866760 kernel: audit: initializing netlink subsys (disabled) Jun 21 04:44:08.866778 kernel: audit: type=2000 audit(1750481046.524:1): state=initialized audit_enabled=0 res=1 Jun 21 04:44:08.866793 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 21 04:44:08.866811 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 21 04:44:08.866819 kernel: cpuidle: using governor menu Jun 21 04:44:08.866827 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 21 04:44:08.866850 kernel: dca service started, version 1.12.1 Jun 21 04:44:08.866858 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Jun 21 04:44:08.866866 kernel: PCI: Using configuration type 1 for base access Jun 21 04:44:08.866873 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 21 04:44:08.866884 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 21 04:44:08.866892 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 21 04:44:08.866899 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 21 04:44:08.866907 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 21 04:44:08.866915 kernel: ACPI: Added _OSI(Module Device) Jun 21 04:44:08.866922 kernel: ACPI: Added _OSI(Processor Device) Jun 21 04:44:08.866930 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 21 04:44:08.866938 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jun 21 04:44:08.866945 kernel: ACPI: Interpreter enabled Jun 21 04:44:08.866955 kernel: ACPI: PM: (supports S0 S3 S5) Jun 21 04:44:08.866963 kernel: ACPI: Using IOAPIC for interrupt routing Jun 21 04:44:08.866981 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 21 04:44:08.866989 kernel: PCI: Using E820 reservations for host bridge windows Jun 21 04:44:08.866997 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jun 21 04:44:08.867005 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 21 04:44:08.867601 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jun 21 04:44:08.867774 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jun 21 04:44:08.867960 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jun 21 04:44:08.867975 kernel: PCI host bridge to bus 0000:00 Jun 21 04:44:08.868121 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 21 04:44:08.868233 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 21 04:44:08.868358 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 21 04:44:08.868469 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Jun 21 04:44:08.868577 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Jun 21 04:44:08.868691 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Jun 21 04:44:08.868873 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 21 04:44:08.869041 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Jun 21 04:44:08.869280 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jun 21 04:44:08.869417 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Jun 21 04:44:08.869538 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Jun 21 04:44:08.869677 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Jun 21 04:44:08.869821 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 21 04:44:08.869983 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jun 21 04:44:08.870106 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Jun 21 04:44:08.870226 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Jun 21 04:44:08.870395 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Jun 21 04:44:08.870616 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Jun 21 04:44:08.870794 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Jun 21 04:44:08.870990 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Jun 21 04:44:08.871143 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Jun 21 04:44:08.871328 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Jun 21 04:44:08.871485 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Jun 21 04:44:08.871633 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Jun 21 04:44:08.871784 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Jun 21 04:44:08.871999 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Jun 21 04:44:08.872176 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Jun 21 04:44:08.872379 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jun 21 04:44:08.872562 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jun 21 04:44:08.872753 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Jun 21 04:44:08.872931 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Jun 21 04:44:08.873103 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Jun 21 04:44:08.873262 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Jun 21 04:44:08.873278 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jun 21 04:44:08.873298 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jun 21 04:44:08.873309 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jun 21 04:44:08.873319 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jun 21 04:44:08.873329 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jun 21 04:44:08.873340 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jun 21 04:44:08.873350 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jun 21 04:44:08.873365 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jun 21 04:44:08.873376 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jun 21 04:44:08.873386 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jun 21 04:44:08.873397 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jun 21 04:44:08.873407 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jun 21 04:44:08.873418 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jun 21 04:44:08.873428 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jun 21 04:44:08.873439 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jun 21 04:44:08.873449 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jun 21 04:44:08.873462 kernel: iommu: Default domain type: Translated Jun 21 04:44:08.873473 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 21 04:44:08.873483 kernel: efivars: Registered efivars operations Jun 21 04:44:08.873494 kernel: PCI: Using ACPI for IRQ routing Jun 21 04:44:08.873504 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 21 04:44:08.873515 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Jun 21 04:44:08.873525 kernel: e820: reserve RAM buffer [mem 0x00811000-0x008fffff] Jun 21 04:44:08.873536 kernel: e820: reserve RAM buffer [mem 0x9b2e3018-0x9bffffff] Jun 21 04:44:08.873546 kernel: e820: reserve RAM buffer [mem 0x9b320018-0x9bffffff] Jun 21 04:44:08.873559 kernel: e820: reserve RAM buffer [mem 0x9bd3f000-0x9bffffff] Jun 21 04:44:08.873569 kernel: e820: reserve RAM buffer [mem 0x9c8ed000-0x9fffffff] Jun 21 04:44:08.873580 kernel: e820: reserve RAM buffer [mem 0x9ce91000-0x9fffffff] Jun 21 04:44:08.873590 kernel: e820: reserve RAM buffer [mem 0x9cedc000-0x9fffffff] Jun 21 04:44:08.873762 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jun 21 04:44:08.873996 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jun 21 04:44:08.874152 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 21 04:44:08.874168 kernel: vgaarb: loaded Jun 21 04:44:08.874185 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jun 21 04:44:08.874196 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jun 21 04:44:08.874206 kernel: clocksource: Switched to clocksource kvm-clock Jun 21 04:44:08.874216 kernel: VFS: Disk quotas dquot_6.6.0 Jun 21 04:44:08.874226 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 21 04:44:08.874236 kernel: pnp: PnP ACPI init Jun 21 04:44:08.874435 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Jun 21 04:44:08.874474 kernel: pnp: PnP ACPI: found 6 devices Jun 21 04:44:08.874490 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 21 04:44:08.874500 kernel: NET: Registered PF_INET protocol family Jun 21 04:44:08.874510 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jun 21 04:44:08.874521 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jun 21 04:44:08.874531 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 21 04:44:08.874541 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 21 04:44:08.874551 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jun 21 04:44:08.874562 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jun 21 04:44:08.874573 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 04:44:08.874587 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jun 21 04:44:08.874597 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 21 04:44:08.874607 kernel: NET: Registered PF_XDP protocol family Jun 21 04:44:08.874796 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Jun 21 04:44:08.874966 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Jun 21 04:44:08.875102 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 21 04:44:08.875214 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 21 04:44:08.875333 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 21 04:44:08.875449 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Jun 21 04:44:08.875599 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Jun 21 04:44:08.875757 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Jun 21 04:44:08.875778 kernel: PCI: CLS 0 bytes, default 64 Jun 21 04:44:08.875793 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848ddd4e75, max_idle_ns: 440795346320 ns Jun 21 04:44:08.875807 kernel: Initialise system trusted keyrings Jun 21 04:44:08.875821 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jun 21 04:44:08.875859 kernel: Key type asymmetric registered Jun 21 04:44:08.875881 kernel: Asymmetric key parser 'x509' registered Jun 21 04:44:08.875895 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jun 21 04:44:08.875909 kernel: io scheduler mq-deadline registered Jun 21 04:44:08.875927 kernel: io scheduler kyber registered Jun 21 04:44:08.875938 kernel: io scheduler bfq registered Jun 21 04:44:08.875949 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 21 04:44:08.875963 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jun 21 04:44:08.875975 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jun 21 04:44:08.875986 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jun 21 04:44:08.875997 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 21 04:44:08.876008 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 21 04:44:08.876020 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 21 04:44:08.876031 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 21 04:44:08.876042 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 21 04:44:08.876220 kernel: rtc_cmos 00:04: RTC can wake from S4 Jun 21 04:44:08.876243 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jun 21 04:44:08.876407 kernel: rtc_cmos 00:04: registered as rtc0 Jun 21 04:44:08.876553 kernel: rtc_cmos 00:04: setting system clock to 2025-06-21T04:44:08 UTC (1750481048) Jun 21 04:44:08.876707 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Jun 21 04:44:08.876728 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jun 21 04:44:08.876742 kernel: efifb: probing for efifb Jun 21 04:44:08.876755 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Jun 21 04:44:08.876769 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Jun 21 04:44:08.876786 kernel: efifb: scrolling: redraw Jun 21 04:44:08.876797 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jun 21 04:44:08.876808 kernel: Console: switching to colour frame buffer device 160x50 Jun 21 04:44:08.876819 kernel: fb0: EFI VGA frame buffer device Jun 21 04:44:08.876830 kernel: pstore: Using crash dump compression: deflate Jun 21 04:44:08.876866 kernel: pstore: Registered efi_pstore as persistent store backend Jun 21 04:44:08.876877 kernel: NET: Registered PF_INET6 protocol family Jun 21 04:44:08.876889 kernel: Segment Routing with IPv6 Jun 21 04:44:08.876899 kernel: In-situ OAM (IOAM) with IPv6 Jun 21 04:44:08.876911 kernel: NET: Registered PF_PACKET protocol family Jun 21 04:44:08.876919 kernel: Key type dns_resolver registered Jun 21 04:44:08.876927 kernel: IPI shorthand broadcast: enabled Jun 21 04:44:08.876936 kernel: sched_clock: Marking stable (3610003492, 164976644)->(3802569141, -27589005) Jun 21 04:44:08.876944 kernel: registered taskstats version 1 Jun 21 04:44:08.876952 kernel: Loading compiled-in X.509 certificates Jun 21 04:44:08.876960 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.34-flatcar: ec4617d162e00e1890f71f252cdf44036a7b66f7' Jun 21 04:44:08.876969 kernel: Demotion targets for Node 0: null Jun 21 04:44:08.876976 kernel: Key type .fscrypt registered Jun 21 04:44:08.876987 kernel: Key type fscrypt-provisioning registered Jun 21 04:44:08.876995 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 21 04:44:08.877003 kernel: ima: Allocated hash algorithm: sha1 Jun 21 04:44:08.877011 kernel: ima: No architecture policies found Jun 21 04:44:08.877020 kernel: clk: Disabling unused clocks Jun 21 04:44:08.877028 kernel: Warning: unable to open an initial console. Jun 21 04:44:08.877036 kernel: Freeing unused kernel image (initmem) memory: 54424K Jun 21 04:44:08.877044 kernel: Write protecting the kernel read-only data: 24576k Jun 21 04:44:08.877055 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jun 21 04:44:08.877063 kernel: Run /init as init process Jun 21 04:44:08.877071 kernel: with arguments: Jun 21 04:44:08.877079 kernel: /init Jun 21 04:44:08.877090 kernel: with environment: Jun 21 04:44:08.877097 kernel: HOME=/ Jun 21 04:44:08.877105 kernel: TERM=linux Jun 21 04:44:08.877113 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jun 21 04:44:08.877123 systemd[1]: Successfully made /usr/ read-only. Jun 21 04:44:08.877137 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jun 21 04:44:08.877147 systemd[1]: Detected virtualization kvm. Jun 21 04:44:08.877155 systemd[1]: Detected architecture x86-64. Jun 21 04:44:08.877164 systemd[1]: Running in initrd. Jun 21 04:44:08.877172 systemd[1]: No hostname configured, using default hostname. Jun 21 04:44:08.877181 systemd[1]: Hostname set to . Jun 21 04:44:08.877189 systemd[1]: Initializing machine ID from VM UUID. Jun 21 04:44:08.877198 systemd[1]: Queued start job for default target initrd.target. Jun 21 04:44:08.877209 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:44:08.877219 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:44:08.877232 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 21 04:44:08.877244 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 04:44:08.877256 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 21 04:44:08.877266 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 21 04:44:08.877283 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 21 04:44:08.877307 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 21 04:44:08.877319 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:44:08.877331 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:44:08.877342 systemd[1]: Reached target paths.target - Path Units. Jun 21 04:44:08.877354 systemd[1]: Reached target slices.target - Slice Units. Jun 21 04:44:08.877365 systemd[1]: Reached target swap.target - Swaps. Jun 21 04:44:08.877375 systemd[1]: Reached target timers.target - Timer Units. Jun 21 04:44:08.877384 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 04:44:08.877396 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 04:44:08.877405 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 21 04:44:08.877413 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jun 21 04:44:08.877423 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:44:08.877435 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 04:44:08.877446 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:44:08.877458 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 04:44:08.877470 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 21 04:44:08.877485 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 04:44:08.877497 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 21 04:44:08.877509 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Jun 21 04:44:08.877524 systemd[1]: Starting systemd-fsck-usr.service... Jun 21 04:44:08.877536 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 04:44:08.877547 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 04:44:08.877559 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:08.877571 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 21 04:44:08.877586 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:44:08.877598 systemd[1]: Finished systemd-fsck-usr.service. Jun 21 04:44:08.877610 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 04:44:08.877654 systemd-journald[220]: Collecting audit messages is disabled. Jun 21 04:44:08.877682 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:08.877692 systemd-journald[220]: Journal started Jun 21 04:44:08.877721 systemd-journald[220]: Runtime Journal (/run/log/journal/9977c85dbc944c79834d71ff88b20a4f) is 6M, max 48.5M, 42.4M free. Jun 21 04:44:08.867513 systemd-modules-load[222]: Inserted module 'overlay' Jun 21 04:44:08.880863 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 21 04:44:08.882859 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 04:44:08.897876 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 21 04:44:08.898043 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 04:44:08.900868 kernel: Bridge firewalling registered Jun 21 04:44:08.901592 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 04:44:08.901739 systemd-modules-load[222]: Inserted module 'br_netfilter' Jun 21 04:44:08.905671 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 04:44:08.906420 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 04:44:08.910113 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 04:44:08.925574 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 04:44:08.927339 systemd-tmpfiles[240]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jun 21 04:44:08.927371 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:44:08.930039 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:44:08.934384 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 21 04:44:08.936449 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:44:08.953684 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 04:44:08.969650 dracut-cmdline[260]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=d3c0be6f64121476b0313f5d7d7bbd73e21bc1a219aacd38b8006b291898eca1 Jun 21 04:44:09.016194 systemd-resolved[262]: Positive Trust Anchors: Jun 21 04:44:09.016214 systemd-resolved[262]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 04:44:09.016254 systemd-resolved[262]: 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 Jun 21 04:44:09.019593 systemd-resolved[262]: Defaulting to hostname 'linux'. Jun 21 04:44:09.021084 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 04:44:09.026951 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:44:09.095873 kernel: SCSI subsystem initialized Jun 21 04:44:09.108868 kernel: Loading iSCSI transport class v2.0-870. Jun 21 04:44:09.122870 kernel: iscsi: registered transport (tcp) Jun 21 04:44:09.146084 kernel: iscsi: registered transport (qla4xxx) Jun 21 04:44:09.146132 kernel: QLogic iSCSI HBA Driver Jun 21 04:44:09.171024 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 04:44:09.202306 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:44:09.205312 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 04:44:09.267609 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 21 04:44:09.269572 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 21 04:44:09.342889 kernel: raid6: avx2x4 gen() 28653 MB/s Jun 21 04:44:09.359871 kernel: raid6: avx2x2 gen() 26083 MB/s Jun 21 04:44:09.384024 kernel: raid6: avx2x1 gen() 14894 MB/s Jun 21 04:44:09.384110 kernel: raid6: using algorithm avx2x4 gen() 28653 MB/s Jun 21 04:44:09.402257 kernel: raid6: .... xor() 6385 MB/s, rmw enabled Jun 21 04:44:09.402346 kernel: raid6: using avx2x2 recovery algorithm Jun 21 04:44:09.427905 kernel: xor: automatically using best checksumming function avx Jun 21 04:44:09.620887 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 21 04:44:09.631573 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 21 04:44:09.634786 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:44:09.666421 systemd-udevd[471]: Using default interface naming scheme 'v255'. Jun 21 04:44:09.672154 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:44:09.696210 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 21 04:44:09.728302 dracut-pre-trigger[483]: rd.md=0: removing MD RAID activation Jun 21 04:44:09.763978 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 04:44:09.766036 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 04:44:09.859995 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:44:09.864715 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 21 04:44:09.898894 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jun 21 04:44:09.902815 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jun 21 04:44:09.909354 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jun 21 04:44:09.909416 kernel: GPT:9289727 != 19775487 Jun 21 04:44:09.909444 kernel: GPT:Alternate GPT header not at the end of the disk. Jun 21 04:44:09.909469 kernel: GPT:9289727 != 19775487 Jun 21 04:44:09.909496 kernel: GPT: Use GNU Parted to correct GPT errors. Jun 21 04:44:09.909523 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 04:44:09.935880 kernel: cryptd: max_cpu_qlen set to 1000 Jun 21 04:44:09.939861 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Jun 21 04:44:09.958863 kernel: AES CTR mode by8 optimization enabled Jun 21 04:44:09.958910 kernel: libata version 3.00 loaded. Jun 21 04:44:09.963970 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:44:09.964111 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:10.000218 kernel: ahci 0000:00:1f.2: version 3.0 Jun 21 04:44:10.000555 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jun 21 04:44:10.000571 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jun 21 04:44:10.000718 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Jun 21 04:44:10.000939 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jun 21 04:44:10.004248 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:10.010898 kernel: scsi host0: ahci Jun 21 04:44:10.013111 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:10.014909 kernel: scsi host1: ahci Jun 21 04:44:10.015971 kernel: scsi host2: ahci Jun 21 04:44:10.018914 kernel: scsi host3: ahci Jun 21 04:44:10.018377 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:44:10.024431 kernel: scsi host4: ahci Jun 21 04:44:10.025132 kernel: scsi host5: ahci Jun 21 04:44:10.025445 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0 Jun 21 04:44:10.026151 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0 Jun 21 04:44:10.030858 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0 Jun 21 04:44:10.030895 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0 Jun 21 04:44:10.030910 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0 Jun 21 04:44:10.030923 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0 Jun 21 04:44:10.056689 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jun 21 04:44:10.059719 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:10.072387 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jun 21 04:44:10.089846 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 04:44:10.100068 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jun 21 04:44:10.103457 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jun 21 04:44:10.107702 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 21 04:44:10.110061 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:44:10.110269 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:10.113675 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:10.120678 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:10.123294 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:44:10.131752 disk-uuid[635]: Primary Header is updated. Jun 21 04:44:10.131752 disk-uuid[635]: Secondary Entries is updated. Jun 21 04:44:10.131752 disk-uuid[635]: Secondary Header is updated. Jun 21 04:44:10.135889 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 04:44:10.141874 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 04:44:10.149958 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:10.341159 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jun 21 04:44:10.341253 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jun 21 04:44:10.341266 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jun 21 04:44:10.342868 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jun 21 04:44:10.342942 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jun 21 04:44:10.343859 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jun 21 04:44:10.344864 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jun 21 04:44:10.359175 kernel: ata3.00: applying bridge limits Jun 21 04:44:10.359861 kernel: ata3.00: configured for UDMA/100 Jun 21 04:44:10.361890 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jun 21 04:44:10.413871 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jun 21 04:44:10.414116 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jun 21 04:44:10.439870 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jun 21 04:44:10.824173 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 21 04:44:10.824815 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 04:44:10.828033 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:44:10.830692 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 04:44:10.834137 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 21 04:44:10.868565 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 21 04:44:11.143665 disk-uuid[638]: The operation has completed successfully. Jun 21 04:44:11.145464 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jun 21 04:44:11.180761 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 21 04:44:11.180912 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 21 04:44:11.216363 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 21 04:44:11.241951 sh[670]: Success Jun 21 04:44:11.261879 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 21 04:44:11.261938 kernel: device-mapper: uevent: version 1.0.3 Jun 21 04:44:11.261953 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jun 21 04:44:11.271873 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jun 21 04:44:11.307924 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 21 04:44:11.310381 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 21 04:44:11.326752 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 21 04:44:11.334796 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jun 21 04:44:11.334853 kernel: BTRFS: device fsid bfb8168c-5be0-428c-83e7-820ccaf1f8e9 devid 1 transid 41 /dev/mapper/usr (253:0) scanned by mount (682) Jun 21 04:44:11.337089 kernel: BTRFS info (device dm-0): first mount of filesystem bfb8168c-5be0-428c-83e7-820ccaf1f8e9 Jun 21 04:44:11.337111 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:44:11.337122 kernel: BTRFS info (device dm-0): using free-space-tree Jun 21 04:44:11.342390 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 21 04:44:11.342996 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jun 21 04:44:11.345337 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 21 04:44:11.346238 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 21 04:44:11.348303 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 21 04:44:11.382859 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (713) Jun 21 04:44:11.385499 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:44:11.385559 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:44:11.385579 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 04:44:11.393876 kernel: BTRFS info (device vda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:44:11.394472 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 21 04:44:11.397348 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 21 04:44:11.542736 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 04:44:11.546363 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 04:44:11.711930 ignition[754]: Ignition 2.21.0 Jun 21 04:44:11.711942 ignition[754]: Stage: fetch-offline Jun 21 04:44:11.712072 ignition[754]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:11.712093 ignition[754]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:11.712223 ignition[754]: parsed url from cmdline: "" Jun 21 04:44:11.712234 ignition[754]: no config URL provided Jun 21 04:44:11.712239 ignition[754]: reading system config file "/usr/lib/ignition/user.ign" Jun 21 04:44:11.712250 ignition[754]: no config at "/usr/lib/ignition/user.ign" Jun 21 04:44:11.712866 ignition[754]: op(1): [started] loading QEMU firmware config module Jun 21 04:44:11.712875 ignition[754]: op(1): executing: "modprobe" "qemu_fw_cfg" Jun 21 04:44:11.724233 systemd-networkd[859]: lo: Link UP Jun 21 04:44:11.724245 systemd-networkd[859]: lo: Gained carrier Jun 21 04:44:11.726020 systemd-networkd[859]: Enumeration completed Jun 21 04:44:11.726456 systemd-networkd[859]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:44:11.726650 ignition[754]: op(1): [finished] loading QEMU firmware config module Jun 21 04:44:11.726460 systemd-networkd[859]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 04:44:11.731305 ignition[754]: parsing config with SHA512: ef78b7ada54c8b5dbfc8859ab86e6bb5727238575e8a89bf3ad84260c451a7c044376ddc147d2c5440af634b867f56b9480892b0c5666601860abd2e4844482f Jun 21 04:44:11.727594 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 04:44:11.734419 ignition[754]: fetch-offline: fetch-offline passed Jun 21 04:44:11.730103 systemd-networkd[859]: eth0: Link UP Jun 21 04:44:11.734475 ignition[754]: Ignition finished successfully Jun 21 04:44:11.730106 systemd-networkd[859]: eth0: Gained carrier Jun 21 04:44:11.730115 systemd-networkd[859]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:44:11.731312 systemd[1]: Reached target network.target - Network. Jun 21 04:44:11.734152 unknown[754]: fetched base config from "system" Jun 21 04:44:11.734161 unknown[754]: fetched user config from "qemu" Jun 21 04:44:11.737978 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 04:44:11.740208 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jun 21 04:44:11.741076 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 21 04:44:11.743935 systemd-networkd[859]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 04:44:11.790656 ignition[865]: Ignition 2.21.0 Jun 21 04:44:11.790671 ignition[865]: Stage: kargs Jun 21 04:44:11.790828 ignition[865]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:11.790875 ignition[865]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:11.791538 ignition[865]: kargs: kargs passed Jun 21 04:44:11.791595 ignition[865]: Ignition finished successfully Jun 21 04:44:11.799314 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 21 04:44:11.800624 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 21 04:44:11.841131 ignition[874]: Ignition 2.21.0 Jun 21 04:44:11.841146 ignition[874]: Stage: disks Jun 21 04:44:11.841307 ignition[874]: no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:11.841320 ignition[874]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:11.841945 ignition[874]: disks: disks passed Jun 21 04:44:11.841989 ignition[874]: Ignition finished successfully Jun 21 04:44:11.847257 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 21 04:44:11.847858 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 21 04:44:11.851640 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 21 04:44:11.851723 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 04:44:11.854085 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 04:44:11.855966 systemd[1]: Reached target basic.target - Basic System. Jun 21 04:44:11.857425 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 21 04:44:11.859019 systemd-resolved[262]: Detected conflict on linux IN A 10.0.0.110 Jun 21 04:44:11.859033 systemd-resolved[262]: Hostname conflict, changing published hostname from 'linux' to 'linux6'. Jun 21 04:44:11.977782 systemd-fsck[884]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jun 21 04:44:11.987787 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 21 04:44:11.992472 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 21 04:44:12.116889 kernel: EXT4-fs (vda9): mounted filesystem 6d18c974-0fd6-4e4a-98cf-62524fcf9e99 r/w with ordered data mode. Quota mode: none. Jun 21 04:44:12.117721 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 21 04:44:12.120002 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 21 04:44:12.123670 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 04:44:12.126226 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 21 04:44:12.128234 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jun 21 04:44:12.128282 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 21 04:44:12.128306 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 04:44:12.138050 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 21 04:44:12.139621 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 21 04:44:12.168053 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (892) Jun 21 04:44:12.170738 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:44:12.170772 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:44:12.170787 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 04:44:12.177255 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 04:44:12.192790 initrd-setup-root[916]: cut: /sysroot/etc/passwd: No such file or directory Jun 21 04:44:12.197626 initrd-setup-root[923]: cut: /sysroot/etc/group: No such file or directory Jun 21 04:44:12.203046 initrd-setup-root[930]: cut: /sysroot/etc/shadow: No such file or directory Jun 21 04:44:12.207949 initrd-setup-root[937]: cut: /sysroot/etc/gshadow: No such file or directory Jun 21 04:44:12.309688 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 21 04:44:12.312208 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 21 04:44:12.314552 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 21 04:44:12.335033 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 21 04:44:12.336862 kernel: BTRFS info (device vda6): last unmount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:44:12.352461 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 21 04:44:12.371749 ignition[1006]: INFO : Ignition 2.21.0 Jun 21 04:44:12.371749 ignition[1006]: INFO : Stage: mount Jun 21 04:44:12.374616 ignition[1006]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:12.374616 ignition[1006]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:12.374616 ignition[1006]: INFO : mount: mount passed Jun 21 04:44:12.374616 ignition[1006]: INFO : Ignition finished successfully Jun 21 04:44:12.378277 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 21 04:44:12.382023 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 21 04:44:12.407012 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 21 04:44:12.440877 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 (254:6) scanned by mount (1018) Jun 21 04:44:12.443243 kernel: BTRFS info (device vda6): first mount of filesystem 57d2b200-37a8-4067-8765-910d3ed0182c Jun 21 04:44:12.443270 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jun 21 04:44:12.443286 kernel: BTRFS info (device vda6): using free-space-tree Jun 21 04:44:12.448088 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 21 04:44:12.487326 ignition[1035]: INFO : Ignition 2.21.0 Jun 21 04:44:12.487326 ignition[1035]: INFO : Stage: files Jun 21 04:44:12.489407 ignition[1035]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:12.489407 ignition[1035]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:12.492450 ignition[1035]: DEBUG : files: compiled without relabeling support, skipping Jun 21 04:44:12.493963 ignition[1035]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 21 04:44:12.493963 ignition[1035]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 21 04:44:12.497266 ignition[1035]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 21 04:44:12.497266 ignition[1035]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 21 04:44:12.500453 ignition[1035]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 21 04:44:12.500453 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jun 21 04:44:12.500453 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jun 21 04:44:12.497518 unknown[1035]: wrote ssh authorized keys file for user: core Jun 21 04:44:12.507030 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 04:44:12.507030 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 21 04:44:12.507030 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jun 21 04:44:12.513246 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jun 21 04:44:12.513246 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jun 21 04:44:12.513246 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-x86-64.raw: attempt #1 Jun 21 04:44:13.133627 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jun 21 04:44:13.293209 systemd-networkd[859]: eth0: Gained IPv6LL Jun 21 04:44:13.816632 ignition[1035]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Jun 21 04:44:13.816632 ignition[1035]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jun 21 04:44:13.820990 ignition[1035]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 04:44:13.826053 ignition[1035]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jun 21 04:44:13.826053 ignition[1035]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jun 21 04:44:13.826053 ignition[1035]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jun 21 04:44:13.854586 ignition[1035]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 04:44:13.860504 ignition[1035]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jun 21 04:44:13.862168 ignition[1035]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jun 21 04:44:13.862168 ignition[1035]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 21 04:44:13.862168 ignition[1035]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 21 04:44:13.862168 ignition[1035]: INFO : files: files passed Jun 21 04:44:13.862168 ignition[1035]: INFO : Ignition finished successfully Jun 21 04:44:13.871885 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 21 04:44:13.874502 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 21 04:44:13.876995 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 21 04:44:13.899620 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 21 04:44:13.899822 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 21 04:44:13.904037 initrd-setup-root-after-ignition[1064]: grep: /sysroot/oem/oem-release: No such file or directory Jun 21 04:44:13.907309 initrd-setup-root-after-ignition[1070]: grep: Jun 21 04:44:13.907309 initrd-setup-root-after-ignition[1066]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:44:13.910557 initrd-setup-root-after-ignition[1066]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:44:13.912391 initrd-setup-root-after-ignition[1070]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 21 04:44:13.913331 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 04:44:13.916072 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 21 04:44:13.920030 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 21 04:44:13.983779 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 21 04:44:13.985174 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 21 04:44:13.988296 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 21 04:44:13.988411 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 21 04:44:13.992953 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 21 04:44:13.994948 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 21 04:44:14.030335 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 04:44:14.031999 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 21 04:44:14.070178 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:44:14.072799 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:44:14.075452 systemd[1]: Stopped target timers.target - Timer Units. Jun 21 04:44:14.077525 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 21 04:44:14.078669 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 21 04:44:14.081528 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 21 04:44:14.083860 systemd[1]: Stopped target basic.target - Basic System. Jun 21 04:44:14.085715 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 21 04:44:14.087916 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 21 04:44:14.090256 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 21 04:44:14.092490 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jun 21 04:44:14.094730 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 21 04:44:14.096799 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 21 04:44:14.099299 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 21 04:44:14.101376 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 21 04:44:14.103422 systemd[1]: Stopped target swap.target - Swaps. Jun 21 04:44:14.105054 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 21 04:44:14.106071 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 21 04:44:14.108934 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:44:14.111594 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:44:14.114276 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 21 04:44:14.115341 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:44:14.118209 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 21 04:44:14.118373 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 21 04:44:14.121903 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 21 04:44:14.122078 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 21 04:44:14.123619 systemd[1]: Stopped target paths.target - Path Units. Jun 21 04:44:14.126004 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 21 04:44:14.130907 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:44:14.131132 systemd[1]: Stopped target slices.target - Slice Units. Jun 21 04:44:14.133928 systemd[1]: Stopped target sockets.target - Socket Units. Jun 21 04:44:14.135762 systemd[1]: iscsid.socket: Deactivated successfully. Jun 21 04:44:14.135917 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 21 04:44:14.137768 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 21 04:44:14.137944 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 21 04:44:14.139576 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 21 04:44:14.139751 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 21 04:44:14.141544 systemd[1]: ignition-files.service: Deactivated successfully. Jun 21 04:44:14.141698 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 21 04:44:14.147106 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 21 04:44:14.151170 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 21 04:44:14.151495 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 21 04:44:14.151712 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:44:14.154756 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 21 04:44:14.154938 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 21 04:44:14.163563 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 21 04:44:14.163998 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 21 04:44:14.185756 ignition[1090]: INFO : Ignition 2.21.0 Jun 21 04:44:14.185756 ignition[1090]: INFO : Stage: umount Jun 21 04:44:14.187606 ignition[1090]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 21 04:44:14.187606 ignition[1090]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jun 21 04:44:14.187472 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 21 04:44:14.191901 ignition[1090]: INFO : umount: umount passed Jun 21 04:44:14.191901 ignition[1090]: INFO : Ignition finished successfully Jun 21 04:44:14.194208 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 21 04:44:14.194342 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 21 04:44:14.196636 systemd[1]: Stopped target network.target - Network. Jun 21 04:44:14.197475 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 21 04:44:14.197527 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 21 04:44:14.201068 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 21 04:44:14.201135 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 21 04:44:14.202127 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 21 04:44:14.202185 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 21 04:44:14.202467 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 21 04:44:14.202516 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 21 04:44:14.202976 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 21 04:44:14.203406 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 21 04:44:14.213035 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 21 04:44:14.213284 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 21 04:44:14.218530 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jun 21 04:44:14.218907 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 21 04:44:14.218966 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:44:14.223395 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:44:14.232166 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 21 04:44:14.232380 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 21 04:44:14.236620 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jun 21 04:44:14.236890 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jun 21 04:44:14.238168 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 21 04:44:14.238211 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:44:14.242494 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 21 04:44:14.248009 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 21 04:44:14.249943 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 21 04:44:14.252422 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 21 04:44:14.252481 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:44:14.255329 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 21 04:44:14.255386 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 21 04:44:14.256440 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:44:14.257604 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jun 21 04:44:14.271192 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 21 04:44:14.271335 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 21 04:44:14.297691 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 21 04:44:14.297896 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:44:14.299127 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 21 04:44:14.299178 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 21 04:44:14.302726 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 21 04:44:14.302765 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:44:14.303864 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 21 04:44:14.303915 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 21 04:44:14.308299 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 21 04:44:14.308353 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 21 04:44:14.309772 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 21 04:44:14.309825 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 21 04:44:14.315349 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 21 04:44:14.316373 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jun 21 04:44:14.316430 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:44:14.324484 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 21 04:44:14.324563 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:44:14.328339 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jun 21 04:44:14.328409 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 04:44:14.332405 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 21 04:44:14.332467 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:44:14.334729 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:44:14.334779 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:14.338980 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 21 04:44:14.339092 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 21 04:44:14.364244 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 21 04:44:14.364400 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 21 04:44:14.365681 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 21 04:44:14.368489 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 21 04:44:14.368548 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 21 04:44:14.373073 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 21 04:44:14.398978 systemd[1]: Switching root. Jun 21 04:44:14.441007 systemd-journald[220]: Journal stopped Jun 21 04:44:15.779331 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Jun 21 04:44:15.779391 kernel: SELinux: policy capability network_peer_controls=1 Jun 21 04:44:15.779412 kernel: SELinux: policy capability open_perms=1 Jun 21 04:44:15.779424 kernel: SELinux: policy capability extended_socket_class=1 Jun 21 04:44:15.779439 kernel: SELinux: policy capability always_check_network=0 Jun 21 04:44:15.779453 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 21 04:44:15.779465 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 21 04:44:15.779476 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 21 04:44:15.779492 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 21 04:44:15.779504 kernel: SELinux: policy capability userspace_initial_context=0 Jun 21 04:44:15.779522 kernel: audit: type=1403 audit(1750481054.818:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 21 04:44:15.779537 systemd[1]: Successfully loaded SELinux policy in 52.580ms. Jun 21 04:44:15.779558 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 13.555ms. Jun 21 04:44:15.779574 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jun 21 04:44:15.779586 systemd[1]: Detected virtualization kvm. Jun 21 04:44:15.779598 systemd[1]: Detected architecture x86-64. Jun 21 04:44:15.779610 systemd[1]: Detected first boot. Jun 21 04:44:15.779622 systemd[1]: Initializing machine ID from VM UUID. Jun 21 04:44:15.779634 zram_generator::config[1135]: No configuration found. Jun 21 04:44:15.779652 kernel: Guest personality initialized and is inactive Jun 21 04:44:15.779665 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Jun 21 04:44:15.779679 kernel: Initialized host personality Jun 21 04:44:15.779696 kernel: NET: Registered PF_VSOCK protocol family Jun 21 04:44:15.779716 systemd[1]: Populated /etc with preset unit settings. Jun 21 04:44:15.779733 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jun 21 04:44:15.779748 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 21 04:44:15.779763 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 21 04:44:15.779783 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 21 04:44:15.779798 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 21 04:44:15.779816 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 21 04:44:15.779830 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 21 04:44:15.779966 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 21 04:44:15.779979 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 21 04:44:15.779992 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 21 04:44:15.780004 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 21 04:44:15.780016 systemd[1]: Created slice user.slice - User and Session Slice. Jun 21 04:44:15.780028 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 21 04:44:15.780041 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 21 04:44:15.780053 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 21 04:44:15.780076 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 21 04:44:15.780089 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 21 04:44:15.780101 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 21 04:44:15.780113 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jun 21 04:44:15.780126 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 21 04:44:15.780138 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 21 04:44:15.780150 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 21 04:44:15.780162 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 21 04:44:15.780176 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 21 04:44:15.780188 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 21 04:44:15.780199 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 21 04:44:15.780211 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 21 04:44:15.780223 systemd[1]: Reached target slices.target - Slice Units. Jun 21 04:44:15.780236 systemd[1]: Reached target swap.target - Swaps. Jun 21 04:44:15.780248 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 21 04:44:15.780259 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 21 04:44:15.780272 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jun 21 04:44:15.780286 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 21 04:44:15.780298 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 21 04:44:15.780310 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 21 04:44:15.780322 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 21 04:44:15.780334 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 21 04:44:15.780346 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 21 04:44:15.780358 systemd[1]: Mounting media.mount - External Media Directory... Jun 21 04:44:15.780370 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:15.780383 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 21 04:44:15.780397 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 21 04:44:15.780409 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 21 04:44:15.780421 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). Jun 21 04:44:15.780434 systemd[1]: Reached target machines.target - Containers. Jun 21 04:44:15.780446 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 21 04:44:15.780458 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:44:15.780470 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 21 04:44:15.780482 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 21 04:44:15.780496 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 04:44:15.780508 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 04:44:15.780520 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 04:44:15.780532 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 21 04:44:15.780544 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 04:44:15.780557 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 21 04:44:15.780569 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 21 04:44:15.780582 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 21 04:44:15.780593 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 21 04:44:15.780607 systemd[1]: Stopped systemd-fsck-usr.service. Jun 21 04:44:15.780620 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jun 21 04:44:15.780632 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 21 04:44:15.780644 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 21 04:44:15.780656 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 21 04:44:15.780668 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 21 04:44:15.780681 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jun 21 04:44:15.780694 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 21 04:44:15.780709 systemd[1]: verity-setup.service: Deactivated successfully. Jun 21 04:44:15.780721 systemd[1]: Stopped verity-setup.service. Jun 21 04:44:15.780736 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:15.780747 kernel: loop: module loaded Jun 21 04:44:15.780759 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 21 04:44:15.780771 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 21 04:44:15.780783 systemd[1]: Mounted media.mount - External Media Directory. Jun 21 04:44:15.780795 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 21 04:44:15.780806 kernel: fuse: init (API version 7.41) Jun 21 04:44:15.780819 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 21 04:44:15.780845 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 21 04:44:15.780862 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 21 04:44:15.780876 kernel: ACPI: bus type drm_connector registered Jun 21 04:44:15.780889 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 21 04:44:15.780903 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 21 04:44:15.780915 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 21 04:44:15.780927 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 04:44:15.780939 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 04:44:15.780952 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 04:44:15.780977 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 04:44:15.781012 systemd-journald[1210]: Collecting audit messages is disabled. Jun 21 04:44:15.781037 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 04:44:15.781049 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 04:44:15.781069 systemd-journald[1210]: Journal started Jun 21 04:44:15.781091 systemd-journald[1210]: Runtime Journal (/run/log/journal/9977c85dbc944c79834d71ff88b20a4f) is 6M, max 48.5M, 42.4M free. Jun 21 04:44:15.472100 systemd[1]: Queued start job for default target multi-user.target. Jun 21 04:44:15.492920 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jun 21 04:44:15.493432 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 21 04:44:15.783895 systemd[1]: Started systemd-journald.service - Journal Service. Jun 21 04:44:15.785361 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 21 04:44:15.785608 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 21 04:44:15.787102 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 04:44:15.787336 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 04:44:15.789009 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 21 04:44:15.790513 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 21 04:44:15.792244 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 21 04:44:15.793905 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jun 21 04:44:15.810595 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 21 04:44:15.813578 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 21 04:44:15.816951 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 21 04:44:15.818213 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 21 04:44:15.818245 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 21 04:44:15.820463 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jun 21 04:44:15.823001 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 21 04:44:15.824456 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:44:15.828046 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 21 04:44:15.832026 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 21 04:44:15.833516 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 04:44:15.835269 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 21 04:44:15.836499 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 04:44:15.838096 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 21 04:44:15.840425 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 21 04:44:15.848755 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 21 04:44:15.853443 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 21 04:44:15.856726 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 21 04:44:15.858064 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 21 04:44:15.866911 systemd-journald[1210]: Time spent on flushing to /var/log/journal/9977c85dbc944c79834d71ff88b20a4f is 22.640ms for 1057 entries. Jun 21 04:44:15.866911 systemd-journald[1210]: System Journal (/var/log/journal/9977c85dbc944c79834d71ff88b20a4f) is 8M, max 195.6M, 187.6M free. Jun 21 04:44:15.905022 systemd-journald[1210]: Received client request to flush runtime journal. Jun 21 04:44:15.905139 kernel: loop0: detected capacity change from 0 to 113872 Jun 21 04:44:15.875125 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 21 04:44:15.878468 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 21 04:44:15.882274 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jun 21 04:44:15.889115 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 21 04:44:15.909909 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Jun 21 04:44:15.909928 systemd-tmpfiles[1255]: ACLs are not supported, ignoring. Jun 21 04:44:15.917297 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 21 04:44:15.919563 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 21 04:44:15.920167 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 21 04:44:15.924766 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 21 04:44:15.941859 kernel: loop1: detected capacity change from 0 to 224512 Jun 21 04:44:15.947749 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jun 21 04:44:15.977022 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 21 04:44:15.979902 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 21 04:44:15.984870 kernel: loop2: detected capacity change from 0 to 146240 Jun 21 04:44:16.128460 systemd-tmpfiles[1277]: ACLs are not supported, ignoring. Jun 21 04:44:16.128886 systemd-tmpfiles[1277]: ACLs are not supported, ignoring. Jun 21 04:44:16.136344 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 21 04:44:16.140900 kernel: loop3: detected capacity change from 0 to 113872 Jun 21 04:44:16.150867 kernel: loop4: detected capacity change from 0 to 224512 Jun 21 04:44:16.164870 kernel: loop5: detected capacity change from 0 to 146240 Jun 21 04:44:16.183129 (sd-merge)[1281]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jun 21 04:44:16.183863 (sd-merge)[1281]: Merged extensions into '/usr'. Jun 21 04:44:16.190714 systemd[1]: Reload requested from client PID 1254 ('systemd-sysext') (unit systemd-sysext.service)... Jun 21 04:44:16.190734 systemd[1]: Reloading... Jun 21 04:44:16.339880 zram_generator::config[1304]: No configuration found. Jun 21 04:44:16.371807 ldconfig[1249]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 21 04:44:16.446978 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. Jun 21 04:44:16.531543 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 21 04:44:16.532087 systemd[1]: Reloading finished in 340 ms. Jun 21 04:44:16.563571 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 21 04:44:16.565365 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 21 04:44:16.591956 systemd[1]: Starting ensure-sysext.service... Jun 21 04:44:16.594411 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 21 04:44:16.606269 systemd[1]: Reload requested from client PID 1345 ('systemctl') (unit ensure-sysext.service)... Jun 21 04:44:16.606287 systemd[1]: Reloading... Jun 21 04:44:16.630168 systemd-tmpfiles[1346]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jun 21 04:44:16.630267 systemd-tmpfiles[1346]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jun 21 04:44:16.631134 systemd-tmpfiles[1346]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 21 04:44:16.631645 systemd-tmpfiles[1346]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 21 04:44:16.633282 systemd-tmpfiles[1346]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 21 04:44:16.633819 systemd-tmpfiles[1346]: ACLs are not supported, ignoring. Jun 21 04:44:16.634020 systemd-tmpfiles[1346]: ACLs are not supported, ignoring. Jun 21 04:44:16.641213 systemd-tmpfiles[1346]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 04:44:16.641254 systemd-tmpfiles[1346]: Skipping /boot Jun 21 04:44:16.671827 systemd-tmpfiles[1346]: Detected autofs mount point /boot during canonicalization of boot. Jun 21 04:44:16.672058 systemd-tmpfiles[1346]: Skipping /boot Jun 21 04:44:16.722872 zram_generator::config[1376]: No configuration found. Jun 21 04:44:16.822058 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. Jun 21 04:44:16.917702 systemd[1]: Reloading finished in 310 ms. Jun 21 04:44:16.941740 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 21 04:44:16.965222 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 21 04:44:16.974691 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jun 21 04:44:16.977488 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 21 04:44:16.979954 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 21 04:44:16.992823 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 21 04:44:16.996894 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 21 04:44:16.999772 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 21 04:44:17.005659 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.006045 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:44:17.011937 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 04:44:17.014966 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 04:44:17.017919 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 04:44:17.019315 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:44:17.019423 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jun 21 04:44:17.027146 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 21 04:44:17.028479 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.029809 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 04:44:17.030065 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 04:44:17.032426 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 04:44:17.033079 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 04:44:17.037090 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 21 04:44:17.039451 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 04:44:17.040110 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 04:44:17.051622 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.052264 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:44:17.055162 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 21 04:44:17.055413 systemd-udevd[1416]: Using default interface naming scheme 'v255'. Jun 21 04:44:17.057683 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 21 04:44:17.062237 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 21 04:44:17.063805 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:44:17.063984 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jun 21 04:44:17.065464 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 21 04:44:17.067112 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.075022 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 21 04:44:17.077924 augenrules[1449]: No rules Jun 21 04:44:17.079598 systemd[1]: audit-rules.service: Deactivated successfully. Jun 21 04:44:17.080215 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jun 21 04:44:17.082542 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 21 04:44:17.082770 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 21 04:44:17.085796 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 21 04:44:17.086118 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 21 04:44:17.088227 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 21 04:44:17.090629 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 21 04:44:17.090939 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 21 04:44:17.093493 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 21 04:44:17.109949 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 21 04:44:17.112103 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 21 04:44:17.126738 systemd[1]: Finished ensure-sysext.service. Jun 21 04:44:17.136952 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.137132 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 21 04:44:17.138629 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 21 04:44:17.140587 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 21 04:44:17.140631 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jun 21 04:44:17.144945 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 21 04:44:17.146073 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 21 04:44:17.146142 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 21 04:44:17.149721 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jun 21 04:44:17.151198 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). Jun 21 04:44:17.151250 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 21 04:44:17.163456 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 21 04:44:17.163863 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 21 04:44:17.203542 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jun 21 04:44:17.300900 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jun 21 04:44:17.305192 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jun 21 04:44:17.395065 kernel: mousedev: PS/2 mouse device common for all mice Jun 21 04:44:17.401873 systemd-resolved[1415]: Positive Trust Anchors: Jun 21 04:44:17.401890 systemd-resolved[1415]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 21 04:44:17.401922 systemd-resolved[1415]: 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 Jun 21 04:44:17.405508 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 21 04:44:17.411641 systemd-resolved[1415]: Defaulting to hostname 'linux'. Jun 21 04:44:17.411889 systemd-networkd[1494]: lo: Link UP Jun 21 04:44:17.411901 systemd-networkd[1494]: lo: Gained carrier Jun 21 04:44:17.413507 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 21 04:44:17.413619 systemd-networkd[1494]: Enumeration completed Jun 21 04:44:17.414048 systemd-networkd[1494]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:44:17.414053 systemd-networkd[1494]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 21 04:44:17.414916 systemd-networkd[1494]: eth0: Link UP Jun 21 04:44:17.415029 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 21 04:44:17.415125 systemd-networkd[1494]: eth0: Gained carrier Jun 21 04:44:17.415139 systemd-networkd[1494]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 21 04:44:17.416334 systemd[1]: Reached target network.target - Network. Jun 21 04:44:17.417310 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 21 04:44:17.420331 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jun 21 04:44:17.426024 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 21 04:44:17.426916 systemd-networkd[1494]: eth0: DHCPv4 address 10.0.0.110/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jun 21 04:44:17.435863 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jun 21 04:44:17.449872 kernel: ACPI: button: Power Button [PWRF] Jun 21 04:44:17.457386 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jun 21 04:44:17.458910 systemd[1]: Reached target sysinit.target - System Initialization. Jun 21 04:44:17.460235 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 21 04:44:17.461779 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 21 04:44:17.463243 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jun 21 04:44:19.029825 systemd-resolved[1415]: Clock change detected. Flushing caches. Jun 21 04:44:19.029859 systemd-timesyncd[1495]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jun 21 04:44:19.029912 systemd-timesyncd[1495]: Initial clock synchronization to Sat 2025-06-21 04:44:19.029765 UTC. Jun 21 04:44:19.031196 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 21 04:44:19.034172 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Jun 21 04:44:19.034497 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jun 21 04:44:19.034661 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jun 21 04:44:19.034142 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 21 04:44:19.034168 systemd[1]: Reached target paths.target - Path Units. Jun 21 04:44:19.035173 systemd[1]: Reached target time-set.target - System Time Set. Jun 21 04:44:19.036497 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 21 04:44:19.037686 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 21 04:44:19.039020 systemd[1]: Reached target timers.target - Timer Units. Jun 21 04:44:19.042636 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 21 04:44:19.060315 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 21 04:44:19.065155 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jun 21 04:44:19.067131 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jun 21 04:44:19.069564 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jun 21 04:44:19.075742 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 21 04:44:19.077353 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jun 21 04:44:19.079646 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jun 21 04:44:19.081153 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 21 04:44:19.084327 systemd[1]: Reached target sockets.target - Socket Units. Jun 21 04:44:19.085870 systemd[1]: Reached target basic.target - Basic System. Jun 21 04:44:19.087083 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 21 04:44:19.087116 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 21 04:44:19.088221 systemd[1]: Starting containerd.service - containerd container runtime... Jun 21 04:44:19.092057 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 21 04:44:19.102033 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 21 04:44:19.104789 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 21 04:44:19.110970 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 21 04:44:19.112100 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). Jun 21 04:44:19.113896 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jun 21 04:44:19.135598 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 21 04:44:19.146744 jq[1536]: false Jun 21 04:44:19.141107 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 21 04:44:19.144895 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 21 04:44:19.151966 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 21 04:44:19.153967 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 21 04:44:19.154493 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 21 04:44:19.156973 systemd[1]: Starting update-engine.service - Update Engine... Jun 21 04:44:19.160924 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 21 04:44:19.166427 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 21 04:44:19.168387 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 21 04:44:19.168822 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 21 04:44:19.169244 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 21 04:44:19.170784 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 21 04:44:19.179530 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Refreshing passwd entry cache Jun 21 04:44:19.180000 oslogin_cache_refresh[1538]: Refreshing passwd entry cache Jun 21 04:44:19.195747 extend-filesystems[1537]: Found /dev/vda6 Jun 21 04:44:19.198123 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Failure getting users, quitting Jun 21 04:44:19.198116 oslogin_cache_refresh[1538]: Failure getting users, quitting Jun 21 04:44:19.198214 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 04:44:19.198214 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Refreshing group entry cache Jun 21 04:44:19.198146 oslogin_cache_refresh[1538]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jun 21 04:44:19.198208 oslogin_cache_refresh[1538]: Refreshing group entry cache Jun 21 04:44:19.198441 update_engine[1545]: I20250621 04:44:19.198374 1545 main.cc:92] Flatcar Update Engine starting Jun 21 04:44:19.199258 extend-filesystems[1537]: Found /dev/vda9 Jun 21 04:44:19.202008 extend-filesystems[1537]: Checking size of /dev/vda9 Jun 21 04:44:19.205521 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:19.208014 (ntainerd)[1559]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 21 04:44:19.212795 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Failure getting groups, quitting Jun 21 04:44:19.212795 google_oslogin_nss_cache[1538]: oslogin_cache_refresh[1538]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 04:44:19.211963 oslogin_cache_refresh[1538]: Failure getting groups, quitting Jun 21 04:44:19.211976 oslogin_cache_refresh[1538]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jun 21 04:44:19.213783 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jun 21 04:44:19.234536 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jun 21 04:44:19.242593 jq[1547]: true Jun 21 04:44:19.271787 systemd[1]: motdgen.service: Deactivated successfully. Jun 21 04:44:19.272135 extend-filesystems[1537]: Resized partition /dev/vda9 Jun 21 04:44:19.283950 extend-filesystems[1576]: resize2fs 1.47.2 (1-Jan-2025) Jun 21 04:44:19.278999 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 21 04:44:19.292176 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jun 21 04:44:19.299080 dbus-daemon[1534]: [system] SELinux support is enabled Jun 21 04:44:19.302125 jq[1570]: true Jun 21 04:44:19.304346 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 21 04:44:19.313957 update_engine[1545]: I20250621 04:44:19.310982 1545 update_check_scheduler.cc:74] Next update check in 8m9s Jun 21 04:44:19.312282 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 21 04:44:19.312598 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:19.319955 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jun 21 04:44:19.328231 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jun 21 04:44:19.341050 extend-filesystems[1576]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jun 21 04:44:19.341050 extend-filesystems[1576]: old_desc_blocks = 1, new_desc_blocks = 1 Jun 21 04:44:19.341050 extend-filesystems[1576]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jun 21 04:44:19.346678 extend-filesystems[1537]: Resized filesystem in /dev/vda9 Jun 21 04:44:19.344134 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 21 04:44:19.349957 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 21 04:44:19.363764 kernel: kvm_amd: TSC scaling supported Jun 21 04:44:19.363830 kernel: kvm_amd: Nested Virtualization enabled Jun 21 04:44:19.363855 kernel: kvm_amd: Nested Paging enabled Jun 21 04:44:19.363891 kernel: kvm_amd: LBR virtualization supported Jun 21 04:44:19.363949 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jun 21 04:44:19.363976 kernel: kvm_amd: Virtual GIF supported Jun 21 04:44:19.390140 systemd[1]: Started update-engine.service - Update Engine. Jun 21 04:44:19.391860 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). Jun 21 04:44:19.391905 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 21 04:44:19.395114 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 21 04:44:19.396310 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). Jun 21 04:44:19.398921 bash[1598]: Updated "/home/core/.ssh/authorized_keys" Jun 21 04:44:19.396329 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 21 04:44:19.400999 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 21 04:44:19.403550 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 21 04:44:19.406258 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jun 21 04:44:19.407763 systemd-logind[1544]: Watching system buttons on /dev/input/event2 (Power Button) Jun 21 04:44:19.407793 systemd-logind[1544]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 21 04:44:19.408484 systemd-logind[1544]: New seat seat0. Jun 21 04:44:19.411138 systemd[1]: Started systemd-logind.service - User Login Management. Jun 21 04:44:19.452767 kernel: EDAC MC: Ver: 3.0.0 Jun 21 04:44:19.486892 locksmithd[1605]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 21 04:44:19.508843 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 21 04:44:19.551393 containerd[1559]: time="2025-06-21T04:44:19Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Jun 21 04:44:19.552272 containerd[1559]: time="2025-06-21T04:44:19.552234867Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jun 21 04:44:19.560207 containerd[1559]: time="2025-06-21T04:44:19.560157441Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.219µs" Jun 21 04:44:19.560207 containerd[1559]: time="2025-06-21T04:44:19.560194079Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jun 21 04:44:19.560268 containerd[1559]: time="2025-06-21T04:44:19.560212474Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jun 21 04:44:19.560439 containerd[1559]: time="2025-06-21T04:44:19.560407129Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jun 21 04:44:19.560439 containerd[1559]: time="2025-06-21T04:44:19.560428369Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jun 21 04:44:19.560493 containerd[1559]: time="2025-06-21T04:44:19.560452955Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560542 containerd[1559]: time="2025-06-21T04:44:19.560518147Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560542 containerd[1559]: time="2025-06-21T04:44:19.560533546Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560863 containerd[1559]: time="2025-06-21T04:44:19.560828289Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560863 containerd[1559]: time="2025-06-21T04:44:19.560847285Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560863 containerd[1559]: time="2025-06-21T04:44:19.560858285Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jun 21 04:44:19.560941 containerd[1559]: time="2025-06-21T04:44:19.560873404Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jun 21 04:44:19.561005 containerd[1559]: time="2025-06-21T04:44:19.560972450Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jun 21 04:44:19.561243 containerd[1559]: time="2025-06-21T04:44:19.561209234Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 04:44:19.561268 containerd[1559]: time="2025-06-21T04:44:19.561245512Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jun 21 04:44:19.561268 containerd[1559]: time="2025-06-21T04:44:19.561256082Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jun 21 04:44:19.561307 containerd[1559]: time="2025-06-21T04:44:19.561297870Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jun 21 04:44:19.562259 containerd[1559]: time="2025-06-21T04:44:19.561941788Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jun 21 04:44:19.562259 containerd[1559]: time="2025-06-21T04:44:19.562108311Z" level=info msg="metadata content store policy set" policy=shared Jun 21 04:44:19.568860 containerd[1559]: time="2025-06-21T04:44:19.568811065Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jun 21 04:44:19.568928 containerd[1559]: time="2025-06-21T04:44:19.568882159Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jun 21 04:44:19.568928 containerd[1559]: time="2025-06-21T04:44:19.568898770Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jun 21 04:44:19.568928 containerd[1559]: time="2025-06-21T04:44:19.568911564Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jun 21 04:44:19.568928 containerd[1559]: time="2025-06-21T04:44:19.568924879Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568936661Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568948904Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568961357Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568972007Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568981495Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jun 21 04:44:19.569000 containerd[1559]: time="2025-06-21T04:44:19.568991604Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jun 21 04:44:19.569109 containerd[1559]: time="2025-06-21T04:44:19.569004308Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jun 21 04:44:19.569180 containerd[1559]: time="2025-06-21T04:44:19.569152115Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jun 21 04:44:19.569210 containerd[1559]: time="2025-06-21T04:44:19.569178174Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jun 21 04:44:19.569210 containerd[1559]: time="2025-06-21T04:44:19.569191609Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jun 21 04:44:19.569210 containerd[1559]: time="2025-06-21T04:44:19.569202790Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569213410Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569224531Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569234951Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569244489Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569255379Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jun 21 04:44:19.569269 containerd[1559]: time="2025-06-21T04:44:19.569266460Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jun 21 04:44:19.569390 containerd[1559]: time="2025-06-21T04:44:19.569283943Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jun 21 04:44:19.569390 containerd[1559]: time="2025-06-21T04:44:19.569352852Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jun 21 04:44:19.569390 containerd[1559]: time="2025-06-21T04:44:19.569365876Z" level=info msg="Start snapshots syncer" Jun 21 04:44:19.569444 containerd[1559]: time="2025-06-21T04:44:19.569391354Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jun 21 04:44:19.569643 containerd[1559]: time="2025-06-21T04:44:19.569602140Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Jun 21 04:44:19.569758 containerd[1559]: time="2025-06-21T04:44:19.569648376Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jun 21 04:44:19.570538 containerd[1559]: time="2025-06-21T04:44:19.570508560Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jun 21 04:44:19.570649 containerd[1559]: time="2025-06-21T04:44:19.570620600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jun 21 04:44:19.570649 containerd[1559]: time="2025-06-21T04:44:19.570647441Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jun 21 04:44:19.570698 containerd[1559]: time="2025-06-21T04:44:19.570663761Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jun 21 04:44:19.570698 containerd[1559]: time="2025-06-21T04:44:19.570674181Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jun 21 04:44:19.570698 containerd[1559]: time="2025-06-21T04:44:19.570685863Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jun 21 04:44:19.570698 containerd[1559]: time="2025-06-21T04:44:19.570696793Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jun 21 04:44:19.570808 containerd[1559]: time="2025-06-21T04:44:19.570707764Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jun 21 04:44:19.570808 containerd[1559]: time="2025-06-21T04:44:19.570755163Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jun 21 04:44:19.570808 containerd[1559]: time="2025-06-21T04:44:19.570768588Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jun 21 04:44:19.570808 containerd[1559]: time="2025-06-21T04:44:19.570780821Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570815295Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570829322Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570837838Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570846724Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570854479Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570864468Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jun 21 04:44:19.570896 containerd[1559]: time="2025-06-21T04:44:19.570882492Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jun 21 04:44:19.571022 containerd[1559]: time="2025-06-21T04:44:19.570902509Z" level=info msg="runtime interface created" Jun 21 04:44:19.571022 containerd[1559]: time="2025-06-21T04:44:19.570909763Z" level=info msg="created NRI interface" Jun 21 04:44:19.571022 containerd[1559]: time="2025-06-21T04:44:19.570917748Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jun 21 04:44:19.571022 containerd[1559]: time="2025-06-21T04:44:19.570929199Z" level=info msg="Connect containerd service" Jun 21 04:44:19.571022 containerd[1559]: time="2025-06-21T04:44:19.570966649Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 21 04:44:19.571796 containerd[1559]: time="2025-06-21T04:44:19.571772070Z" 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" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722268703Z" level=info msg="Start subscribing containerd event" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722353302Z" level=info msg="Start recovering state" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722483887Z" level=info msg="Start event monitor" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722492723Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722514704Z" level=info msg="Start cni network conf syncer for default" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722610534Z" level=info msg="Start streaming server" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722568425Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722629189Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722641132Z" level=info msg="runtime interface starting up..." Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722656310Z" level=info msg="starting plugins..." Jun 21 04:44:19.722752 containerd[1559]: time="2025-06-21T04:44:19.722692087Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jun 21 04:44:19.723076 containerd[1559]: time="2025-06-21T04:44:19.723052453Z" level=info msg="containerd successfully booted in 0.172190s" Jun 21 04:44:19.723203 systemd[1]: Started containerd.service - containerd container runtime. Jun 21 04:44:19.731120 sshd_keygen[1569]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 21 04:44:19.756298 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 21 04:44:19.759480 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 21 04:44:19.781888 systemd[1]: issuegen.service: Deactivated successfully. Jun 21 04:44:19.782157 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 21 04:44:19.784933 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 21 04:44:19.921791 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 21 04:44:19.925047 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 21 04:44:19.927242 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jun 21 04:44:19.928518 systemd[1]: Reached target getty.target - Login Prompts. Jun 21 04:44:20.539970 systemd-networkd[1494]: eth0: Gained IPv6LL Jun 21 04:44:20.543435 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 21 04:44:20.545522 systemd[1]: Reached target network-online.target - Network is Online. Jun 21 04:44:20.548223 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 21 04:44:20.550796 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 04:44:20.553066 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 21 04:44:20.584009 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 21 04:44:20.587761 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 21 04:44:20.588089 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 21 04:44:20.590025 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 21 04:44:22.123564 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 04:44:22.125518 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 21 04:44:22.127516 systemd[1]: Startup finished in 3.681s (kernel) + 6.174s (initrd) + 5.793s (userspace) = 15.649s. Jun 21 04:44:22.138126 (kubelet)[1674]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jun 21 04:44:22.768692 kubelet[1674]: E0621 04:44:22.768612 1674 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" Jun 21 04:44:22.772502 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jun 21 04:44:22.772736 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jun 21 04:44:22.773195 systemd[1]: kubelet.service: Consumed 2.016s CPU time, 266.6M memory peak. Jun 21 04:44:23.950244 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 21 04:44:23.951685 systemd[1]: Started sshd@0-10.0.0.110:22-10.0.0.1:49064.service - OpenSSH per-connection server daemon (10.0.0.1:49064). Jun 21 04:44:24.045431 sshd[1687]: Accepted publickey for core from 10.0.0.1 port 49064 ssh2: RSA SHA256:015yC5fRvb07MyWOgrdDHnl6DLRQb6q1XcuQXpFRy7c Jun 21 04:44:24.047642 sshd-session[1687]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:24.055650 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 21 04:44:24.056931 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 21 04:44:24.064694 systemd-logind[1544]: New session 1 of user core. Jun 21 04:44:24.083833 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 21 04:44:24.086957 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 21 04:44:24.118567 (systemd)[1691]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 21 04:44:24.121224 systemd-logind[1544]: New session c1 of user core. Jun 21 04:44:24.278523 systemd[1691]: Queued start job for default target default.target. Jun 21 04:44:24.303041 systemd[1691]: Created slice app.slice - User Application Slice. Jun 21 04:44:24.303068 systemd[1691]: Reached target paths.target - Paths. Jun 21 04:44:24.303106 systemd[1691]: Reached target timers.target - Timers. Jun 21 04:44:24.304835 systemd[1691]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 21 04:44:24.320059 systemd[1691]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 21 04:44:24.320187 systemd[1691]: Reached target sockets.target - Sockets. Jun 21 04:44:24.320229 systemd[1691]: Reached target basic.target - Basic System. Jun 21 04:44:24.320268 systemd[1691]: Reached target default.target - Main User Target. Jun 21 04:44:24.320299 systemd[1691]: Startup finished in 191ms. Jun 21 04:44:24.320691 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 21 04:44:24.322509 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 21 04:44:24.385197 systemd[1]: Started sshd@1-10.0.0.110:22-10.0.0.1:49070.service - OpenSSH per-connection server daemon (10.0.0.1:49070). Jun 21 04:44:24.441157 sshd[1702]: Accepted publickey for core from 10.0.0.1 port 49070 ssh2: RSA SHA256:015yC5fRvb07MyWOgrdDHnl6DLRQb6q1XcuQXpFRy7c Jun 21 04:44:24.442552 sshd-session[1702]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:24.447339 systemd-logind[1544]: New session 2 of user core. Jun 21 04:44:24.457057 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 21 04:44:24.511520 sshd[1704]: Connection closed by 10.0.0.1 port 49070 Jun 21 04:44:24.511951 sshd-session[1702]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:24.524129 systemd[1]: sshd@1-10.0.0.110:22-10.0.0.1:49070.service: Deactivated successfully. Jun 21 04:44:24.526322 systemd[1]: session-2.scope: Deactivated successfully. Jun 21 04:44:24.527124 systemd-logind[1544]: Session 2 logged out. Waiting for processes to exit. Jun 21 04:44:24.530589 systemd[1]: Started sshd@2-10.0.0.110:22-10.0.0.1:49076.service - OpenSSH per-connection server daemon (10.0.0.1:49076). Jun 21 04:44:24.531537 systemd-logind[1544]: Removed session 2. Jun 21 04:44:24.591968 sshd[1710]: Accepted publickey for core from 10.0.0.1 port 49076 ssh2: RSA SHA256:015yC5fRvb07MyWOgrdDHnl6DLRQb6q1XcuQXpFRy7c Jun 21 04:44:24.593514 sshd-session[1710]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:24.598080 systemd-logind[1544]: New session 3 of user core. Jun 21 04:44:24.607876 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 21 04:44:24.658344 sshd[1712]: Connection closed by 10.0.0.1 port 49076 Jun 21 04:44:24.658853 sshd-session[1710]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:24.673620 systemd[1]: sshd@2-10.0.0.110:22-10.0.0.1:49076.service: Deactivated successfully. Jun 21 04:44:24.676298 systemd[1]: session-3.scope: Deactivated successfully. Jun 21 04:44:24.677548 systemd-logind[1544]: Session 3 logged out. Waiting for processes to exit. Jun 21 04:44:24.681786 systemd[1]: Started sshd@3-10.0.0.110:22-10.0.0.1:49088.service - OpenSSH per-connection server daemon (10.0.0.1:49088). Jun 21 04:44:24.682573 systemd-logind[1544]: Removed session 3. Jun 21 04:44:24.738165 sshd[1718]: Accepted publickey for core from 10.0.0.1 port 49088 ssh2: RSA SHA256:015yC5fRvb07MyWOgrdDHnl6DLRQb6q1XcuQXpFRy7c Jun 21 04:44:24.739919 sshd-session[1718]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:24.744974 systemd-logind[1544]: New session 4 of user core. Jun 21 04:44:24.754859 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 21 04:44:24.808882 sshd[1720]: Connection closed by 10.0.0.1 port 49088 Jun 21 04:44:24.809155 sshd-session[1718]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:24.824777 systemd[1]: sshd@3-10.0.0.110:22-10.0.0.1:49088.service: Deactivated successfully. Jun 21 04:44:24.826679 systemd[1]: session-4.scope: Deactivated successfully. Jun 21 04:44:24.827427 systemd-logind[1544]: Session 4 logged out. Waiting for processes to exit. Jun 21 04:44:24.830417 systemd[1]: Started sshd@4-10.0.0.110:22-10.0.0.1:49092.service - OpenSSH per-connection server daemon (10.0.0.1:49092). Jun 21 04:44:24.831039 systemd-logind[1544]: Removed session 4. Jun 21 04:44:24.891509 sshd[1726]: Accepted publickey for core from 10.0.0.1 port 49092 ssh2: RSA SHA256:015yC5fRvb07MyWOgrdDHnl6DLRQb6q1XcuQXpFRy7c Jun 21 04:44:24.892864 sshd-session[1726]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 21 04:44:24.897187 systemd-logind[1544]: New session 5 of user core. Jun 21 04:44:24.906850 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 21 04:44:24.963755 sudo[1729]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jun 21 04:44:24.964075 sudo[1729]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 21 04:44:24.977909 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jun 21 04:44:25.034910 systemd[1]: coreos-metadata.service: Deactivated successfully. Jun 21 04:44:25.035196 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jun 21 04:44:25.654384 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 04:44:25.654550 systemd[1]: kubelet.service: Consumed 2.016s CPU time, 266.6M memory peak. Jun 21 04:44:25.656982 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 04:44:25.684389 systemd[1]: Reload requested from client PID 1771 ('systemctl') (unit session-5.scope)... Jun 21 04:44:25.684405 systemd[1]: Reloading... Jun 21 04:44:25.823815 zram_generator::config[1819]: No configuration found. Jun 21 04:44:26.024974 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. Jun 21 04:44:26.147299 systemd[1]: Reloading finished in 462 ms. Jun 21 04:44:26.221824 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jun 21 04:44:26.221973 systemd[1]: kubelet.service: Failed with result 'signal'. Jun 21 04:44:26.222418 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 04:44:26.222485 systemd[1]: kubelet.service: Consumed 249ms CPU time, 98.2M memory peak. Jun 21 04:44:26.224912 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 21 04:44:26.445303 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 21 04:44:26.457219 (kubelet)[1861]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jun 21 04:44:26.502850 kubelet[1861]: 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. Jun 21 04:44:26.502850 kubelet[1861]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Jun 21 04:44:26.502850 kubelet[1861]: 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. Jun 21 04:44:26.503290 kubelet[1861]: I0621 04:44:26.502922 1861 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" Jun 21 04:44:26.849204 kubelet[1861]: I0621 04:44:26.849064 1861 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Jun 21 04:44:26.849204 kubelet[1861]: I0621 04:44:26.849098 1861 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jun 21 04:44:26.849415 kubelet[1861]: I0621 04:44:26.849357 1861 server.go:954] "Client rotation is on, will bootstrap in background" Jun 21 04:44:26.876563 kubelet[1861]: I0621 04:44:26.876492 1861 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jun 21 04:44:26.884809 kubelet[1861]: I0621 04:44:26.884765 1861 server.go:1444] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Jun 21 04:44:26.891170 kubelet[1861]: I0621 04:44:26.891144 1861 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jun 21 04:44:26.892413 kubelet[1861]: I0621 04:44:26.892353 1861 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jun 21 04:44:26.892608 kubelet[1861]: I0621 04:44:26.892403 1861 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.110","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Jun 21 04:44:26.892754 kubelet[1861]: I0621 04:44:26.892616 1861 topology_manager.go:138] "Creating topology manager with none policy" Jun 21 04:44:26.892754 kubelet[1861]: I0621 04:44:26.892634 1861 container_manager_linux.go:304] "Creating device plugin manager" Jun 21 04:44:26.892869 kubelet[1861]: I0621 04:44:26.892837 1861 state_mem.go:36] "Initialized new in-memory state store" Jun 21 04:44:26.895666 kubelet[1861]: I0621 04:44:26.895639 1861 kubelet.go:446] "Attempting to sync node with API server" Jun 21 04:44:26.895735 kubelet[1861]: I0621 04:44:26.895677 1861 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Jun 21 04:44:26.895735 kubelet[1861]: I0621 04:44:26.895711 1861 kubelet.go:352] "Adding apiserver pod source" Jun 21 04:44:26.895787 kubelet[1861]: I0621 04:44:26.895777 1861 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jun 21 04:44:26.895906 kubelet[1861]: E0621 04:44:26.895862 1861 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:26.897187 kubelet[1861]: E0621 04:44:26.896806 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:26.899735 kubelet[1861]: I0621 04:44:26.899671 1861 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v2.0.4" apiVersion="v1" Jun 21 04:44:26.900169 kubelet[1861]: I0621 04:44:26.900139 1861 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Jun 21 04:44:26.900286 kubelet[1861]: W0621 04:44:26.900220 1861 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jun 21 04:44:26.902030 kubelet[1861]: I0621 04:44:26.901991 1861 watchdog_linux.go:99] "Systemd watchdog is not enabled" Jun 21 04:44:26.902086 kubelet[1861]: I0621 04:44:26.902038 1861 server.go:1287] "Started kubelet" Jun 21 04:44:26.902157 kubelet[1861]: I0621 04:44:26.902126 1861 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Jun 21 04:44:26.904235 kubelet[1861]: I0621 04:44:26.903276 1861 server.go:479] "Adding debug handlers to kubelet server" Jun 21 04:44:26.904384 kubelet[1861]: I0621 04:44:26.904211 1861 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jun 21 04:44:26.905592 kubelet[1861]: I0621 04:44:26.905499 1861 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jun 21 04:44:26.905656 kubelet[1861]: I0621 04:44:26.905607 1861 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jun 21 04:44:26.908147 kubelet[1861]: I0621 04:44:26.908112 1861 volume_manager.go:297] "Starting Kubelet Volume Manager" Jun 21 04:44:26.908226 kubelet[1861]: I0621 04:44:26.908184 1861 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jun 21 04:44:26.910436 kubelet[1861]: E0621 04:44:26.910113 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:26.910436 kubelet[1861]: I0621 04:44:26.910264 1861 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Jun 21 04:44:26.910436 kubelet[1861]: I0621 04:44:26.910322 1861 reconciler.go:26] "Reconciler: start to sync state" Jun 21 04:44:26.911174 kubelet[1861]: I0621 04:44:26.911142 1861 factory.go:221] Registration of the systemd container factory successfully Jun 21 04:44:26.911280 kubelet[1861]: I0621 04:44:26.911261 1861 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 Jun 21 04:44:26.912003 kubelet[1861]: E0621 04:44:26.911964 1861 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.110\" not found" node="10.0.0.110" Jun 21 04:44:26.912191 kubelet[1861]: E0621 04:44:26.912085 1861 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jun 21 04:44:26.912660 kubelet[1861]: I0621 04:44:26.912635 1861 factory.go:221] Registration of the containerd container factory successfully Jun 21 04:44:26.924674 kubelet[1861]: I0621 04:44:26.924302 1861 cpu_manager.go:221] "Starting CPU manager" policy="none" Jun 21 04:44:26.924674 kubelet[1861]: I0621 04:44:26.924327 1861 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Jun 21 04:44:26.924674 kubelet[1861]: I0621 04:44:26.924350 1861 state_mem.go:36] "Initialized new in-memory state store" Jun 21 04:44:27.010589 kubelet[1861]: E0621 04:44:27.010538 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.110913 kubelet[1861]: E0621 04:44:27.110802 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.211188 kubelet[1861]: E0621 04:44:27.211137 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.248212 kubelet[1861]: E0621 04:44:27.248172 1861 csi_plugin.go:308] Failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "10.0.0.110" not found Jun 21 04:44:27.311291 kubelet[1861]: E0621 04:44:27.311242 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.412432 kubelet[1861]: E0621 04:44:27.412278 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.512865 kubelet[1861]: E0621 04:44:27.512799 1861 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.110\" not found" Jun 21 04:44:27.533669 kubelet[1861]: I0621 04:44:27.533640 1861 policy_none.go:49] "None policy: Start" Jun 21 04:44:27.533799 kubelet[1861]: I0621 04:44:27.533681 1861 memory_manager.go:186] "Starting memorymanager" policy="None" Jun 21 04:44:27.533799 kubelet[1861]: I0621 04:44:27.533707 1861 state_mem.go:35] "Initializing new in-memory state store" Jun 21 04:44:27.541747 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jun 21 04:44:27.556474 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jun 21 04:44:27.560476 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jun 21 04:44:27.570022 kubelet[1861]: I0621 04:44:27.569959 1861 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Jun 21 04:44:27.570242 kubelet[1861]: I0621 04:44:27.570226 1861 eviction_manager.go:189] "Eviction manager: starting control loop" Jun 21 04:44:27.570312 kubelet[1861]: I0621 04:44:27.570245 1861 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jun 21 04:44:27.570629 kubelet[1861]: I0621 04:44:27.570574 1861 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jun 21 04:44:27.571060 kubelet[1861]: I0621 04:44:27.571015 1861 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Jun 21 04:44:27.571743 kubelet[1861]: E0621 04:44:27.571663 1861 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jun 21 04:44:27.571840 kubelet[1861]: E0621 04:44:27.571716 1861 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.110\" not found" Jun 21 04:44:27.572807 kubelet[1861]: I0621 04:44:27.572781 1861 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Jun 21 04:44:27.572891 kubelet[1861]: I0621 04:44:27.572828 1861 status_manager.go:227] "Starting to sync pod status with apiserver" Jun 21 04:44:27.572891 kubelet[1861]: I0621 04:44:27.572851 1861 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jun 21 04:44:27.573339 kubelet[1861]: I0621 04:44:27.573318 1861 kubelet.go:2382] "Starting kubelet main sync loop" Jun 21 04:44:27.573437 kubelet[1861]: E0621 04:44:27.573383 1861 kubelet.go:2406] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jun 21 04:44:27.596628 kubelet[1861]: E0621 04:44:27.596571 1861 csi_plugin.go:308] Failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "10.0.0.110" not found Jun 21 04:44:27.672287 kubelet[1861]: I0621 04:44:27.672145 1861 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.110" Jun 21 04:44:27.678675 kubelet[1861]: I0621 04:44:27.678609 1861 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.110" Jun 21 04:44:27.790936 kubelet[1861]: I0621 04:44:27.790894 1861 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jun 21 04:44:27.791399 containerd[1559]: time="2025-06-21T04:44:27.791329066Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jun 21 04:44:27.791847 kubelet[1861]: I0621 04:44:27.791677 1861 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jun 21 04:44:27.851975 kubelet[1861]: I0621 04:44:27.851902 1861 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jun 21 04:44:27.852286 kubelet[1861]: W0621 04:44:27.852223 1861 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver 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 Jun 21 04:44:27.852286 kubelet[1861]: W0621 04:44:27.852223 1861 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.Service 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 Jun 21 04:44:27.852286 kubelet[1861]: W0621 04:44:27.852261 1861 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 Jun 21 04:44:27.897137 kubelet[1861]: I0621 04:44:27.897084 1861 apiserver.go:52] "Watching apiserver" Jun 21 04:44:27.897269 kubelet[1861]: E0621 04:44:27.897086 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:27.907455 systemd[1]: Created slice kubepods-besteffort-pod7f17c25f_1182_4c71_affe_2d01fc564159.slice - libcontainer container kubepods-besteffort-pod7f17c25f_1182_4c71_affe_2d01fc564159.slice. Jun 21 04:44:27.911568 kubelet[1861]: I0621 04:44:27.911524 1861 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Jun 21 04:44:27.914385 kubelet[1861]: I0621 04:44:27.914341 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/715eff34-0e65-4fdb-8587-1629d55298da-run\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914385 kubelet[1861]: I0621 04:44:27.914382 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/715eff34-0e65-4fdb-8587-1629d55298da-cni\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914548 kubelet[1861]: I0621 04:44:27.914409 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/715eff34-0e65-4fdb-8587-1629d55298da-xtables-lock\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914548 kubelet[1861]: I0621 04:44:27.914430 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-fvnxk\" (UniqueName: \"kubernetes.io/projected/715eff34-0e65-4fdb-8587-1629d55298da-kube-api-access-fvnxk\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914548 kubelet[1861]: I0621 04:44:27.914451 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/7f17c25f-1182-4c71-affe-2d01fc564159-kube-proxy\") pod \"kube-proxy-xxf58\" (UID: \"7f17c25f-1182-4c71-affe-2d01fc564159\") " pod="kube-system/kube-proxy-xxf58" Jun 21 04:44:27.914548 kubelet[1861]: I0621 04:44:27.914476 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/715eff34-0e65-4fdb-8587-1629d55298da-cni-plugin\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914548 kubelet[1861]: I0621 04:44:27.914511 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/715eff34-0e65-4fdb-8587-1629d55298da-flannel-cfg\") pod \"kube-flannel-ds-mbbs7\" (UID: \"715eff34-0e65-4fdb-8587-1629d55298da\") " pod="kube-flannel/kube-flannel-ds-mbbs7" Jun 21 04:44:27.914798 kubelet[1861]: I0621 04:44:27.914529 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/7f17c25f-1182-4c71-affe-2d01fc564159-xtables-lock\") pod \"kube-proxy-xxf58\" (UID: \"7f17c25f-1182-4c71-affe-2d01fc564159\") " pod="kube-system/kube-proxy-xxf58" Jun 21 04:44:27.914798 kubelet[1861]: I0621 04:44:27.914569 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/7f17c25f-1182-4c71-affe-2d01fc564159-lib-modules\") pod \"kube-proxy-xxf58\" (UID: \"7f17c25f-1182-4c71-affe-2d01fc564159\") " pod="kube-system/kube-proxy-xxf58" Jun 21 04:44:27.914798 kubelet[1861]: I0621 04:44:27.914612 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-6qvf6\" (UniqueName: \"kubernetes.io/projected/7f17c25f-1182-4c71-affe-2d01fc564159-kube-api-access-6qvf6\") pod \"kube-proxy-xxf58\" (UID: \"7f17c25f-1182-4c71-affe-2d01fc564159\") " pod="kube-system/kube-proxy-xxf58" Jun 21 04:44:27.921428 systemd[1]: Created slice kubepods-burstable-pod715eff34_0e65_4fdb_8587_1629d55298da.slice - libcontainer container kubepods-burstable-pod715eff34_0e65_4fdb_8587_1629d55298da.slice. Jun 21 04:44:27.974093 sudo[1729]: pam_unix(sudo:session): session closed for user root Jun 21 04:44:27.975563 sshd[1728]: Connection closed by 10.0.0.1 port 49092 Jun 21 04:44:27.975890 sshd-session[1726]: pam_unix(sshd:session): session closed for user core Jun 21 04:44:27.980027 systemd[1]: sshd@4-10.0.0.110:22-10.0.0.1:49092.service: Deactivated successfully. Jun 21 04:44:27.982564 systemd[1]: session-5.scope: Deactivated successfully. Jun 21 04:44:27.982843 systemd[1]: session-5.scope: Consumed 676ms CPU time, 77.2M memory peak. Jun 21 04:44:27.984080 systemd-logind[1544]: Session 5 logged out. Waiting for processes to exit. Jun 21 04:44:27.985485 systemd-logind[1544]: Removed session 5. Jun 21 04:44:28.218951 kubelet[1861]: E0621 04:44:28.218888 1861 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" Jun 21 04:44:28.219705 containerd[1559]: time="2025-06-21T04:44:28.219653523Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-xxf58,Uid:7f17c25f-1182-4c71-affe-2d01fc564159,Namespace:kube-system,Attempt:0,}" Jun 21 04:44:28.236921 kubelet[1861]: E0621 04:44:28.236814 1861 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" Jun 21 04:44:28.237365 containerd[1559]: time="2025-06-21T04:44:28.237327401Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-mbbs7,Uid:715eff34-0e65-4fdb-8587-1629d55298da,Namespace:kube-flannel,Attempt:0,}" Jun 21 04:44:28.881409 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount580245376.mount: Deactivated successfully. Jun 21 04:44:28.891295 containerd[1559]: time="2025-06-21T04:44:28.891222214Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 21 04:44:28.892882 containerd[1559]: time="2025-06-21T04:44:28.892844357Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=321138" Jun 21 04:44:28.894253 containerd[1559]: time="2025-06-21T04:44:28.894140088Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 21 04:44:28.895744 containerd[1559]: time="2025-06-21T04:44:28.895694194Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 21 04:44:28.896616 containerd[1559]: time="2025-06-21T04:44:28.896586508Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Jun 21 04:44:28.898089 kubelet[1861]: E0621 04:44:28.898059 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:28.898619 containerd[1559]: time="2025-06-21T04:44:28.898578615Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 21 04:44:28.899271 containerd[1559]: time="2025-06-21T04:44:28.899203828Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 668.102878ms" Jun 21 04:44:28.900397 containerd[1559]: time="2025-06-21T04:44:28.900339609Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"320368\" in 655.907409ms" Jun 21 04:44:28.926597 containerd[1559]: time="2025-06-21T04:44:28.926506270Z" level=info msg="connecting to shim a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a" address="unix:///run/containerd/s/51bd3c881d7bb0c5c716c51a5de487f780d4414250981a6f8c70c9aa83227acb" namespace=k8s.io protocol=ttrpc version=3 Jun 21 04:44:28.928247 containerd[1559]: time="2025-06-21T04:44:28.928184688Z" level=info msg="connecting to shim 6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f" address="unix:///run/containerd/s/0ae0f2e60406637c187b660a91cb2dc18cd23f02738805547daf3e2b1cdd3b21" namespace=k8s.io protocol=ttrpc version=3 Jun 21 04:44:28.979891 systemd[1]: Started cri-containerd-a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a.scope - libcontainer container a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a. Jun 21 04:44:29.005892 systemd[1]: Started cri-containerd-6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f.scope - libcontainer container 6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f. Jun 21 04:44:29.040911 containerd[1559]: time="2025-06-21T04:44:29.040839156Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-xxf58,Uid:7f17c25f-1182-4c71-affe-2d01fc564159,Namespace:kube-system,Attempt:0,} returns sandbox id \"a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a\"" Jun 21 04:44:29.042373 kubelet[1861]: E0621 04:44:29.042324 1861 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" Jun 21 04:44:29.043907 containerd[1559]: time="2025-06-21T04:44:29.043878659Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.6\"" Jun 21 04:44:29.064305 containerd[1559]: time="2025-06-21T04:44:29.064250999Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-mbbs7,Uid:715eff34-0e65-4fdb-8587-1629d55298da,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\"" Jun 21 04:44:29.065019 kubelet[1861]: E0621 04:44:29.064992 1861 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" Jun 21 04:44:29.898357 kubelet[1861]: E0621 04:44:29.898243 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:30.054230 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2668647260.mount: Deactivated successfully. Jun 21 04:44:30.352621 containerd[1559]: time="2025-06-21T04:44:30.352569666Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.6\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:30.353355 containerd[1559]: time="2025-06-21T04:44:30.353326707Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.6: active requests=0, bytes read=30895363" Jun 21 04:44:30.354436 containerd[1559]: time="2025-06-21T04:44:30.354409648Z" level=info msg="ImageCreate event name:\"sha256:63f0cbe3b7339c5d006efc9964228e48271bae73039320037c451b5e8f763e02\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:30.356313 containerd[1559]: time="2025-06-21T04:44:30.356257745Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:b13d9da413b983d130bf090b83fce12e1ccc704e95f366da743c18e964d9d7e9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:30.356757 containerd[1559]: time="2025-06-21T04:44:30.356713510Z" 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 1.312791691s" Jun 21 04:44:30.356798 containerd[1559]: time="2025-06-21T04:44:30.356755519Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.6\" returns image reference \"sha256:63f0cbe3b7339c5d006efc9964228e48271bae73039320037c451b5e8f763e02\"" Jun 21 04:44:30.357698 containerd[1559]: time="2025-06-21T04:44:30.357659435Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Jun 21 04:44:30.358768 containerd[1559]: time="2025-06-21T04:44:30.358740203Z" level=info msg="CreateContainer within sandbox \"a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jun 21 04:44:30.369947 containerd[1559]: time="2025-06-21T04:44:30.369885151Z" level=info msg="Container 879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:44:30.380325 containerd[1559]: time="2025-06-21T04:44:30.380272759Z" level=info msg="CreateContainer within sandbox \"a61865fb8389fff7699e7d10c96e17c8cd91370ad73edcacf71841d9512a2e4a\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb\"" Jun 21 04:44:30.381354 containerd[1559]: time="2025-06-21T04:44:30.381179420Z" level=info msg="StartContainer for \"879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb\"" Jun 21 04:44:30.382737 containerd[1559]: time="2025-06-21T04:44:30.382686678Z" level=info msg="connecting to shim 879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb" address="unix:///run/containerd/s/51bd3c881d7bb0c5c716c51a5de487f780d4414250981a6f8c70c9aa83227acb" protocol=ttrpc version=3 Jun 21 04:44:30.411920 systemd[1]: Started cri-containerd-879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb.scope - libcontainer container 879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb. Jun 21 04:44:30.460612 containerd[1559]: time="2025-06-21T04:44:30.460553993Z" level=info msg="StartContainer for \"879ead0b916e695c3ce526166ccefb1c57011dc619e9a7da9f6d09b0ef6bf0fb\" returns successfully" Jun 21 04:44:30.642512 kubelet[1861]: E0621 04:44:30.642363 1861 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" Jun 21 04:44:30.651024 kubelet[1861]: I0621 04:44:30.650941 1861 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-xxf58" podStartSLOduration=2.336904346 podStartE2EDuration="3.650913591s" podCreationTimestamp="2025-06-21 04:44:27 +0000 UTC" firstStartedPulling="2025-06-21 04:44:29.043405591 +0000 UTC m=+2.581298471" lastFinishedPulling="2025-06-21 04:44:30.357414836 +0000 UTC m=+3.895307716" observedRunningTime="2025-06-21 04:44:30.650484366 +0000 UTC m=+4.188377256" watchObservedRunningTime="2025-06-21 04:44:30.650913591 +0000 UTC m=+4.188806471" Jun 21 04:44:30.899289 kubelet[1861]: E0621 04:44:30.899135 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:31.643794 kubelet[1861]: E0621 04:44:31.643749 1861 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" Jun 21 04:44:31.899992 kubelet[1861]: E0621 04:44:31.899834 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:32.130397 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3157662596.mount: Deactivated successfully. Jun 21 04:44:32.299704 containerd[1559]: time="2025-06-21T04:44:32.299654446Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:32.300495 containerd[1559]: time="2025-06-21T04:44:32.300459737Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852937" Jun 21 04:44:32.301609 containerd[1559]: time="2025-06-21T04:44:32.301572254Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:32.327707 containerd[1559]: time="2025-06-21T04:44:32.327668823Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:32.328478 containerd[1559]: time="2025-06-21T04:44:32.328452644Z" 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 1.970744458s" Jun 21 04:44:32.328526 containerd[1559]: time="2025-06-21T04:44:32.328481909Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Jun 21 04:44:32.330345 containerd[1559]: time="2025-06-21T04:44:32.330303697Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jun 21 04:44:32.359848 containerd[1559]: time="2025-06-21T04:44:32.359800374Z" level=info msg="Container 2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:44:32.368192 containerd[1559]: time="2025-06-21T04:44:32.368148787Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\"" Jun 21 04:44:32.368593 containerd[1559]: time="2025-06-21T04:44:32.368561651Z" level=info msg="StartContainer for \"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\"" Jun 21 04:44:32.369467 containerd[1559]: time="2025-06-21T04:44:32.369424760Z" level=info msg="connecting to shim 2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795" address="unix:///run/containerd/s/0ae0f2e60406637c187b660a91cb2dc18cd23f02738805547daf3e2b1cdd3b21" protocol=ttrpc version=3 Jun 21 04:44:32.395899 systemd[1]: Started cri-containerd-2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795.scope - libcontainer container 2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795. Jun 21 04:44:32.436195 systemd[1]: cri-containerd-2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795.scope: Deactivated successfully. Jun 21 04:44:32.438009 containerd[1559]: time="2025-06-21T04:44:32.437965588Z" level=info msg="received exit event container_id:\"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\" id:\"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\" pid:2195 exited_at:{seconds:1750481072 nanos:437493312}" Jun 21 04:44:32.438135 containerd[1559]: time="2025-06-21T04:44:32.438109508Z" level=info msg="TaskExit event in podsandbox handler container_id:\"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\" id:\"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\" pid:2195 exited_at:{seconds:1750481072 nanos:437493312}" Jun 21 04:44:32.438712 containerd[1559]: time="2025-06-21T04:44:32.438688013Z" level=info msg="StartContainer for \"2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795\" returns successfully" Jun 21 04:44:32.647453 kubelet[1861]: E0621 04:44:32.646915 1861 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" Jun 21 04:44:32.900594 kubelet[1861]: E0621 04:44:32.900385 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:33.059004 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-2332ba416fbe096af5184d81d697758a5301eaa1d94ce88985986df504340795-rootfs.mount: Deactivated successfully. Jun 21 04:44:33.649437 kubelet[1861]: E0621 04:44:33.649386 1861 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" Jun 21 04:44:33.650307 containerd[1559]: time="2025-06-21T04:44:33.650236976Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Jun 21 04:44:33.902090 kubelet[1861]: E0621 04:44:33.901346 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:34.902599 kubelet[1861]: E0621 04:44:34.902539 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:35.453709 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount733083652.mount: Deactivated successfully. Jun 21 04:44:35.903855 kubelet[1861]: E0621 04:44:35.903702 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:36.441187 containerd[1559]: time="2025-06-21T04:44:36.441126614Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:36.441897 containerd[1559]: time="2025-06-21T04:44:36.441866081Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866358" Jun 21 04:44:36.442999 containerd[1559]: time="2025-06-21T04:44:36.442957469Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:36.445439 containerd[1559]: time="2025-06-21T04:44:36.445403638Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:44:36.446322 containerd[1559]: time="2025-06-21T04:44:36.446274992Z" 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 2.795982583s" Jun 21 04:44:36.446385 containerd[1559]: time="2025-06-21T04:44:36.446323453Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Jun 21 04:44:36.448057 containerd[1559]: time="2025-06-21T04:44:36.448036507Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jun 21 04:44:36.457824 containerd[1559]: time="2025-06-21T04:44:36.457775118Z" level=info msg="Container 5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:44:36.465079 containerd[1559]: time="2025-06-21T04:44:36.465024999Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\"" Jun 21 04:44:36.467997 containerd[1559]: time="2025-06-21T04:44:36.467925490Z" level=info msg="StartContainer for \"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\"" Jun 21 04:44:36.469180 containerd[1559]: time="2025-06-21T04:44:36.469152993Z" level=info msg="connecting to shim 5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf" address="unix:///run/containerd/s/0ae0f2e60406637c187b660a91cb2dc18cd23f02738805547daf3e2b1cdd3b21" protocol=ttrpc version=3 Jun 21 04:44:36.501903 systemd[1]: Started cri-containerd-5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf.scope - libcontainer container 5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf. Jun 21 04:44:36.538991 systemd[1]: cri-containerd-5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf.scope: Deactivated successfully. Jun 21 04:44:36.540475 containerd[1559]: time="2025-06-21T04:44:36.540335076Z" level=warning msg="error from *cgroupsv2.Manager.EventChan" error="failed to add inotify watch for \"/sys/fs/cgroup/kubepods.slice/kubepods-burstable.slice/kubepods-burstable-pod715eff34_0e65_4fdb_8587_1629d55298da.slice/cri-containerd-5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf.scope/memory.events\": no such file or directory" Jun 21 04:44:36.540795 containerd[1559]: time="2025-06-21T04:44:36.540563575Z" level=info msg="TaskExit event in podsandbox handler container_id:\"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\" id:\"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\" pid:2269 exited_at:{seconds:1750481076 nanos:539911742}" Jun 21 04:44:36.572184 containerd[1559]: time="2025-06-21T04:44:36.572143060Z" level=info msg="received exit event container_id:\"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\" id:\"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\" pid:2269 exited_at:{seconds:1750481076 nanos:539911742}" Jun 21 04:44:36.574026 containerd[1559]: time="2025-06-21T04:44:36.573999062Z" level=info msg="StartContainer for \"5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf\" returns successfully" Jun 21 04:44:36.578594 kubelet[1861]: I0621 04:44:36.578568 1861 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Jun 21 04:44:36.658022 kubelet[1861]: E0621 04:44:36.657977 1861 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" Jun 21 04:44:36.729738 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-5aeb948d0dcb4d6ecc787ad5836bad589e10a10c3a7e0db350106860dc1d0fbf-rootfs.mount: Deactivated successfully. Jun 21 04:44:36.904835 kubelet[1861]: E0621 04:44:36.904761 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:37.662354 kubelet[1861]: E0621 04:44:37.662310 1861 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" Jun 21 04:44:37.663963 containerd[1559]: time="2025-06-21T04:44:37.663903841Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jun 21 04:44:37.905280 kubelet[1861]: E0621 04:44:37.905188 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:37.920585 containerd[1559]: time="2025-06-21T04:44:37.920392302Z" level=info msg="Container 96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:44:38.212054 containerd[1559]: time="2025-06-21T04:44:38.211992715Z" level=info msg="CreateContainer within sandbox \"6b27f4f7d2e250b4015e70fcf40f2c642430701acb302627862af4a88039a42f\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307\"" Jun 21 04:44:38.212610 containerd[1559]: time="2025-06-21T04:44:38.212582321Z" level=info msg="StartContainer for \"96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307\"" Jun 21 04:44:38.213741 containerd[1559]: time="2025-06-21T04:44:38.213696842Z" level=info msg="connecting to shim 96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307" address="unix:///run/containerd/s/0ae0f2e60406637c187b660a91cb2dc18cd23f02738805547daf3e2b1cdd3b21" protocol=ttrpc version=3 Jun 21 04:44:38.241878 systemd[1]: Started cri-containerd-96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307.scope - libcontainer container 96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307. Jun 21 04:44:38.359219 containerd[1559]: time="2025-06-21T04:44:38.358181696Z" level=info msg="StartContainer for \"96dc86b5a484a679ccfaf35a13a6726e9156171417b0341632cd10113b39e307\" returns successfully" Jun 21 04:44:38.668042 kubelet[1861]: E0621 04:44:38.667868 1861 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" Jun 21 04:44:38.835703 kubelet[1861]: I0621 04:44:38.835625 1861 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-mbbs7" podStartSLOduration=4.454212487 podStartE2EDuration="11.835595739s" podCreationTimestamp="2025-06-21 04:44:27 +0000 UTC" firstStartedPulling="2025-06-21 04:44:29.065577407 +0000 UTC m=+2.603470287" lastFinishedPulling="2025-06-21 04:44:36.446960669 +0000 UTC m=+9.984853539" observedRunningTime="2025-06-21 04:44:38.679431103 +0000 UTC m=+12.217323993" watchObservedRunningTime="2025-06-21 04:44:38.835595739 +0000 UTC m=+12.373488619" Jun 21 04:44:38.842105 kubelet[1861]: I0621 04:44:38.841858 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-p49r9\" (UniqueName: \"kubernetes.io/projected/7332e027-e9c1-420a-9768-78ab0f1e1060-kube-api-access-p49r9\") pod \"nginx-deployment-7fcdb87857-bj4p9\" (UID: \"7332e027-e9c1-420a-9768-78ab0f1e1060\") " pod="default/nginx-deployment-7fcdb87857-bj4p9" Jun 21 04:44:38.843167 systemd[1]: Created slice kubepods-besteffort-pod7332e027_e9c1_420a_9768_78ab0f1e1060.slice - libcontainer container kubepods-besteffort-pod7332e027_e9c1_420a_9768_78ab0f1e1060.slice. Jun 21 04:44:38.906227 kubelet[1861]: E0621 04:44:38.906160 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:39.147474 containerd[1559]: time="2025-06-21T04:44:39.147406748Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-bj4p9,Uid:7332e027-e9c1-420a-9768-78ab0f1e1060,Namespace:default,Attempt:0,}" Jun 21 04:44:39.171558 containerd[1559]: time="2025-06-21T04:44:39.171463992Z" level=error msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-bj4p9,Uid:7332e027-e9c1-420a-9768-78ab0f1e1060,Namespace:default,Attempt:0,} failed, error" error="rpc error: code = Unknown desc = failed to setup network for sandbox \"0b2a084d9c10e4d583c342e58f64e4b57950fd5b603bbad38e0f4caca567192e\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jun 21 04:44:39.171936 kubelet[1861]: E0621 04:44:39.171852 1861 log.go:32] "RunPodSandbox from runtime service failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"0b2a084d9c10e4d583c342e58f64e4b57950fd5b603bbad38e0f4caca567192e\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jun 21 04:44:39.172018 kubelet[1861]: E0621 04:44:39.171971 1861 kuberuntime_sandbox.go:72] "Failed to create sandbox for pod" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"0b2a084d9c10e4d583c342e58f64e4b57950fd5b603bbad38e0f4caca567192e\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-7fcdb87857-bj4p9" Jun 21 04:44:39.172018 kubelet[1861]: E0621 04:44:39.172003 1861 kuberuntime_manager.go:1237] "CreatePodSandbox for pod failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"0b2a084d9c10e4d583c342e58f64e4b57950fd5b603bbad38e0f4caca567192e\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-7fcdb87857-bj4p9" Jun 21 04:44:39.172104 kubelet[1861]: E0621 04:44:39.172066 1861 pod_workers.go:1301] "Error syncing pod, skipping" err="failed to \"CreatePodSandbox\" for \"nginx-deployment-7fcdb87857-bj4p9_default(7332e027-e9c1-420a-9768-78ab0f1e1060)\" with CreatePodSandboxError: \"Failed to create sandbox for pod \\\"nginx-deployment-7fcdb87857-bj4p9_default(7332e027-e9c1-420a-9768-78ab0f1e1060)\\\": rpc error: code = Unknown desc = failed to setup network for sandbox \\\"0b2a084d9c10e4d583c342e58f64e4b57950fd5b603bbad38e0f4caca567192e\\\": plugin type=\\\"flannel\\\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory\"" pod="default/nginx-deployment-7fcdb87857-bj4p9" podUID="7332e027-e9c1-420a-9768-78ab0f1e1060" Jun 21 04:44:39.172862 systemd[1]: run-netns-cni\x2df9dcaec2\x2d26e8\x2d1a16\x2d072b\x2dd5de63279f06.mount: Deactivated successfully. Jun 21 04:44:39.414297 systemd-networkd[1494]: flannel.1: Link UP Jun 21 04:44:39.414307 systemd-networkd[1494]: flannel.1: Gained carrier Jun 21 04:44:39.669832 kubelet[1861]: E0621 04:44:39.669690 1861 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" Jun 21 04:44:39.907008 kubelet[1861]: E0621 04:44:39.906946 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:40.907617 kubelet[1861]: E0621 04:44:40.907540 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:40.956034 systemd-networkd[1494]: flannel.1: Gained IPv6LL Jun 21 04:44:41.908817 kubelet[1861]: E0621 04:44:41.908744 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:42.909022 kubelet[1861]: E0621 04:44:42.908939 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:43.909763 kubelet[1861]: E0621 04:44:43.909675 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:44.910583 kubelet[1861]: E0621 04:44:44.910511 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:45.911101 kubelet[1861]: E0621 04:44:45.911007 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:46.896495 kubelet[1861]: E0621 04:44:46.896421 1861 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:46.912114 kubelet[1861]: E0621 04:44:46.912068 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:47.912691 kubelet[1861]: E0621 04:44:47.912615 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:48.913158 kubelet[1861]: E0621 04:44:48.913094 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:49.913923 kubelet[1861]: E0621 04:44:49.913842 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:50.915064 kubelet[1861]: E0621 04:44:50.915003 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:51.915643 kubelet[1861]: E0621 04:44:51.915561 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:52.916776 kubelet[1861]: E0621 04:44:52.916621 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:53.916914 kubelet[1861]: E0621 04:44:53.916828 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:54.574890 containerd[1559]: time="2025-06-21T04:44:54.574806114Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-bj4p9,Uid:7332e027-e9c1-420a-9768-78ab0f1e1060,Namespace:default,Attempt:0,}" Jun 21 04:44:54.615931 systemd-networkd[1494]: cni0: Link UP Jun 21 04:44:54.615943 systemd-networkd[1494]: cni0: Gained carrier Jun 21 04:44:54.621198 systemd-networkd[1494]: cni0: Lost carrier Jun 21 04:44:54.629758 systemd-networkd[1494]: veth2078082c: Link UP Jun 21 04:44:54.632369 kernel: cni0: port 1(veth2078082c) entered blocking state Jun 21 04:44:54.632434 kernel: cni0: port 1(veth2078082c) entered disabled state Jun 21 04:44:54.632460 kernel: veth2078082c: entered allmulticast mode Jun 21 04:44:54.632481 kernel: veth2078082c: entered promiscuous mode Jun 21 04:44:54.673554 kernel: cni0: port 1(veth2078082c) entered blocking state Jun 21 04:44:54.673694 kernel: cni0: port 1(veth2078082c) entered forwarding state Jun 21 04:44:54.673967 systemd-networkd[1494]: veth2078082c: Gained carrier Jun 21 04:44:54.674402 systemd-networkd[1494]: cni0: Gained carrier Jun 21 04:44:54.677561 containerd[1559]: 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)(0xc0001268e8), "name":"cbr0", "type":"bridge"} Jun 21 04:44:54.677561 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Jun 21 04:44:54.918139 kubelet[1861]: E0621 04:44:54.917998 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:54.991921 containerd[1559]: {"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-06-21T04:44:54.991824235Z" level=info msg="connecting to shim 41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16" address="unix:///run/containerd/s/b5c314d82d2c8f34e2b1868364d643941b7198be70fce62b134d79389588b749" namespace=k8s.io protocol=ttrpc version=3 Jun 21 04:44:55.034889 systemd[1]: Started cri-containerd-41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16.scope - libcontainer container 41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16. Jun 21 04:44:55.047838 systemd-resolved[1415]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 04:44:55.449301 containerd[1559]: time="2025-06-21T04:44:55.449239441Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-bj4p9,Uid:7332e027-e9c1-420a-9768-78ab0f1e1060,Namespace:default,Attempt:0,} returns sandbox id \"41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16\"" Jun 21 04:44:55.450435 containerd[1559]: time="2025-06-21T04:44:55.450391355Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 21 04:44:55.919458 kubelet[1861]: E0621 04:44:55.919233 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:55.931977 systemd-networkd[1494]: cni0: Gained IPv6LL Jun 21 04:44:55.932323 systemd-networkd[1494]: veth2078082c: Gained IPv6LL Jun 21 04:44:56.919859 kubelet[1861]: E0621 04:44:56.919791 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:57.920547 kubelet[1861]: E0621 04:44:57.920458 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:58.878118 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2690123056.mount: Deactivated successfully. Jun 21 04:44:58.921318 kubelet[1861]: E0621 04:44:58.921263 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:44:59.922015 kubelet[1861]: E0621 04:44:59.921951 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:00.687164 containerd[1559]: time="2025-06-21T04:45:00.687078239Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:00.688288 containerd[1559]: time="2025-06-21T04:45:00.688227491Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73313230" Jun 21 04:45:00.689903 containerd[1559]: time="2025-06-21T04:45:00.689831102Z" level=info msg="ImageCreate event name:\"sha256:601c94998c5615a5f36a1babb9bcc2b1d9f112c02c19d68701b29f3fd6b2feb8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:00.692566 containerd[1559]: time="2025-06-21T04:45:00.692520705Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:00.693376 containerd[1559]: time="2025-06-21T04:45:00.693313644Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:601c94998c5615a5f36a1babb9bcc2b1d9f112c02c19d68701b29f3fd6b2feb8\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\", size \"73313108\" in 5.242873595s" Jun 21 04:45:00.693376 containerd[1559]: time="2025-06-21T04:45:00.693353240Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:601c94998c5615a5f36a1babb9bcc2b1d9f112c02c19d68701b29f3fd6b2feb8\"" Jun 21 04:45:00.695739 containerd[1559]: time="2025-06-21T04:45:00.695698734Z" level=info msg="CreateContainer within sandbox \"41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jun 21 04:45:00.759601 containerd[1559]: time="2025-06-21T04:45:00.759523545Z" level=info msg="Container d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:45:00.771105 containerd[1559]: time="2025-06-21T04:45:00.771027133Z" level=info msg="CreateContainer within sandbox \"41ea938f66381e56d67f46f9e18bff7a80a111d8004f54ed1457ff2d7bf83f16\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e\"" Jun 21 04:45:00.771768 containerd[1559]: time="2025-06-21T04:45:00.771652501Z" level=info msg="StartContainer for \"d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e\"" Jun 21 04:45:00.772897 containerd[1559]: time="2025-06-21T04:45:00.772864754Z" level=info msg="connecting to shim d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e" address="unix:///run/containerd/s/b5c314d82d2c8f34e2b1868364d643941b7198be70fce62b134d79389588b749" protocol=ttrpc version=3 Jun 21 04:45:00.841921 systemd[1]: Started cri-containerd-d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e.scope - libcontainer container d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e. Jun 21 04:45:00.900925 containerd[1559]: time="2025-06-21T04:45:00.900834100Z" level=info msg="StartContainer for \"d573d09ffa167ea08c16d9a8c46c836faf6eaa67657c86ac100486c0d08f587e\" returns successfully" Jun 21 04:45:00.922263 kubelet[1861]: E0621 04:45:00.922191 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:01.717967 kubelet[1861]: I0621 04:45:01.717885 1861 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-bj4p9" podStartSLOduration=18.473582819 podStartE2EDuration="23.717868585s" podCreationTimestamp="2025-06-21 04:44:38 +0000 UTC" firstStartedPulling="2025-06-21 04:44:55.450137274 +0000 UTC m=+28.988030154" lastFinishedPulling="2025-06-21 04:45:00.69442304 +0000 UTC m=+34.232315920" observedRunningTime="2025-06-21 04:45:01.717700213 +0000 UTC m=+35.255593093" watchObservedRunningTime="2025-06-21 04:45:01.717868585 +0000 UTC m=+35.255761465" Jun 21 04:45:01.923213 kubelet[1861]: E0621 04:45:01.923112 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:02.924451 kubelet[1861]: E0621 04:45:02.924298 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:03.924521 kubelet[1861]: E0621 04:45:03.924453 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:04.480982 update_engine[1545]: I20250621 04:45:04.480842 1545 update_attempter.cc:509] Updating boot flags... Jun 21 04:45:04.925384 kubelet[1861]: E0621 04:45:04.925325 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:05.926243 kubelet[1861]: E0621 04:45:05.926150 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:06.413373 systemd[1]: Created slice kubepods-besteffort-pod6b7d9153_034b_40e4_99e4_74b27d0cbb91.slice - libcontainer container kubepods-besteffort-pod6b7d9153_034b_40e4_99e4_74b27d0cbb91.slice. Jun 21 04:45:06.489984 kubelet[1861]: I0621 04:45:06.489896 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-bjcr5\" (UniqueName: \"kubernetes.io/projected/6b7d9153-034b-40e4-99e4-74b27d0cbb91-kube-api-access-bjcr5\") pod \"nfs-server-provisioner-0\" (UID: \"6b7d9153-034b-40e4-99e4-74b27d0cbb91\") " pod="default/nfs-server-provisioner-0" Jun 21 04:45:06.489984 kubelet[1861]: I0621 04:45:06.489954 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/6b7d9153-034b-40e4-99e4-74b27d0cbb91-data\") pod \"nfs-server-provisioner-0\" (UID: \"6b7d9153-034b-40e4-99e4-74b27d0cbb91\") " pod="default/nfs-server-provisioner-0" Jun 21 04:45:06.717757 containerd[1559]: time="2025-06-21T04:45:06.717657892Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:6b7d9153-034b-40e4-99e4-74b27d0cbb91,Namespace:default,Attempt:0,}" Jun 21 04:45:06.736010 systemd-networkd[1494]: veth5fb69ba5: Link UP Jun 21 04:45:06.737534 kernel: cni0: port 2(veth5fb69ba5) entered blocking state Jun 21 04:45:06.737599 kernel: cni0: port 2(veth5fb69ba5) entered disabled state Jun 21 04:45:06.738458 kernel: veth5fb69ba5: entered allmulticast mode Jun 21 04:45:06.739335 kernel: veth5fb69ba5: entered promiscuous mode Jun 21 04:45:06.748606 kernel: cni0: port 2(veth5fb69ba5) entered blocking state Jun 21 04:45:06.748769 kernel: cni0: port 2(veth5fb69ba5) entered forwarding state Jun 21 04:45:06.748824 systemd-networkd[1494]: veth5fb69ba5: Gained carrier Jun 21 04:45:06.752101 containerd[1559]: 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)(0xc00011a8e8), "name":"cbr0", "type":"bridge"} Jun 21 04:45:06.752101 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Jun 21 04:45:06.789377 containerd[1559]: {"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-06-21T04:45:06.789235123Z" level=info msg="connecting to shim af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e" address="unix:///run/containerd/s/c0d29a8e0bf8149c678f02ef2a7a4b3225f47d92c897ff51f966c6e9ed15c41e" namespace=k8s.io protocol=ttrpc version=3 Jun 21 04:45:06.826863 systemd[1]: Started cri-containerd-af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e.scope - libcontainer container af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e. Jun 21 04:45:06.844248 systemd-resolved[1415]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 04:45:06.879660 containerd[1559]: time="2025-06-21T04:45:06.879603174Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:6b7d9153-034b-40e4-99e4-74b27d0cbb91,Namespace:default,Attempt:0,} returns sandbox id \"af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e\"" Jun 21 04:45:06.881595 containerd[1559]: time="2025-06-21T04:45:06.881568814Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jun 21 04:45:06.896831 kubelet[1861]: E0621 04:45:06.896767 1861 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:06.926694 kubelet[1861]: E0621 04:45:06.926620 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:07.927564 kubelet[1861]: E0621 04:45:07.927470 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:08.224917 systemd-networkd[1494]: veth5fb69ba5: Gained IPv6LL Jun 21 04:45:08.928407 kubelet[1861]: E0621 04:45:08.928353 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:09.793446 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3039642125.mount: Deactivated successfully. Jun 21 04:45:09.928562 kubelet[1861]: E0621 04:45:09.928509 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:10.929794 kubelet[1861]: E0621 04:45:10.929712 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:11.929969 kubelet[1861]: E0621 04:45:11.929909 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:11.978162 containerd[1559]: time="2025-06-21T04:45:11.978067882Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:11.982020 containerd[1559]: time="2025-06-21T04:45:11.981987572Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Jun 21 04:45:11.983538 containerd[1559]: time="2025-06-21T04:45:11.983492645Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:11.986697 containerd[1559]: time="2025-06-21T04:45:11.986646323Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:11.987484 containerd[1559]: time="2025-06-21T04:45:11.987434668Z" 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 5.105831637s" Jun 21 04:45:11.987484 containerd[1559]: time="2025-06-21T04:45:11.987479202Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jun 21 04:45:11.989585 containerd[1559]: time="2025-06-21T04:45:11.989545940Z" level=info msg="CreateContainer within sandbox \"af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jun 21 04:45:11.999631 containerd[1559]: time="2025-06-21T04:45:11.999547047Z" level=info msg="Container 55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:45:12.004712 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount942630967.mount: Deactivated successfully. Jun 21 04:45:12.009351 containerd[1559]: time="2025-06-21T04:45:12.009282922Z" level=info msg="CreateContainer within sandbox \"af7e41bfd7a6bab37d7caa6e3682cbd55f15b3207752665770d72d4cfa62e27e\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8\"" Jun 21 04:45:12.010091 containerd[1559]: time="2025-06-21T04:45:12.010004961Z" level=info msg="StartContainer for \"55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8\"" Jun 21 04:45:12.010978 containerd[1559]: time="2025-06-21T04:45:12.010942346Z" level=info msg="connecting to shim 55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8" address="unix:///run/containerd/s/c0d29a8e0bf8149c678f02ef2a7a4b3225f47d92c897ff51f966c6e9ed15c41e" protocol=ttrpc version=3 Jun 21 04:45:12.042932 systemd[1]: Started cri-containerd-55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8.scope - libcontainer container 55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8. Jun 21 04:45:12.079468 containerd[1559]: time="2025-06-21T04:45:12.079414838Z" level=info msg="StartContainer for \"55c2713c027032daa4a87da3d77ca9ce548c339980c6b4572ccd498af1fa23f8\" returns successfully" Jun 21 04:45:12.742477 kubelet[1861]: I0621 04:45:12.742393 1861 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.635329718 podStartE2EDuration="6.742369631s" podCreationTimestamp="2025-06-21 04:45:06 +0000 UTC" firstStartedPulling="2025-06-21 04:45:06.881169614 +0000 UTC m=+40.419062494" lastFinishedPulling="2025-06-21 04:45:11.988209527 +0000 UTC m=+45.526102407" observedRunningTime="2025-06-21 04:45:12.742183569 +0000 UTC m=+46.280076439" watchObservedRunningTime="2025-06-21 04:45:12.742369631 +0000 UTC m=+46.280262511" Jun 21 04:45:12.930921 kubelet[1861]: E0621 04:45:12.930845 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:13.931088 kubelet[1861]: E0621 04:45:13.931012 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:14.932118 kubelet[1861]: E0621 04:45:14.932044 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:15.932887 kubelet[1861]: E0621 04:45:15.932822 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:16.933755 kubelet[1861]: E0621 04:45:16.933673 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:17.934967 kubelet[1861]: E0621 04:45:17.934884 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:18.935443 kubelet[1861]: E0621 04:45:18.935363 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:19.936028 kubelet[1861]: E0621 04:45:19.935943 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:20.936237 kubelet[1861]: E0621 04:45:20.936157 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:21.936587 kubelet[1861]: E0621 04:45:21.936479 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:22.937026 kubelet[1861]: E0621 04:45:22.936942 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:23.496340 systemd[1]: Created slice kubepods-besteffort-pod568b7d89_d536_4f64_9490_7ad8c9461645.slice - libcontainer container kubepods-besteffort-pod568b7d89_d536_4f64_9490_7ad8c9461645.slice. Jun 21 04:45:23.695860 kubelet[1861]: I0621 04:45:23.695703 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-67179b6b-6570-4c7d-87eb-1f5b4801b42f\" (UniqueName: \"kubernetes.io/nfs/568b7d89-d536-4f64-9490-7ad8c9461645-pvc-67179b6b-6570-4c7d-87eb-1f5b4801b42f\") pod \"test-pod-1\" (UID: \"568b7d89-d536-4f64-9490-7ad8c9461645\") " pod="default/test-pod-1" Jun 21 04:45:23.695860 kubelet[1861]: I0621 04:45:23.695838 1861 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-bzpmh\" (UniqueName: \"kubernetes.io/projected/568b7d89-d536-4f64-9490-7ad8c9461645-kube-api-access-bzpmh\") pod \"test-pod-1\" (UID: \"568b7d89-d536-4f64-9490-7ad8c9461645\") " pod="default/test-pod-1" Jun 21 04:45:23.834782 kernel: netfs: FS-Cache loaded Jun 21 04:45:23.902257 kernel: RPC: Registered named UNIX socket transport module. Jun 21 04:45:23.902410 kernel: RPC: Registered udp transport module. Jun 21 04:45:23.902434 kernel: RPC: Registered tcp transport module. Jun 21 04:45:23.902454 kernel: RPC: Registered tcp-with-tls transport module. Jun 21 04:45:23.902949 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 21 04:45:23.937265 kubelet[1861]: E0621 04:45:23.937192 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:24.140052 kernel: NFS: Registering the id_resolver key type Jun 21 04:45:24.140215 kernel: Key type id_resolver registered Jun 21 04:45:24.140242 kernel: Key type id_legacy registered Jun 21 04:45:24.166691 nfsidmap[3001]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Jun 21 04:45:24.167659 nfsidmap[3001]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jun 21 04:45:24.172071 nfsidmap[3004]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Jun 21 04:45:24.172258 nfsidmap[3004]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jun 21 04:45:24.178950 nfsrahead[3008]: setting /var/lib/kubelet/pods/568b7d89-d536-4f64-9490-7ad8c9461645/volumes/kubernetes.io~nfs/pvc-67179b6b-6570-4c7d-87eb-1f5b4801b42f readahead to 128 Jun 21 04:45:24.400814 containerd[1559]: time="2025-06-21T04:45:24.400704400Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:568b7d89-d536-4f64-9490-7ad8c9461645,Namespace:default,Attempt:0,}" Jun 21 04:45:24.482607 systemd-networkd[1494]: veth8c2192e4: Link UP Jun 21 04:45:24.484526 kernel: cni0: port 3(veth8c2192e4) entered blocking state Jun 21 04:45:24.484639 kernel: cni0: port 3(veth8c2192e4) entered disabled state Jun 21 04:45:24.484660 kernel: veth8c2192e4: entered allmulticast mode Jun 21 04:45:24.486183 kernel: veth8c2192e4: entered promiscuous mode Jun 21 04:45:24.492532 kernel: cni0: port 3(veth8c2192e4) entered blocking state Jun 21 04:45:24.492576 kernel: cni0: port 3(veth8c2192e4) entered forwarding state Jun 21 04:45:24.493467 systemd-networkd[1494]: veth8c2192e4: Gained carrier Jun 21 04:45:24.496798 containerd[1559]: 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)(0xc0000b48e8), "name":"cbr0", "type":"bridge"} Jun 21 04:45:24.496798 containerd[1559]: delegateAdd: netconf sent to delegate plugin: Jun 21 04:45:24.807074 containerd[1559]: {"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-06-21T04:45:24.806939592Z" level=info msg="connecting to shim 8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764" address="unix:///run/containerd/s/d494e143db6c99cbe17ba4089ebb868f4e597251df7ecaa16c28aa3df7a1964c" namespace=k8s.io protocol=ttrpc version=3 Jun 21 04:45:24.839916 systemd[1]: Started cri-containerd-8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764.scope - libcontainer container 8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764. Jun 21 04:45:24.856315 systemd-resolved[1415]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jun 21 04:45:24.894883 containerd[1559]: time="2025-06-21T04:45:24.894822749Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:568b7d89-d536-4f64-9490-7ad8c9461645,Namespace:default,Attempt:0,} returns sandbox id \"8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764\"" Jun 21 04:45:24.896111 containerd[1559]: time="2025-06-21T04:45:24.896066903Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 21 04:45:24.937603 kubelet[1861]: E0621 04:45:24.937523 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:25.752322 containerd[1559]: time="2025-06-21T04:45:25.752241679Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 21 04:45:25.753631 containerd[1559]: time="2025-06-21T04:45:25.753587235Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jun 21 04:45:25.756216 containerd[1559]: time="2025-06-21T04:45:25.756169760Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:601c94998c5615a5f36a1babb9bcc2b1d9f112c02c19d68701b29f3fd6b2feb8\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:9a18b8b1845bf88a3388cde4ec626461965a717ac641198120979e75438b9693\", size \"73313108\" in 860.065637ms" Jun 21 04:45:25.756216 containerd[1559]: time="2025-06-21T04:45:25.756204897Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:601c94998c5615a5f36a1babb9bcc2b1d9f112c02c19d68701b29f3fd6b2feb8\"" Jun 21 04:45:25.758299 containerd[1559]: time="2025-06-21T04:45:25.758270147Z" level=info msg="CreateContainer within sandbox \"8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jun 21 04:45:25.772235 containerd[1559]: time="2025-06-21T04:45:25.772174733Z" level=info msg="Container 892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5: CDI devices from CRI Config.CDIDevices: []" Jun 21 04:45:25.781964 containerd[1559]: time="2025-06-21T04:45:25.781914602Z" level=info msg="CreateContainer within sandbox \"8f9a5b4b75dd12b063ede9b19c78a6ca6a2e15f5f26597e8138ad709a06d6764\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5\"" Jun 21 04:45:25.782514 containerd[1559]: time="2025-06-21T04:45:25.782462065Z" level=info msg="StartContainer for \"892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5\"" Jun 21 04:45:25.783486 containerd[1559]: time="2025-06-21T04:45:25.783454213Z" level=info msg="connecting to shim 892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5" address="unix:///run/containerd/s/d494e143db6c99cbe17ba4089ebb868f4e597251df7ecaa16c28aa3df7a1964c" protocol=ttrpc version=3 Jun 21 04:45:25.806882 systemd[1]: Started cri-containerd-892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5.scope - libcontainer container 892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5. Jun 21 04:45:25.838969 containerd[1559]: time="2025-06-21T04:45:25.838897136Z" level=info msg="StartContainer for \"892aaf1066be901f1ca7f87b71dc3b5e6370b9fe0afbdd6c3317f73cd9ad92f5\" returns successfully" Jun 21 04:45:25.937850 kubelet[1861]: E0621 04:45:25.937716 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:26.331945 systemd-networkd[1494]: veth8c2192e4: Gained IPv6LL Jun 21 04:45:26.802863 kubelet[1861]: I0621 04:45:26.802764 1861 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=19.941678165 podStartE2EDuration="20.802707929s" podCreationTimestamp="2025-06-21 04:45:06 +0000 UTC" firstStartedPulling="2025-06-21 04:45:24.89578387 +0000 UTC m=+58.433676750" lastFinishedPulling="2025-06-21 04:45:25.756813634 +0000 UTC m=+59.294706514" observedRunningTime="2025-06-21 04:45:26.802557695 +0000 UTC m=+60.340450575" watchObservedRunningTime="2025-06-21 04:45:26.802707929 +0000 UTC m=+60.340600809" Jun 21 04:45:26.895893 kubelet[1861]: E0621 04:45:26.895817 1861 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:26.938036 kubelet[1861]: E0621 04:45:26.937919 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:27.938425 kubelet[1861]: E0621 04:45:27.938360 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 21 04:45:28.939647 kubelet[1861]: E0621 04:45:28.939570 1861 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"