Jul 10 00:19:17.873054 kernel: Linux version 6.12.36-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 Wed Jul 9 22:15:30 -00 2025 Jul 10 00:19:17.873093 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=844005237fb9709f65a093d5533c4229fb6c54e8e257736d9c3d041b6d3080ea Jul 10 00:19:17.873106 kernel: BIOS-provided physical RAM map: Jul 10 00:19:17.873113 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000002ffff] usable Jul 10 00:19:17.873120 kernel: BIOS-e820: [mem 0x0000000000030000-0x000000000004ffff] reserved Jul 10 00:19:17.873126 kernel: BIOS-e820: [mem 0x0000000000050000-0x000000000009efff] usable Jul 10 00:19:17.873135 kernel: BIOS-e820: [mem 0x000000000009f000-0x000000000009ffff] reserved Jul 10 00:19:17.873143 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009b8ecfff] usable Jul 10 00:19:17.873156 kernel: BIOS-e820: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Jul 10 00:19:17.873166 kernel: BIOS-e820: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Jul 10 00:19:17.873174 kernel: BIOS-e820: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Jul 10 00:19:17.873187 kernel: BIOS-e820: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Jul 10 00:19:17.873196 kernel: BIOS-e820: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Jul 10 00:19:17.873203 kernel: BIOS-e820: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Jul 10 00:19:17.873211 kernel: BIOS-e820: [mem 0x000000009bfb7000-0x000000009bffffff] usable Jul 10 00:19:17.873218 kernel: BIOS-e820: [mem 0x000000009c000000-0x000000009cffffff] reserved Jul 10 00:19:17.873231 kernel: BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jul 10 00:19:17.873238 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jul 10 00:19:17.873245 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jul 10 00:19:17.873252 kernel: NX (Execute Disable) protection: active Jul 10 00:19:17.873259 kernel: APIC: Static calls initialized Jul 10 00:19:17.873267 kernel: e820: update [mem 0x9a13e018-0x9a147c57] usable ==> usable Jul 10 00:19:17.873274 kernel: e820: update [mem 0x9a101018-0x9a13de57] usable ==> usable Jul 10 00:19:17.873281 kernel: extended physical RAM map: Jul 10 00:19:17.873288 kernel: reserve setup_data: [mem 0x0000000000000000-0x000000000002ffff] usable Jul 10 00:19:17.873295 kernel: reserve setup_data: [mem 0x0000000000030000-0x000000000004ffff] reserved Jul 10 00:19:17.873302 kernel: reserve setup_data: [mem 0x0000000000050000-0x000000000009efff] usable Jul 10 00:19:17.873312 kernel: reserve setup_data: [mem 0x000000000009f000-0x000000000009ffff] reserved Jul 10 00:19:17.873319 kernel: reserve setup_data: [mem 0x0000000000100000-0x000000009a101017] usable Jul 10 00:19:17.873326 kernel: reserve setup_data: [mem 0x000000009a101018-0x000000009a13de57] usable Jul 10 00:19:17.873333 kernel: reserve setup_data: [mem 0x000000009a13de58-0x000000009a13e017] usable Jul 10 00:19:17.873340 kernel: reserve setup_data: [mem 0x000000009a13e018-0x000000009a147c57] usable Jul 10 00:19:17.873347 kernel: reserve setup_data: [mem 0x000000009a147c58-0x000000009b8ecfff] usable Jul 10 00:19:17.873354 kernel: reserve setup_data: [mem 0x000000009b8ed000-0x000000009bb6cfff] reserved Jul 10 00:19:17.873361 kernel: reserve setup_data: [mem 0x000000009bb6d000-0x000000009bb7efff] ACPI data Jul 10 00:19:17.873368 kernel: reserve setup_data: [mem 0x000000009bb7f000-0x000000009bbfefff] ACPI NVS Jul 10 00:19:17.873375 kernel: reserve setup_data: [mem 0x000000009bbff000-0x000000009bfb0fff] usable Jul 10 00:19:17.873383 kernel: reserve setup_data: [mem 0x000000009bfb1000-0x000000009bfb4fff] reserved Jul 10 00:19:17.873392 kernel: reserve setup_data: [mem 0x000000009bfb5000-0x000000009bfb6fff] ACPI NVS Jul 10 00:19:17.873399 kernel: reserve setup_data: [mem 0x000000009bfb7000-0x000000009bffffff] usable Jul 10 00:19:17.873410 kernel: reserve setup_data: [mem 0x000000009c000000-0x000000009cffffff] reserved Jul 10 00:19:17.873418 kernel: reserve setup_data: [mem 0x00000000e0000000-0x00000000efffffff] reserved Jul 10 00:19:17.873425 kernel: reserve setup_data: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jul 10 00:19:17.873432 kernel: reserve setup_data: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Jul 10 00:19:17.873442 kernel: efi: EFI v2.7 by EDK II Jul 10 00:19:17.873449 kernel: efi: SMBIOS=0x9b9d5000 ACPI=0x9bb7e000 ACPI 2.0=0x9bb7e014 MEMATTR=0x9a1af018 RNG=0x9bb73018 Jul 10 00:19:17.873457 kernel: random: crng init done Jul 10 00:19:17.873464 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Jul 10 00:19:17.873471 kernel: secureboot: Secure boot enabled Jul 10 00:19:17.873479 kernel: SMBIOS 2.8 present. Jul 10 00:19:17.873486 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS unknown 02/02/2022 Jul 10 00:19:17.873493 kernel: DMI: Memory slots populated: 1/1 Jul 10 00:19:17.873501 kernel: Hypervisor detected: KVM Jul 10 00:19:17.873508 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jul 10 00:19:17.873515 kernel: kvm-clock: using sched offset of 6505607429 cycles Jul 10 00:19:17.873526 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jul 10 00:19:17.873534 kernel: tsc: Detected 2794.748 MHz processor Jul 10 00:19:17.873542 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jul 10 00:19:17.873551 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jul 10 00:19:17.873559 kernel: last_pfn = 0x9c000 max_arch_pfn = 0x400000000 Jul 10 00:19:17.873567 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jul 10 00:19:17.873582 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jul 10 00:19:17.873590 kernel: Using GB pages for direct mapping Jul 10 00:19:17.873602 kernel: ACPI: Early table checksum verification disabled Jul 10 00:19:17.873612 kernel: ACPI: RSDP 0x000000009BB7E014 000024 (v02 BOCHS ) Jul 10 00:19:17.873620 kernel: ACPI: XSDT 0x000000009BB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Jul 10 00:19:17.873628 kernel: ACPI: FACP 0x000000009BB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873635 kernel: ACPI: DSDT 0x000000009BB7A000 002237 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873643 kernel: ACPI: FACS 0x000000009BBDD000 000040 Jul 10 00:19:17.873650 kernel: ACPI: APIC 0x000000009BB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873658 kernel: ACPI: HPET 0x000000009BB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873666 kernel: ACPI: MCFG 0x000000009BB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873676 kernel: ACPI: WAET 0x000000009BB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 10 00:19:17.873683 kernel: ACPI: BGRT 0x000000009BB74000 000038 (v01 INTEL EDK2 00000002 01000013) Jul 10 00:19:17.873691 kernel: ACPI: Reserving FACP table memory at [mem 0x9bb79000-0x9bb790f3] Jul 10 00:19:17.873698 kernel: ACPI: Reserving DSDT table memory at [mem 0x9bb7a000-0x9bb7c236] Jul 10 00:19:17.873706 kernel: ACPI: Reserving FACS table memory at [mem 0x9bbdd000-0x9bbdd03f] Jul 10 00:19:17.873714 kernel: ACPI: Reserving APIC table memory at [mem 0x9bb78000-0x9bb7808f] Jul 10 00:19:17.873721 kernel: ACPI: Reserving HPET table memory at [mem 0x9bb77000-0x9bb77037] Jul 10 00:19:17.873729 kernel: ACPI: Reserving MCFG table memory at [mem 0x9bb76000-0x9bb7603b] Jul 10 00:19:17.873736 kernel: ACPI: Reserving WAET table memory at [mem 0x9bb75000-0x9bb75027] Jul 10 00:19:17.873744 kernel: ACPI: Reserving BGRT table memory at [mem 0x9bb74000-0x9bb74037] Jul 10 00:19:17.873754 kernel: No NUMA configuration found Jul 10 00:19:17.873761 kernel: Faking a node at [mem 0x0000000000000000-0x000000009bffffff] Jul 10 00:19:17.873769 kernel: NODE_DATA(0) allocated [mem 0x9bf57dc0-0x9bf5efff] Jul 10 00:19:17.873777 kernel: Zone ranges: Jul 10 00:19:17.873784 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jul 10 00:19:17.873792 kernel: DMA32 [mem 0x0000000001000000-0x000000009bffffff] Jul 10 00:19:17.873800 kernel: Normal empty Jul 10 00:19:17.873807 kernel: Device empty Jul 10 00:19:17.873815 kernel: Movable zone start for each node Jul 10 00:19:17.873825 kernel: Early memory node ranges Jul 10 00:19:17.873833 kernel: node 0: [mem 0x0000000000001000-0x000000000002ffff] Jul 10 00:19:17.873840 kernel: node 0: [mem 0x0000000000050000-0x000000000009efff] Jul 10 00:19:17.873848 kernel: node 0: [mem 0x0000000000100000-0x000000009b8ecfff] Jul 10 00:19:17.873855 kernel: node 0: [mem 0x000000009bbff000-0x000000009bfb0fff] Jul 10 00:19:17.873863 kernel: node 0: [mem 0x000000009bfb7000-0x000000009bffffff] Jul 10 00:19:17.873870 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009bffffff] Jul 10 00:19:17.873878 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jul 10 00:19:17.873886 kernel: On node 0, zone DMA: 32 pages in unavailable ranges Jul 10 00:19:17.873895 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jul 10 00:19:17.873903 kernel: On node 0, zone DMA32: 786 pages in unavailable ranges Jul 10 00:19:17.873911 kernel: On node 0, zone DMA32: 6 pages in unavailable ranges Jul 10 00:19:17.873918 kernel: On node 0, zone DMA32: 16384 pages in unavailable ranges Jul 10 00:19:17.873926 kernel: ACPI: PM-Timer IO Port: 0x608 Jul 10 00:19:17.873934 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jul 10 00:19:17.873941 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jul 10 00:19:17.873949 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jul 10 00:19:17.873956 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jul 10 00:19:17.873969 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jul 10 00:19:17.873977 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jul 10 00:19:17.874001 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jul 10 00:19:17.874010 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jul 10 00:19:17.874017 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jul 10 00:19:17.874025 kernel: TSC deadline timer available Jul 10 00:19:17.874033 kernel: CPU topo: Max. logical packages: 1 Jul 10 00:19:17.874051 kernel: CPU topo: Max. logical dies: 1 Jul 10 00:19:17.874059 kernel: CPU topo: Max. dies per package: 1 Jul 10 00:19:17.874076 kernel: CPU topo: Max. threads per core: 1 Jul 10 00:19:17.874084 kernel: CPU topo: Num. cores per package: 4 Jul 10 00:19:17.874092 kernel: CPU topo: Num. threads per package: 4 Jul 10 00:19:17.874102 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Jul 10 00:19:17.874113 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jul 10 00:19:17.874121 kernel: kvm-guest: KVM setup pv remote TLB flush Jul 10 00:19:17.874129 kernel: kvm-guest: setup PV sched yield Jul 10 00:19:17.874137 kernel: [mem 0x9d000000-0xdfffffff] available for PCI devices Jul 10 00:19:17.874147 kernel: Booting paravirtualized kernel on KVM Jul 10 00:19:17.874156 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jul 10 00:19:17.874164 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Jul 10 00:19:17.874172 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Jul 10 00:19:17.874180 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Jul 10 00:19:17.874187 kernel: pcpu-alloc: [0] 0 1 2 3 Jul 10 00:19:17.874195 kernel: kvm-guest: PV spinlocks enabled Jul 10 00:19:17.874203 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jul 10 00:19:17.874213 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=844005237fb9709f65a093d5533c4229fb6c54e8e257736d9c3d041b6d3080ea Jul 10 00:19:17.874223 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 10 00:19:17.874231 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 10 00:19:17.874239 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 10 00:19:17.874247 kernel: Fallback order for Node 0: 0 Jul 10 00:19:17.874255 kernel: Built 1 zonelists, mobility grouping on. Total pages: 638054 Jul 10 00:19:17.874263 kernel: Policy zone: DMA32 Jul 10 00:19:17.874271 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 10 00:19:17.874279 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 10 00:19:17.874289 kernel: ftrace: allocating 40095 entries in 157 pages Jul 10 00:19:17.874297 kernel: ftrace: allocated 157 pages with 5 groups Jul 10 00:19:17.874305 kernel: Dynamic Preempt: voluntary Jul 10 00:19:17.874313 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 10 00:19:17.874322 kernel: rcu: RCU event tracing is enabled. Jul 10 00:19:17.874330 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 10 00:19:17.874338 kernel: Trampoline variant of Tasks RCU enabled. Jul 10 00:19:17.874346 kernel: Rude variant of Tasks RCU enabled. Jul 10 00:19:17.874354 kernel: Tracing variant of Tasks RCU enabled. Jul 10 00:19:17.874364 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 10 00:19:17.874372 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 10 00:19:17.874380 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 00:19:17.874388 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 00:19:17.874400 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 10 00:19:17.874408 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Jul 10 00:19:17.874416 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 10 00:19:17.874424 kernel: Console: colour dummy device 80x25 Jul 10 00:19:17.874431 kernel: printk: legacy console [ttyS0] enabled Jul 10 00:19:17.874442 kernel: ACPI: Core revision 20240827 Jul 10 00:19:17.874450 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Jul 10 00:19:17.874458 kernel: APIC: Switch to symmetric I/O mode setup Jul 10 00:19:17.874467 kernel: x2apic enabled Jul 10 00:19:17.874476 kernel: APIC: Switched APIC routing to: physical x2apic Jul 10 00:19:17.874484 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Jul 10 00:19:17.874493 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Jul 10 00:19:17.874500 kernel: kvm-guest: setup PV IPIs Jul 10 00:19:17.874508 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jul 10 00:19:17.874519 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Jul 10 00:19:17.874527 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Jul 10 00:19:17.874535 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jul 10 00:19:17.874543 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Jul 10 00:19:17.874550 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Jul 10 00:19:17.874561 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jul 10 00:19:17.874569 kernel: Spectre V2 : Mitigation: Retpolines Jul 10 00:19:17.874577 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jul 10 00:19:17.874585 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Jul 10 00:19:17.874595 kernel: RETBleed: Mitigation: untrained return thunk Jul 10 00:19:17.874603 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jul 10 00:19:17.874611 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jul 10 00:19:17.874619 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Jul 10 00:19:17.874627 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Jul 10 00:19:17.874635 kernel: x86/bugs: return thunk changed Jul 10 00:19:17.874643 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Jul 10 00:19:17.874651 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jul 10 00:19:17.874662 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jul 10 00:19:17.874670 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jul 10 00:19:17.874677 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jul 10 00:19:17.874686 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Jul 10 00:19:17.874693 kernel: Freeing SMP alternatives memory: 32K Jul 10 00:19:17.874701 kernel: pid_max: default: 32768 minimum: 301 Jul 10 00:19:17.874709 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 10 00:19:17.874717 kernel: landlock: Up and running. Jul 10 00:19:17.874724 kernel: SELinux: Initializing. Jul 10 00:19:17.874735 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 00:19:17.874743 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 10 00:19:17.874751 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Jul 10 00:19:17.874759 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Jul 10 00:19:17.874767 kernel: ... version: 0 Jul 10 00:19:17.874774 kernel: ... bit width: 48 Jul 10 00:19:17.874784 kernel: ... generic registers: 6 Jul 10 00:19:17.874792 kernel: ... value mask: 0000ffffffffffff Jul 10 00:19:17.874800 kernel: ... max period: 00007fffffffffff Jul 10 00:19:17.874810 kernel: ... fixed-purpose events: 0 Jul 10 00:19:17.874818 kernel: ... event mask: 000000000000003f Jul 10 00:19:17.874826 kernel: signal: max sigframe size: 1776 Jul 10 00:19:17.874834 kernel: rcu: Hierarchical SRCU implementation. Jul 10 00:19:17.874842 kernel: rcu: Max phase no-delay instances is 400. Jul 10 00:19:17.874850 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 10 00:19:17.874858 kernel: smp: Bringing up secondary CPUs ... Jul 10 00:19:17.874866 kernel: smpboot: x86: Booting SMP configuration: Jul 10 00:19:17.874873 kernel: .... node #0, CPUs: #1 #2 #3 Jul 10 00:19:17.874881 kernel: smp: Brought up 1 node, 4 CPUs Jul 10 00:19:17.874892 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Jul 10 00:19:17.874900 kernel: Memory: 2409216K/2552216K available (14336K kernel code, 2430K rwdata, 9956K rodata, 54420K init, 2548K bss, 137064K reserved, 0K cma-reserved) Jul 10 00:19:17.874908 kernel: devtmpfs: initialized Jul 10 00:19:17.874916 kernel: x86/mm: Memory block size: 128MB Jul 10 00:19:17.874924 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bb7f000-0x9bbfefff] (524288 bytes) Jul 10 00:19:17.874932 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9bfb5000-0x9bfb6fff] (8192 bytes) Jul 10 00:19:17.874940 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 10 00:19:17.874948 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 10 00:19:17.874958 kernel: pinctrl core: initialized pinctrl subsystem Jul 10 00:19:17.874966 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 10 00:19:17.874974 kernel: audit: initializing netlink subsys (disabled) Jul 10 00:19:17.874982 kernel: audit: type=2000 audit(1752106755.584:1): state=initialized audit_enabled=0 res=1 Jul 10 00:19:17.875003 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 10 00:19:17.875011 kernel: thermal_sys: Registered thermal governor 'user_space' Jul 10 00:19:17.875019 kernel: cpuidle: using governor menu Jul 10 00:19:17.875027 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 10 00:19:17.875035 kernel: dca service started, version 1.12.1 Jul 10 00:19:17.875055 kernel: PCI: ECAM [mem 0xe0000000-0xefffffff] (base 0xe0000000) for domain 0000 [bus 00-ff] Jul 10 00:19:17.875063 kernel: PCI: Using configuration type 1 for base access Jul 10 00:19:17.875071 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jul 10 00:19:17.875079 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 10 00:19:17.875087 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jul 10 00:19:17.875095 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 10 00:19:17.875103 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jul 10 00:19:17.875110 kernel: ACPI: Added _OSI(Module Device) Jul 10 00:19:17.875118 kernel: ACPI: Added _OSI(Processor Device) Jul 10 00:19:17.875128 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 10 00:19:17.875136 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 10 00:19:17.875144 kernel: ACPI: Interpreter enabled Jul 10 00:19:17.875152 kernel: ACPI: PM: (supports S0 S5) Jul 10 00:19:17.875160 kernel: ACPI: Using IOAPIC for interrupt routing Jul 10 00:19:17.875168 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jul 10 00:19:17.875175 kernel: PCI: Using E820 reservations for host bridge windows Jul 10 00:19:17.875183 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jul 10 00:19:17.875191 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 10 00:19:17.875421 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 10 00:19:17.875572 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Jul 10 00:19:17.875730 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Jul 10 00:19:17.875744 kernel: PCI host bridge to bus 0000:00 Jul 10 00:19:17.875917 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jul 10 00:19:17.876068 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jul 10 00:19:17.876202 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jul 10 00:19:17.876318 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xdfffffff window] Jul 10 00:19:17.876447 kernel: pci_bus 0000:00: root bus resource [mem 0xf0000000-0xfebfffff window] Jul 10 00:19:17.876574 kernel: pci_bus 0000:00: root bus resource [mem 0x380000000000-0x3807ffffffff window] Jul 10 00:19:17.876685 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 10 00:19:17.876849 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Jul 10 00:19:17.877141 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Jul 10 00:19:17.877278 kernel: pci 0000:00:01.0: BAR 0 [mem 0xc0000000-0xc0ffffff pref] Jul 10 00:19:17.877410 kernel: pci 0000:00:01.0: BAR 2 [mem 0xc1044000-0xc1044fff] Jul 10 00:19:17.877534 kernel: pci 0000:00:01.0: ROM [mem 0xffff0000-0xffffffff pref] Jul 10 00:19:17.877656 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jul 10 00:19:17.877800 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 10 00:19:17.877924 kernel: pci 0000:00:02.0: BAR 0 [io 0x6100-0x611f] Jul 10 00:19:17.878074 kernel: pci 0000:00:02.0: BAR 1 [mem 0xc1043000-0xc1043fff] Jul 10 00:19:17.878244 kernel: pci 0000:00:02.0: BAR 4 [mem 0x380000000000-0x380000003fff 64bit pref] Jul 10 00:19:17.878419 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Jul 10 00:19:17.878672 kernel: pci 0000:00:03.0: BAR 0 [io 0x6000-0x607f] Jul 10 00:19:17.878816 kernel: pci 0000:00:03.0: BAR 1 [mem 0xc1042000-0xc1042fff] Jul 10 00:19:17.878940 kernel: pci 0000:00:03.0: BAR 4 [mem 0x380000004000-0x380000007fff 64bit pref] Jul 10 00:19:17.879115 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Jul 10 00:19:17.879248 kernel: pci 0000:00:04.0: BAR 0 [io 0x60e0-0x60ff] Jul 10 00:19:17.879372 kernel: pci 0000:00:04.0: BAR 1 [mem 0xc1041000-0xc1041fff] Jul 10 00:19:17.879494 kernel: pci 0000:00:04.0: BAR 4 [mem 0x380000008000-0x38000000bfff 64bit pref] Jul 10 00:19:17.879617 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref] Jul 10 00:19:17.879770 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Jul 10 00:19:17.879896 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jul 10 00:19:17.880105 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Jul 10 00:19:17.880284 kernel: pci 0000:00:1f.2: BAR 4 [io 0x60c0-0x60df] Jul 10 00:19:17.880407 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xc1040000-0xc1040fff] Jul 10 00:19:17.880578 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Jul 10 00:19:17.880704 kernel: pci 0000:00:1f.3: BAR 4 [io 0x6080-0x60bf] Jul 10 00:19:17.880715 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jul 10 00:19:17.880724 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jul 10 00:19:17.880733 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jul 10 00:19:17.880744 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jul 10 00:19:17.880759 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jul 10 00:19:17.880769 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jul 10 00:19:17.880779 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jul 10 00:19:17.880789 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jul 10 00:19:17.880799 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jul 10 00:19:17.880809 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jul 10 00:19:17.880818 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jul 10 00:19:17.880828 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jul 10 00:19:17.880836 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jul 10 00:19:17.880847 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jul 10 00:19:17.880855 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jul 10 00:19:17.880863 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jul 10 00:19:17.880871 kernel: iommu: Default domain type: Translated Jul 10 00:19:17.880879 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jul 10 00:19:17.880887 kernel: efivars: Registered efivars operations Jul 10 00:19:17.880895 kernel: PCI: Using ACPI for IRQ routing Jul 10 00:19:17.880903 kernel: PCI: pci_cache_line_size set to 64 bytes Jul 10 00:19:17.880913 kernel: e820: reserve RAM buffer [mem 0x0009f000-0x0009ffff] Jul 10 00:19:17.880926 kernel: e820: reserve RAM buffer [mem 0x9a101018-0x9bffffff] Jul 10 00:19:17.880936 kernel: e820: reserve RAM buffer [mem 0x9a13e018-0x9bffffff] Jul 10 00:19:17.880946 kernel: e820: reserve RAM buffer [mem 0x9b8ed000-0x9bffffff] Jul 10 00:19:17.880955 kernel: e820: reserve RAM buffer [mem 0x9bfb1000-0x9bffffff] Jul 10 00:19:17.881151 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jul 10 00:19:17.881280 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jul 10 00:19:17.881402 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jul 10 00:19:17.881413 kernel: vgaarb: loaded Jul 10 00:19:17.881426 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Jul 10 00:19:17.881434 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Jul 10 00:19:17.881442 kernel: clocksource: Switched to clocksource kvm-clock Jul 10 00:19:17.881450 kernel: VFS: Disk quotas dquot_6.6.0 Jul 10 00:19:17.881458 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 10 00:19:17.881466 kernel: pnp: PnP ACPI init Jul 10 00:19:17.881626 kernel: system 00:05: [mem 0xe0000000-0xefffffff window] has been reserved Jul 10 00:19:17.881640 kernel: pnp: PnP ACPI: found 6 devices Jul 10 00:19:17.881648 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jul 10 00:19:17.881660 kernel: NET: Registered PF_INET protocol family Jul 10 00:19:17.881668 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 10 00:19:17.881676 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 10 00:19:17.881684 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 10 00:19:17.881692 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 10 00:19:17.881700 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 10 00:19:17.881708 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 10 00:19:17.881716 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 00:19:17.881727 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 10 00:19:17.881735 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 10 00:19:17.881743 kernel: NET: Registered PF_XDP protocol family Jul 10 00:19:17.881867 kernel: pci 0000:00:04.0: ROM [mem 0xfffc0000-0xffffffff pref]: can't claim; no compatible bridge window Jul 10 00:19:17.882010 kernel: pci 0000:00:04.0: ROM [mem 0x9d000000-0x9d03ffff pref]: assigned Jul 10 00:19:17.882163 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jul 10 00:19:17.882277 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jul 10 00:19:17.882389 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jul 10 00:19:17.882506 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xdfffffff window] Jul 10 00:19:17.882617 kernel: pci_bus 0000:00: resource 8 [mem 0xf0000000-0xfebfffff window] Jul 10 00:19:17.882728 kernel: pci_bus 0000:00: resource 9 [mem 0x380000000000-0x3807ffffffff window] Jul 10 00:19:17.882739 kernel: PCI: CLS 0 bytes, default 64 Jul 10 00:19:17.882748 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848df6a9de, max_idle_ns: 440795280912 ns Jul 10 00:19:17.882756 kernel: Initialise system trusted keyrings Jul 10 00:19:17.882765 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 10 00:19:17.882773 kernel: Key type asymmetric registered Jul 10 00:19:17.882781 kernel: Asymmetric key parser 'x509' registered Jul 10 00:19:17.882792 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Jul 10 00:19:17.882816 kernel: io scheduler mq-deadline registered Jul 10 00:19:17.882826 kernel: io scheduler kyber registered Jul 10 00:19:17.882835 kernel: io scheduler bfq registered Jul 10 00:19:17.882843 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jul 10 00:19:17.882852 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jul 10 00:19:17.882860 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jul 10 00:19:17.882869 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jul 10 00:19:17.882877 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 10 00:19:17.882888 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jul 10 00:19:17.882896 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jul 10 00:19:17.882905 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jul 10 00:19:17.882913 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jul 10 00:19:17.883081 kernel: rtc_cmos 00:04: RTC can wake from S4 Jul 10 00:19:17.883095 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jul 10 00:19:17.883228 kernel: rtc_cmos 00:04: registered as rtc0 Jul 10 00:19:17.883348 kernel: rtc_cmos 00:04: setting system clock to 2025-07-10T00:19:17 UTC (1752106757) Jul 10 00:19:17.883469 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram Jul 10 00:19:17.883480 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Jul 10 00:19:17.883489 kernel: efifb: probing for efifb Jul 10 00:19:17.883498 kernel: efifb: framebuffer at 0xc0000000, using 4000k, total 4000k Jul 10 00:19:17.883506 kernel: efifb: mode is 1280x800x32, linelength=5120, pages=1 Jul 10 00:19:17.883515 kernel: efifb: scrolling: redraw Jul 10 00:19:17.883523 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jul 10 00:19:17.883531 kernel: Console: switching to colour frame buffer device 160x50 Jul 10 00:19:17.883540 kernel: fb0: EFI VGA frame buffer device Jul 10 00:19:17.883553 kernel: pstore: Using crash dump compression: deflate Jul 10 00:19:17.883562 kernel: pstore: Registered efi_pstore as persistent store backend Jul 10 00:19:17.883572 kernel: NET: Registered PF_INET6 protocol family Jul 10 00:19:17.883580 kernel: Segment Routing with IPv6 Jul 10 00:19:17.883588 kernel: In-situ OAM (IOAM) with IPv6 Jul 10 00:19:17.883599 kernel: NET: Registered PF_PACKET protocol family Jul 10 00:19:17.883607 kernel: Key type dns_resolver registered Jul 10 00:19:17.883616 kernel: IPI shorthand broadcast: enabled Jul 10 00:19:17.883624 kernel: sched_clock: Marking stable (3589002381, 159548622)->(3804971330, -56420327) Jul 10 00:19:17.883633 kernel: registered taskstats version 1 Jul 10 00:19:17.883641 kernel: Loading compiled-in X.509 certificates Jul 10 00:19:17.883649 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: f515550de55d4e43b2ea11ae212aa0cb3a4e55cf' Jul 10 00:19:17.883657 kernel: Demotion targets for Node 0: null Jul 10 00:19:17.883666 kernel: Key type .fscrypt registered Jul 10 00:19:17.883676 kernel: Key type fscrypt-provisioning registered Jul 10 00:19:17.883685 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 10 00:19:17.883693 kernel: ima: Allocated hash algorithm: sha1 Jul 10 00:19:17.883701 kernel: ima: No architecture policies found Jul 10 00:19:17.883709 kernel: clk: Disabling unused clocks Jul 10 00:19:17.883718 kernel: Warning: unable to open an initial console. Jul 10 00:19:17.883727 kernel: Freeing unused kernel image (initmem) memory: 54420K Jul 10 00:19:17.883735 kernel: Write protecting the kernel read-only data: 24576k Jul 10 00:19:17.883744 kernel: Freeing unused kernel image (rodata/data gap) memory: 284K Jul 10 00:19:17.883754 kernel: Run /init as init process Jul 10 00:19:17.883762 kernel: with arguments: Jul 10 00:19:17.883771 kernel: /init Jul 10 00:19:17.883779 kernel: with environment: Jul 10 00:19:17.883787 kernel: HOME=/ Jul 10 00:19:17.883796 kernel: TERM=linux Jul 10 00:19:17.883804 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 10 00:19:17.883813 systemd[1]: Successfully made /usr/ read-only. Jul 10 00:19:17.883828 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) Jul 10 00:19:17.883838 systemd[1]: Detected virtualization kvm. Jul 10 00:19:17.883847 systemd[1]: Detected architecture x86-64. Jul 10 00:19:17.883856 systemd[1]: Running in initrd. Jul 10 00:19:17.883864 systemd[1]: No hostname configured, using default hostname. Jul 10 00:19:17.883874 systemd[1]: Hostname set to . Jul 10 00:19:17.883883 systemd[1]: Initializing machine ID from VM UUID. Jul 10 00:19:17.883892 systemd[1]: Queued start job for default target initrd.target. Jul 10 00:19:17.883904 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:17.883913 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:17.883923 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 10 00:19:17.883932 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 00:19:17.883941 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 10 00:19:17.883951 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 10 00:19:17.883964 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 10 00:19:17.883973 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 10 00:19:17.883982 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:17.884006 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:17.884015 systemd[1]: Reached target paths.target - Path Units. Jul 10 00:19:17.884024 systemd[1]: Reached target slices.target - Slice Units. Jul 10 00:19:17.884034 systemd[1]: Reached target swap.target - Swaps. Jul 10 00:19:17.884052 systemd[1]: Reached target timers.target - Timer Units. Jul 10 00:19:17.884061 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 00:19:17.884073 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 00:19:17.884082 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 10 00:19:17.884092 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 10 00:19:17.884101 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:17.884110 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:17.884122 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:17.884131 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 00:19:17.884140 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 10 00:19:17.884151 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 00:19:17.884160 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 10 00:19:17.884170 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). Jul 10 00:19:17.884179 systemd[1]: Starting systemd-fsck-usr.service... Jul 10 00:19:17.884188 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 00:19:17.884198 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 00:19:17.884206 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:17.884216 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 10 00:19:17.884227 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:17.884237 systemd[1]: Finished systemd-fsck-usr.service. Jul 10 00:19:17.884246 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 00:19:17.884293 systemd-journald[220]: Collecting audit messages is disabled. Jul 10 00:19:17.884320 systemd-journald[220]: Journal started Jul 10 00:19:17.884341 systemd-journald[220]: Runtime Journal (/run/log/journal/be628eeda4de44ad8f54af6bde26e9dd) is 6M, max 48.2M, 42.2M free. Jul 10 00:19:17.878809 systemd-modules-load[222]: Inserted module 'overlay' Jul 10 00:19:17.887094 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 00:19:17.887925 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:17.888535 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:17.896345 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 10 00:19:17.900396 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 00:19:17.905176 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 00:19:17.914031 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 10 00:19:17.915953 systemd-modules-load[222]: Inserted module 'br_netfilter' Jul 10 00:19:17.917265 kernel: Bridge firewalling registered Jul 10 00:19:17.919926 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:17.921873 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 00:19:17.933206 systemd-tmpfiles[240]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 10 00:19:17.934447 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:17.938032 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:17.939649 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:17.943442 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 10 00:19:17.944137 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:17.946459 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 00:19:17.982294 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=844005237fb9709f65a093d5533c4229fb6c54e8e257736d9c3d041b6d3080ea Jul 10 00:19:18.003225 systemd-resolved[262]: Positive Trust Anchors: Jul 10 00:19:18.003247 systemd-resolved[262]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 00:19:18.003280 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 Jul 10 00:19:18.005809 systemd-resolved[262]: Defaulting to hostname 'linux'. Jul 10 00:19:18.007163 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 00:19:18.012813 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:18.099041 kernel: SCSI subsystem initialized Jul 10 00:19:18.108038 kernel: Loading iSCSI transport class v2.0-870. Jul 10 00:19:18.121024 kernel: iscsi: registered transport (tcp) Jul 10 00:19:18.147448 kernel: iscsi: registered transport (qla4xxx) Jul 10 00:19:18.147545 kernel: QLogic iSCSI HBA Driver Jul 10 00:19:18.172102 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 10 00:19:18.195362 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 00:19:18.196049 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 10 00:19:18.274173 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 10 00:19:18.277983 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 10 00:19:18.342036 kernel: raid6: avx2x4 gen() 27916 MB/s Jul 10 00:19:18.359039 kernel: raid6: avx2x2 gen() 28918 MB/s Jul 10 00:19:18.376277 kernel: raid6: avx2x1 gen() 22139 MB/s Jul 10 00:19:18.376380 kernel: raid6: using algorithm avx2x2 gen() 28918 MB/s Jul 10 00:19:18.394163 kernel: raid6: .... xor() 18510 MB/s, rmw enabled Jul 10 00:19:18.394212 kernel: raid6: using avx2x2 recovery algorithm Jul 10 00:19:18.419073 kernel: xor: automatically using best checksumming function avx Jul 10 00:19:18.608064 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 10 00:19:18.618390 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 10 00:19:18.620777 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:18.665182 systemd-udevd[473]: Using default interface naming scheme 'v255'. Jul 10 00:19:18.671624 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:18.673132 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 10 00:19:18.702029 dracut-pre-trigger[478]: rd.md=0: removing MD RAID activation Jul 10 00:19:18.736424 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 00:19:18.738492 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 00:19:18.823544 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:18.826053 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 10 00:19:18.865102 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Jul 10 00:19:18.873823 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Jul 10 00:19:18.882923 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 10 00:19:18.883001 kernel: GPT:9289727 != 19775487 Jul 10 00:19:18.883028 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 10 00:19:18.883042 kernel: GPT:9289727 != 19775487 Jul 10 00:19:18.883054 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 10 00:19:18.883072 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:18.889858 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Jul 10 00:19:18.895022 kernel: cryptd: max_cpu_qlen set to 1000 Jul 10 00:19:18.905576 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 00:19:18.906571 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:18.912301 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:18.916462 kernel: libata version 3.00 loaded. Jul 10 00:19:18.917338 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:18.921129 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 10 00:19:18.927030 kernel: AES CTR mode by8 optimization enabled Jul 10 00:19:18.932026 kernel: ahci 0000:00:1f.2: version 3.0 Jul 10 00:19:18.934038 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jul 10 00:19:18.955061 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Jul 10 00:19:18.955348 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Jul 10 00:19:18.955557 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jul 10 00:19:18.961706 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:18.966039 kernel: scsi host0: ahci Jul 10 00:19:18.966276 kernel: scsi host1: ahci Jul 10 00:19:18.968044 kernel: scsi host2: ahci Jul 10 00:19:18.970266 kernel: scsi host3: ahci Jul 10 00:19:18.970509 kernel: scsi host4: ahci Jul 10 00:19:18.971252 kernel: scsi host5: ahci Jul 10 00:19:18.973645 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 lpm-pol 0 Jul 10 00:19:18.973670 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 lpm-pol 0 Jul 10 00:19:18.973682 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 lpm-pol 0 Jul 10 00:19:18.975511 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 10 00:19:18.981702 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 lpm-pol 0 Jul 10 00:19:18.981732 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 lpm-pol 0 Jul 10 00:19:18.981748 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 lpm-pol 0 Jul 10 00:19:18.981670 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 10 00:19:18.999036 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 10 00:19:19.009756 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 10 00:19:19.026775 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 00:19:19.029465 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 10 00:19:19.062798 disk-uuid[633]: Primary Header is updated. Jul 10 00:19:19.062798 disk-uuid[633]: Secondary Entries is updated. Jul 10 00:19:19.062798 disk-uuid[633]: Secondary Header is updated. Jul 10 00:19:19.066559 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:19.072045 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:19.289456 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jul 10 00:19:19.289545 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jul 10 00:19:19.289573 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jul 10 00:19:19.291039 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jul 10 00:19:19.291142 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jul 10 00:19:19.292024 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Jul 10 00:19:19.293209 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Jul 10 00:19:19.293229 kernel: ata3.00: applying bridge limits Jul 10 00:19:19.294301 kernel: ata3.00: configured for UDMA/100 Jul 10 00:19:19.295038 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Jul 10 00:19:19.352051 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Jul 10 00:19:19.352437 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Jul 10 00:19:19.380064 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Jul 10 00:19:19.784393 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 10 00:19:19.785369 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 00:19:19.787032 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:19.787503 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 00:19:19.788797 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 10 00:19:19.819794 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 10 00:19:20.072066 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 10 00:19:20.072561 disk-uuid[634]: The operation has completed successfully. Jul 10 00:19:20.107916 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 10 00:19:20.108093 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 10 00:19:20.160426 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 10 00:19:20.175227 sh[662]: Success Jul 10 00:19:20.197154 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 10 00:19:20.197194 kernel: device-mapper: uevent: version 1.0.3 Jul 10 00:19:20.198450 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 10 00:19:20.209015 kernel: device-mapper: verity: sha256 using shash "sha256-ni" Jul 10 00:19:20.248020 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 10 00:19:20.252720 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 10 00:19:20.273696 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 10 00:19:20.280897 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 10 00:19:20.280935 kernel: BTRFS: device fsid c4cb30b0-bb74-4f98-aab6-7a1c6f47edee devid 1 transid 36 /dev/mapper/usr (253:0) scanned by mount (674) Jul 10 00:19:20.283262 kernel: BTRFS info (device dm-0): first mount of filesystem c4cb30b0-bb74-4f98-aab6-7a1c6f47edee Jul 10 00:19:20.283291 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jul 10 00:19:20.283307 kernel: BTRFS info (device dm-0): using free-space-tree Jul 10 00:19:20.289254 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 10 00:19:20.290109 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 10 00:19:20.291478 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 10 00:19:20.292542 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 10 00:19:20.294715 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 10 00:19:20.331046 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (707) Jul 10 00:19:20.331101 kernel: BTRFS info (device vda6): first mount of filesystem 66535909-6865-4f30-ad42-a3000fffd5f6 Jul 10 00:19:20.333455 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 10 00:19:20.333480 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 00:19:20.341015 kernel: BTRFS info (device vda6): last unmount of filesystem 66535909-6865-4f30-ad42-a3000fffd5f6 Jul 10 00:19:20.341480 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 10 00:19:20.344971 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 10 00:19:20.497476 ignition[750]: Ignition 2.21.0 Jul 10 00:19:20.497495 ignition[750]: Stage: fetch-offline Jul 10 00:19:20.497536 ignition[750]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:20.497546 ignition[750]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:20.497647 ignition[750]: parsed url from cmdline: "" Jul 10 00:19:20.497650 ignition[750]: no config URL provided Jul 10 00:19:20.497656 ignition[750]: reading system config file "/usr/lib/ignition/user.ign" Jul 10 00:19:20.497665 ignition[750]: no config at "/usr/lib/ignition/user.ign" Jul 10 00:19:20.497710 ignition[750]: op(1): [started] loading QEMU firmware config module Jul 10 00:19:20.497716 ignition[750]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 10 00:19:20.508482 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 00:19:20.513099 ignition[750]: op(1): [finished] loading QEMU firmware config module Jul 10 00:19:20.514579 ignition[750]: parsing config with SHA512: f98996ecc97840f44d822b509fd00f01ad904752adddb85ad33546aa1ed58e82e5173ed7fc559df9d12fc538692e32c592c4ba3c962463450ff0e38a27034539 Jul 10 00:19:20.515927 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 00:19:20.521308 unknown[750]: fetched base config from "system" Jul 10 00:19:20.521323 unknown[750]: fetched user config from "qemu" Jul 10 00:19:20.521563 ignition[750]: fetch-offline: fetch-offline passed Jul 10 00:19:20.521619 ignition[750]: Ignition finished successfully Jul 10 00:19:20.537226 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 00:19:20.576544 systemd-networkd[852]: lo: Link UP Jul 10 00:19:20.576557 systemd-networkd[852]: lo: Gained carrier Jul 10 00:19:20.578504 systemd-networkd[852]: Enumeration completed Jul 10 00:19:20.579060 systemd-networkd[852]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:20.579065 systemd-networkd[852]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 00:19:20.580177 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 00:19:20.580216 systemd-networkd[852]: eth0: Link UP Jul 10 00:19:20.580220 systemd-networkd[852]: eth0: Gained carrier Jul 10 00:19:20.580229 systemd-networkd[852]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:20.589207 systemd[1]: Reached target network.target - Network. Jul 10 00:19:20.591135 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 10 00:19:20.594561 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 10 00:19:20.603060 systemd-networkd[852]: eth0: DHCPv4 address 10.0.0.73/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 00:19:20.640495 ignition[856]: Ignition 2.21.0 Jul 10 00:19:20.640513 ignition[856]: Stage: kargs Jul 10 00:19:20.640648 ignition[856]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:20.640658 ignition[856]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:20.645650 ignition[856]: kargs: kargs passed Jul 10 00:19:20.645728 ignition[856]: Ignition finished successfully Jul 10 00:19:20.651723 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 10 00:19:20.655229 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 10 00:19:20.698927 ignition[865]: Ignition 2.21.0 Jul 10 00:19:20.698941 ignition[865]: Stage: disks Jul 10 00:19:20.699193 ignition[865]: no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:20.699209 ignition[865]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:20.701526 ignition[865]: disks: disks passed Jul 10 00:19:20.702303 ignition[865]: Ignition finished successfully Jul 10 00:19:20.705316 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 10 00:19:20.707067 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 10 00:19:20.709343 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 10 00:19:20.710754 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 00:19:20.713061 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 00:19:20.714257 systemd[1]: Reached target basic.target - Basic System. Jul 10 00:19:20.717664 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 10 00:19:20.769413 systemd-resolved[262]: Detected conflict on linux IN A 10.0.0.73 Jul 10 00:19:20.769437 systemd-resolved[262]: Hostname conflict, changing published hostname from 'linux' to 'linux8'. Jul 10 00:19:20.773654 systemd-fsck[875]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 10 00:19:20.782508 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 10 00:19:20.787486 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 10 00:19:20.942036 kernel: EXT4-fs (vda9): mounted filesystem a310c019-7915-47f5-9fce-db4a09ac26c2 r/w with ordered data mode. Quota mode: none. Jul 10 00:19:20.942852 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 10 00:19:20.944047 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 10 00:19:20.946383 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 00:19:20.948457 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 10 00:19:20.950537 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 10 00:19:20.950580 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 10 00:19:20.950604 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 00:19:20.967003 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 10 00:19:20.969161 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 10 00:19:20.977846 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (883) Jul 10 00:19:20.977900 kernel: BTRFS info (device vda6): first mount of filesystem 66535909-6865-4f30-ad42-a3000fffd5f6 Jul 10 00:19:20.977916 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 10 00:19:20.979586 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 00:19:20.984387 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 00:19:21.021888 initrd-setup-root[907]: cut: /sysroot/etc/passwd: No such file or directory Jul 10 00:19:21.028780 initrd-setup-root[914]: cut: /sysroot/etc/group: No such file or directory Jul 10 00:19:21.033743 initrd-setup-root[921]: cut: /sysroot/etc/shadow: No such file or directory Jul 10 00:19:21.038184 initrd-setup-root[928]: cut: /sysroot/etc/gshadow: No such file or directory Jul 10 00:19:21.164158 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 10 00:19:21.166484 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 10 00:19:21.168215 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 10 00:19:21.204021 kernel: BTRFS info (device vda6): last unmount of filesystem 66535909-6865-4f30-ad42-a3000fffd5f6 Jul 10 00:19:21.223375 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 10 00:19:21.266658 ignition[997]: INFO : Ignition 2.21.0 Jul 10 00:19:21.266658 ignition[997]: INFO : Stage: mount Jul 10 00:19:21.268926 ignition[997]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:21.268926 ignition[997]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:21.268926 ignition[997]: INFO : mount: mount passed Jul 10 00:19:21.268926 ignition[997]: INFO : Ignition finished successfully Jul 10 00:19:21.276800 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 10 00:19:21.278687 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 10 00:19:21.281540 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 10 00:19:21.306273 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 10 00:19:21.339906 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1009) Jul 10 00:19:21.339980 kernel: BTRFS info (device vda6): first mount of filesystem 66535909-6865-4f30-ad42-a3000fffd5f6 Jul 10 00:19:21.340016 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jul 10 00:19:21.340756 kernel: BTRFS info (device vda6): using free-space-tree Jul 10 00:19:21.345392 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 10 00:19:21.386282 ignition[1026]: INFO : Ignition 2.21.0 Jul 10 00:19:21.386282 ignition[1026]: INFO : Stage: files Jul 10 00:19:21.388441 ignition[1026]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:21.388441 ignition[1026]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:21.392761 ignition[1026]: DEBUG : files: compiled without relabeling support, skipping Jul 10 00:19:21.394633 ignition[1026]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 10 00:19:21.394633 ignition[1026]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 10 00:19:21.398525 ignition[1026]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 10 00:19:21.400274 ignition[1026]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 10 00:19:21.400274 ignition[1026]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 10 00:19:21.399699 unknown[1026]: wrote ssh authorized keys file for user: core Jul 10 00:19:21.405406 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jul 10 00:19:21.407541 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jul 10 00:19:21.424395 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 00:19:21.427044 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 10 00:19:21.429499 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Jul 10 00:19:21.432350 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Jul 10 00:19:21.432350 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Jul 10 00:19:21.432350 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-x86-64.raw: attempt #1 Jul 10 00:19:21.930376 systemd-networkd[852]: eth0: Gained IPv6LL Jul 10 00:19:22.146511 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jul 10 00:19:22.795578 ignition[1026]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-x86-64.raw" Jul 10 00:19:22.795578 ignition[1026]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Jul 10 00:19:22.800124 ignition[1026]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 00:19:22.913398 ignition[1026]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 10 00:19:22.913398 ignition[1026]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Jul 10 00:19:22.913398 ignition[1026]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Jul 10 00:19:22.938415 ignition[1026]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 00:19:22.944984 ignition[1026]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 10 00:19:22.946561 ignition[1026]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Jul 10 00:19:22.946561 ignition[1026]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 10 00:19:22.946561 ignition[1026]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 10 00:19:22.946561 ignition[1026]: INFO : files: files passed Jul 10 00:19:22.946561 ignition[1026]: INFO : Ignition finished successfully Jul 10 00:19:22.949258 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 10 00:19:22.952459 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 10 00:19:22.954786 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 10 00:19:22.975039 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 10 00:19:22.975183 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 10 00:19:22.979614 initrd-setup-root-after-ignition[1056]: grep: /sysroot/oem/oem-release: No such file or directory Jul 10 00:19:22.983757 initrd-setup-root-after-ignition[1058]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:22.985680 initrd-setup-root-after-ignition[1058]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:22.987203 initrd-setup-root-after-ignition[1062]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 10 00:19:22.990314 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 00:19:22.990928 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 10 00:19:22.995049 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 10 00:19:23.044399 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 10 00:19:23.044543 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 10 00:19:23.045748 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 10 00:19:23.047861 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 10 00:19:23.049772 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 10 00:19:23.051503 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 10 00:19:23.095251 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 00:19:23.098118 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 10 00:19:23.128983 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:23.129427 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:23.131662 systemd[1]: Stopped target timers.target - Timer Units. Jul 10 00:19:23.132028 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 10 00:19:23.132217 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 10 00:19:23.137099 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 10 00:19:23.139282 systemd[1]: Stopped target basic.target - Basic System. Jul 10 00:19:23.139677 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 10 00:19:23.140048 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 10 00:19:23.144832 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 10 00:19:23.145517 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 10 00:19:23.148470 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 10 00:19:23.150478 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 10 00:19:23.150974 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 10 00:19:23.154624 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 10 00:19:23.154966 systemd[1]: Stopped target swap.target - Swaps. Jul 10 00:19:23.155462 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 10 00:19:23.155609 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 10 00:19:23.160100 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:23.160439 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:23.160709 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 10 00:19:23.166103 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:23.166564 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 10 00:19:23.166685 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 10 00:19:23.168896 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 10 00:19:23.169033 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 10 00:19:23.169528 systemd[1]: Stopped target paths.target - Path Units. Jul 10 00:19:23.173670 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 10 00:19:23.179085 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:23.179492 systemd[1]: Stopped target slices.target - Slice Units. Jul 10 00:19:23.182374 systemd[1]: Stopped target sockets.target - Socket Units. Jul 10 00:19:23.182690 systemd[1]: iscsid.socket: Deactivated successfully. Jul 10 00:19:23.182805 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 10 00:19:23.185533 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 10 00:19:23.185636 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 10 00:19:23.187411 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 10 00:19:23.187573 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 10 00:19:23.189044 systemd[1]: ignition-files.service: Deactivated successfully. Jul 10 00:19:23.189178 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 10 00:19:23.195568 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 10 00:19:23.196814 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 10 00:19:23.198436 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 10 00:19:23.198584 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:23.200435 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 10 00:19:23.200578 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 10 00:19:23.208151 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 10 00:19:23.208304 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 10 00:19:23.225151 ignition[1082]: INFO : Ignition 2.21.0 Jul 10 00:19:23.225151 ignition[1082]: INFO : Stage: umount Jul 10 00:19:23.227395 ignition[1082]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 10 00:19:23.227395 ignition[1082]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 10 00:19:23.227395 ignition[1082]: INFO : umount: umount passed Jul 10 00:19:23.227395 ignition[1082]: INFO : Ignition finished successfully Jul 10 00:19:23.231606 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 10 00:19:23.232306 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 10 00:19:23.232425 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 10 00:19:23.234039 systemd[1]: Stopped target network.target - Network. Jul 10 00:19:23.235304 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 10 00:19:23.235375 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 10 00:19:23.237381 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 10 00:19:23.237441 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 10 00:19:23.237788 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 10 00:19:23.237845 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 10 00:19:23.241396 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 10 00:19:23.241460 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 10 00:19:23.241869 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 10 00:19:23.245834 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 10 00:19:23.256896 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 10 00:19:23.257126 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 10 00:19:23.262183 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 10 00:19:23.262498 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 10 00:19:23.262547 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:23.267143 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jul 10 00:19:23.270133 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 10 00:19:23.270270 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 10 00:19:23.274408 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jul 10 00:19:23.274585 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 10 00:19:23.275398 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 10 00:19:23.275440 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:23.280254 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 10 00:19:23.280855 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 10 00:19:23.280918 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 10 00:19:23.281451 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 10 00:19:23.281496 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:23.287564 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 10 00:19:23.287616 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:23.288432 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:23.289964 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jul 10 00:19:23.321198 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 10 00:19:23.321391 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:23.323028 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 10 00:19:23.323124 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:23.325576 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 10 00:19:23.325617 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:23.325936 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 10 00:19:23.326008 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 10 00:19:23.327043 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 10 00:19:23.327093 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 10 00:19:23.327801 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 10 00:19:23.327850 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 10 00:19:23.339744 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 10 00:19:23.340367 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 10 00:19:23.340424 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 00:19:23.345062 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 10 00:19:23.345132 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:23.348822 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 10 00:19:23.348872 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:23.352580 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 10 00:19:23.352631 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:23.355151 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 00:19:23.355199 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:23.359573 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 10 00:19:23.361252 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 10 00:19:23.368599 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 10 00:19:23.368736 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 10 00:19:23.411668 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 10 00:19:23.411857 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 10 00:19:23.412687 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 10 00:19:23.414866 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 10 00:19:23.414946 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 10 00:19:23.416486 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 10 00:19:23.449964 systemd[1]: Switching root. Jul 10 00:19:23.497662 systemd-journald[220]: Journal stopped Jul 10 00:19:24.831206 systemd-journald[220]: Received SIGTERM from PID 1 (systemd). Jul 10 00:19:24.831282 kernel: SELinux: policy capability network_peer_controls=1 Jul 10 00:19:24.831297 kernel: SELinux: policy capability open_perms=1 Jul 10 00:19:24.831309 kernel: SELinux: policy capability extended_socket_class=1 Jul 10 00:19:24.831338 kernel: SELinux: policy capability always_check_network=0 Jul 10 00:19:24.831349 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 10 00:19:24.831361 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 10 00:19:24.831375 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 10 00:19:24.831387 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 10 00:19:24.831398 kernel: SELinux: policy capability userspace_initial_context=0 Jul 10 00:19:24.831410 kernel: audit: type=1403 audit(1752106763.889:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 10 00:19:24.831430 systemd[1]: Successfully loaded SELinux policy in 52.486ms. Jul 10 00:19:24.831467 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 19.377ms. Jul 10 00:19:24.831481 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) Jul 10 00:19:24.831494 systemd[1]: Detected virtualization kvm. Jul 10 00:19:24.831508 systemd[1]: Detected architecture x86-64. Jul 10 00:19:24.831520 systemd[1]: Detected first boot. Jul 10 00:19:24.831533 systemd[1]: Initializing machine ID from VM UUID. Jul 10 00:19:24.831546 zram_generator::config[1127]: No configuration found. Jul 10 00:19:24.831559 kernel: Guest personality initialized and is inactive Jul 10 00:19:24.831570 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Jul 10 00:19:24.831582 kernel: Initialized host personality Jul 10 00:19:24.831593 kernel: NET: Registered PF_VSOCK protocol family Jul 10 00:19:24.831605 systemd[1]: Populated /etc with preset unit settings. Jul 10 00:19:24.831621 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 10 00:19:24.831639 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 10 00:19:24.831651 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 10 00:19:24.831665 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 10 00:19:24.831679 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 10 00:19:24.831692 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 10 00:19:24.831706 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 10 00:19:24.831722 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 10 00:19:24.831735 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 10 00:19:24.831751 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 10 00:19:24.831770 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 10 00:19:24.831782 systemd[1]: Created slice user.slice - User and Session Slice. Jul 10 00:19:24.831795 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 10 00:19:24.831808 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 10 00:19:24.831821 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 10 00:19:24.831834 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 10 00:19:24.831847 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 10 00:19:24.831870 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 10 00:19:24.831886 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 10 00:19:24.831899 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 10 00:19:24.831913 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 10 00:19:24.831926 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 10 00:19:24.831938 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 10 00:19:24.831950 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 10 00:19:24.831962 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 10 00:19:24.831977 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 10 00:19:24.832004 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 10 00:19:24.832016 systemd[1]: Reached target slices.target - Slice Units. Jul 10 00:19:24.832028 systemd[1]: Reached target swap.target - Swaps. Jul 10 00:19:24.832041 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 10 00:19:24.832053 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 10 00:19:24.832066 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 10 00:19:24.832078 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 10 00:19:24.832091 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 10 00:19:24.832106 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 10 00:19:24.832118 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 10 00:19:24.832130 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 10 00:19:24.832142 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 10 00:19:24.832154 systemd[1]: Mounting media.mount - External Media Directory... Jul 10 00:19:24.832167 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:24.832179 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 10 00:19:24.832191 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 10 00:19:24.832203 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 10 00:19:24.832219 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jul 10 00:19:24.832320 systemd[1]: Reached target machines.target - Containers. Jul 10 00:19:24.832332 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 10 00:19:24.832345 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:24.832357 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 10 00:19:24.832369 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 10 00:19:24.832388 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:24.832400 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 00:19:24.832415 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:24.832427 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 10 00:19:24.832439 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:24.832451 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 10 00:19:24.832464 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 10 00:19:24.832476 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 10 00:19:24.832489 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 10 00:19:24.832501 systemd[1]: Stopped systemd-fsck-usr.service. Jul 10 00:19:24.832514 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). Jul 10 00:19:24.832529 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 10 00:19:24.832541 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 10 00:19:24.832553 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 10 00:19:24.832565 kernel: fuse: init (API version 7.41) Jul 10 00:19:24.832578 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 10 00:19:24.832598 kernel: loop: module loaded Jul 10 00:19:24.832610 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 10 00:19:24.832623 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 10 00:19:24.832638 systemd[1]: verity-setup.service: Deactivated successfully. Jul 10 00:19:24.832650 systemd[1]: Stopped verity-setup.service. Jul 10 00:19:24.832663 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:24.832678 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 10 00:19:24.832690 kernel: ACPI: bus type drm_connector registered Jul 10 00:19:24.832704 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 10 00:19:24.832717 systemd[1]: Mounted media.mount - External Media Directory. Jul 10 00:19:24.832730 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 10 00:19:24.832745 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 10 00:19:24.832757 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 10 00:19:24.832769 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 10 00:19:24.832813 systemd-journald[1205]: Collecting audit messages is disabled. Jul 10 00:19:24.832837 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 10 00:19:24.832851 systemd-journald[1205]: Journal started Jul 10 00:19:24.832882 systemd-journald[1205]: Runtime Journal (/run/log/journal/be628eeda4de44ad8f54af6bde26e9dd) is 6M, max 48.2M, 42.2M free. Jul 10 00:19:24.531202 systemd[1]: Queued start job for default target multi-user.target. Jul 10 00:19:24.556389 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 10 00:19:24.557099 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 10 00:19:24.834014 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 10 00:19:24.835175 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 10 00:19:24.838003 systemd[1]: Started systemd-journald.service - Journal Service. Jul 10 00:19:24.839267 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:24.839506 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:24.841062 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 00:19:24.841289 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 00:19:24.842804 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:24.843182 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:24.844721 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 10 00:19:24.844949 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 10 00:19:24.846354 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:24.846574 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:24.848037 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 10 00:19:24.849462 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 10 00:19:24.851060 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 10 00:19:24.852621 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 10 00:19:24.867799 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 10 00:19:24.870546 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 10 00:19:24.872724 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 10 00:19:24.873906 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 10 00:19:24.873937 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 10 00:19:24.875909 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 10 00:19:24.877970 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 10 00:19:24.880266 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:24.898139 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 10 00:19:24.903082 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 10 00:19:24.904536 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 00:19:24.916104 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 10 00:19:24.917511 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 00:19:24.919922 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 10 00:19:24.922893 systemd-journald[1205]: Time spent on flushing to /var/log/journal/be628eeda4de44ad8f54af6bde26e9dd is 86.011ms for 1017 entries. Jul 10 00:19:24.922893 systemd-journald[1205]: System Journal (/var/log/journal/be628eeda4de44ad8f54af6bde26e9dd) is 8M, max 195.6M, 187.6M free. Jul 10 00:19:25.024148 systemd-journald[1205]: Received client request to flush runtime journal. Jul 10 00:19:25.024198 kernel: loop0: detected capacity change from 0 to 113872 Jul 10 00:19:25.024213 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 10 00:19:24.924276 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 10 00:19:24.928740 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 10 00:19:24.937108 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 10 00:19:24.938669 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 10 00:19:24.940173 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 10 00:19:24.942171 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 10 00:19:24.949545 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 10 00:19:25.008799 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 10 00:19:25.026655 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 10 00:19:25.028543 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 10 00:19:25.033765 systemd-tmpfiles[1247]: ACLs are not supported, ignoring. Jul 10 00:19:25.033781 systemd-tmpfiles[1247]: ACLs are not supported, ignoring. Jul 10 00:19:25.043443 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 10 00:19:25.044027 kernel: loop1: detected capacity change from 0 to 146240 Jul 10 00:19:25.048125 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 10 00:19:25.063153 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 10 00:19:25.092033 kernel: loop2: detected capacity change from 0 to 221472 Jul 10 00:19:25.096595 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 10 00:19:25.100150 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 10 00:19:25.150031 kernel: loop3: detected capacity change from 0 to 113872 Jul 10 00:19:25.150636 systemd-tmpfiles[1268]: ACLs are not supported, ignoring. Jul 10 00:19:25.150654 systemd-tmpfiles[1268]: ACLs are not supported, ignoring. Jul 10 00:19:25.157418 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 10 00:19:25.166234 kernel: loop4: detected capacity change from 0 to 146240 Jul 10 00:19:25.184026 kernel: loop5: detected capacity change from 0 to 221472 Jul 10 00:19:25.194213 (sd-merge)[1271]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Jul 10 00:19:25.194962 (sd-merge)[1271]: Merged extensions into '/usr'. Jul 10 00:19:25.200755 systemd[1]: Reload requested from client PID 1246 ('systemd-sysext') (unit systemd-sysext.service)... Jul 10 00:19:25.200779 systemd[1]: Reloading... Jul 10 00:19:25.263029 zram_generator::config[1295]: No configuration found. Jul 10 00:19:25.443257 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:25.558244 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 10 00:19:25.558887 systemd[1]: Reloading finished in 357 ms. Jul 10 00:19:25.566019 ldconfig[1241]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 10 00:19:25.595620 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 10 00:19:25.597409 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 10 00:19:25.614781 systemd[1]: Starting ensure-sysext.service... Jul 10 00:19:25.616867 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 10 00:19:25.634728 systemd[1]: Reload requested from client PID 1335 ('systemctl') (unit ensure-sysext.service)... Jul 10 00:19:25.634755 systemd[1]: Reloading... Jul 10 00:19:25.655719 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 10 00:19:25.655757 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 10 00:19:25.656110 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 10 00:19:25.656399 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 10 00:19:25.657625 systemd-tmpfiles[1336]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 10 00:19:25.657939 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Jul 10 00:19:25.658071 systemd-tmpfiles[1336]: ACLs are not supported, ignoring. Jul 10 00:19:25.663149 systemd-tmpfiles[1336]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 00:19:25.663165 systemd-tmpfiles[1336]: Skipping /boot Jul 10 00:19:25.757172 systemd-tmpfiles[1336]: Detected autofs mount point /boot during canonicalization of boot. Jul 10 00:19:25.757362 systemd-tmpfiles[1336]: Skipping /boot Jul 10 00:19:25.766034 zram_generator::config[1362]: No configuration found. Jul 10 00:19:25.878537 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:25.971057 systemd[1]: Reloading finished in 335 ms. Jul 10 00:19:25.993598 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 10 00:19:26.024767 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 10 00:19:26.035503 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 10 00:19:26.038322 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 10 00:19:26.041054 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 10 00:19:26.054794 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 10 00:19:26.059246 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 10 00:19:26.063760 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 10 00:19:26.068544 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.068733 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:26.072214 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:26.075106 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:26.078133 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:26.080295 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:26.080417 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). Jul 10 00:19:26.087520 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 10 00:19:26.090076 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.093957 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 10 00:19:26.103566 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 10 00:19:26.105684 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 10 00:19:26.107866 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:26.108471 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:26.110201 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:26.115339 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:26.117327 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:26.117564 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:26.119848 systemd-udevd[1407]: Using default interface naming scheme 'v255'. Jul 10 00:19:26.127265 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.127441 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:26.129407 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 10 00:19:26.134210 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 10 00:19:26.139122 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 10 00:19:26.156518 augenrules[1440]: No rules Jul 10 00:19:26.209966 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:26.211226 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). Jul 10 00:19:26.211350 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.212201 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 10 00:19:26.215653 systemd[1]: audit-rules.service: Deactivated successfully. Jul 10 00:19:26.216071 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 10 00:19:26.219550 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 10 00:19:26.225226 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 10 00:19:26.253660 systemd[1]: Finished ensure-sysext.service. Jul 10 00:19:26.255287 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 10 00:19:26.256111 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 10 00:19:26.258370 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 10 00:19:26.258653 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 10 00:19:26.261633 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 10 00:19:26.262012 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 10 00:19:26.267526 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 10 00:19:26.278426 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.284371 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 10 00:19:26.285572 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 10 00:19:26.287107 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 10 00:19:26.288270 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 10 00:19:26.288308 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). Jul 10 00:19:26.293337 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 10 00:19:26.294421 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 10 00:19:26.294499 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 10 00:19:26.296588 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 10 00:19:26.297722 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jul 10 00:19:26.297749 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jul 10 00:19:26.321452 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 10 00:19:26.323067 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 10 00:19:26.380039 augenrules[1483]: /sbin/augenrules: No change Jul 10 00:19:26.387182 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 10 00:19:26.402663 augenrules[1511]: No rules Jul 10 00:19:26.406319 systemd-resolved[1405]: Positive Trust Anchors: Jul 10 00:19:26.406334 systemd-resolved[1405]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 10 00:19:26.406377 systemd-resolved[1405]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jul 10 00:19:26.407477 systemd[1]: audit-rules.service: Deactivated successfully. Jul 10 00:19:26.407818 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 10 00:19:26.415324 systemd-resolved[1405]: Defaulting to hostname 'linux'. Jul 10 00:19:26.419475 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 10 00:19:26.421197 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 10 00:19:26.492017 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Jul 10 00:19:26.501017 kernel: ACPI: button: Power Button [PWRF] Jul 10 00:19:26.502854 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 10 00:19:26.510015 kernel: mousedev: PS/2 mouse device common for all mice Jul 10 00:19:26.512440 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 10 00:19:26.526282 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 10 00:19:26.528036 systemd[1]: Reached target sysinit.target - System Initialization. Jul 10 00:19:26.529661 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 10 00:19:26.531154 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 10 00:19:26.534137 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Jul 10 00:19:26.535652 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 10 00:19:26.537445 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 10 00:19:26.537493 systemd[1]: Reached target paths.target - Path Units. Jul 10 00:19:26.538943 systemd[1]: Reached target time-set.target - System Time Set. Jul 10 00:19:26.540394 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 10 00:19:26.541786 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 10 00:19:26.546140 systemd[1]: Reached target timers.target - Timer Units. Jul 10 00:19:26.548365 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 10 00:19:26.550861 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 10 00:19:26.554653 systemd-networkd[1485]: lo: Link UP Jul 10 00:19:26.554659 systemd-networkd[1485]: lo: Gained carrier Jul 10 00:19:26.555559 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 10 00:19:26.557338 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 10 00:19:26.559149 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 10 00:19:26.566159 systemd-networkd[1485]: Enumeration completed Jul 10 00:19:26.574119 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 10 00:19:26.575420 systemd-networkd[1485]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:26.575433 systemd-networkd[1485]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 10 00:19:26.576387 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 10 00:19:26.579496 systemd-networkd[1485]: eth0: Link UP Jul 10 00:19:26.580056 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 10 00:19:26.580558 systemd-networkd[1485]: eth0: Gained carrier Jul 10 00:19:26.580583 systemd-networkd[1485]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 10 00:19:26.581938 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 10 00:19:26.583537 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 10 00:19:26.592211 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Jul 10 00:19:26.592511 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jul 10 00:19:26.593764 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jul 10 00:19:26.594411 systemd[1]: Reached target network.target - Network. Jul 10 00:19:26.596623 systemd[1]: Reached target sockets.target - Socket Units. Jul 10 00:19:26.597955 systemd[1]: Reached target basic.target - Basic System. Jul 10 00:19:26.599688 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 10 00:19:26.599724 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 10 00:19:26.601240 systemd-networkd[1485]: eth0: DHCPv4 address 10.0.0.73/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 10 00:19:26.602616 systemd[1]: Starting containerd.service - containerd container runtime... Jul 10 00:19:26.605078 systemd-timesyncd[1487]: Network configuration changed, trying to establish connection. Jul 10 00:19:28.151772 systemd-timesyncd[1487]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 10 00:19:28.151835 systemd-timesyncd[1487]: Initial clock synchronization to Thu 2025-07-10 00:19:28.151669 UTC. Jul 10 00:19:28.151877 systemd-resolved[1405]: Clock change detected. Flushing caches. Jul 10 00:19:28.170874 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 10 00:19:28.181685 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 10 00:19:28.184070 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 10 00:19:28.186227 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 10 00:19:28.188713 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jul 10 00:19:28.198686 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Jul 10 00:19:28.201517 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 10 00:19:28.205514 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 10 00:19:28.208216 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 10 00:19:28.209930 jq[1547]: false Jul 10 00:19:28.219015 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 10 00:19:28.229046 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Refreshing passwd entry cache Jul 10 00:19:28.227955 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 10 00:19:28.227139 oslogin_cache_refresh[1549]: Refreshing passwd entry cache Jul 10 00:19:28.230845 extend-filesystems[1548]: Found /dev/vda6 Jul 10 00:19:28.236400 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Failure getting users, quitting Jul 10 00:19:28.236465 oslogin_cache_refresh[1549]: Failure getting users, quitting Jul 10 00:19:28.236556 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 10 00:19:28.236587 oslogin_cache_refresh[1549]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Jul 10 00:19:28.236707 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Refreshing group entry cache Jul 10 00:19:28.236740 oslogin_cache_refresh[1549]: Refreshing group entry cache Jul 10 00:19:28.238929 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 10 00:19:28.241795 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 10 00:19:28.242584 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 10 00:19:28.244155 extend-filesystems[1548]: Found /dev/vda9 Jul 10 00:19:28.245720 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Failure getting groups, quitting Jul 10 00:19:28.245720 google_oslogin_nss_cache[1549]: oslogin_cache_refresh[1549]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 10 00:19:28.244709 oslogin_cache_refresh[1549]: Failure getting groups, quitting Jul 10 00:19:28.244722 oslogin_cache_refresh[1549]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Jul 10 00:19:28.247410 systemd[1]: Starting update-engine.service - Update Engine... Jul 10 00:19:28.250885 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 10 00:19:28.255875 extend-filesystems[1548]: Checking size of /dev/vda9 Jul 10 00:19:28.271534 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 10 00:19:28.273934 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 10 00:19:28.274292 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 10 00:19:28.274842 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Jul 10 00:19:28.275307 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Jul 10 00:19:28.276569 jq[1569]: true Jul 10 00:19:28.277277 extend-filesystems[1548]: Resized partition /dev/vda9 Jul 10 00:19:28.279807 extend-filesystems[1575]: resize2fs 1.47.2 (1-Jan-2025) Jul 10 00:19:28.291335 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 10 00:19:28.292328 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 10 00:19:28.302011 jq[1576]: true Jul 10 00:19:28.305686 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Jul 10 00:19:28.313910 systemd[1]: motdgen.service: Deactivated successfully. Jul 10 00:19:28.314246 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 10 00:19:28.315688 update_engine[1568]: I20250710 00:19:28.314280 1568 main.cc:92] Flatcar Update Engine starting Jul 10 00:19:28.326520 (ntainerd)[1581]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 10 00:19:28.328631 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:28.360672 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 10 00:19:28.361005 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:28.369237 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 10 00:19:28.371261 dbus-daemon[1545]: [system] SELinux support is enabled Jul 10 00:19:28.371295 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 10 00:19:28.373817 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 10 00:19:28.381470 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jul 10 00:19:28.381501 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 10 00:19:28.383539 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jul 10 00:19:28.383558 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 10 00:19:28.388205 systemd[1]: Started update-engine.service - Update Engine. Jul 10 00:19:28.412653 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Jul 10 00:19:28.433640 update_engine[1568]: I20250710 00:19:28.412770 1568 update_check_scheduler.cc:74] Next update check in 6m56s Jul 10 00:19:28.436576 extend-filesystems[1575]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jul 10 00:19:28.436576 extend-filesystems[1575]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 10 00:19:28.436576 extend-filesystems[1575]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Jul 10 00:19:28.448942 extend-filesystems[1548]: Resized filesystem in /dev/vda9 Jul 10 00:19:28.449886 bash[1610]: Updated "/home/core/.ssh/authorized_keys" Jul 10 00:19:28.438060 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 10 00:19:28.440017 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 10 00:19:28.440287 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 10 00:19:28.456989 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 10 00:19:28.458880 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 10 00:19:28.591423 kernel: kvm_amd: TSC scaling supported Jul 10 00:19:28.591537 kernel: kvm_amd: Nested Virtualization enabled Jul 10 00:19:28.591552 kernel: kvm_amd: Nested Paging enabled Jul 10 00:19:28.591565 kernel: kvm_amd: LBR virtualization supported Jul 10 00:19:28.595039 systemd-logind[1556]: Watching system buttons on /dev/input/event2 (Power Button) Jul 10 00:19:28.595074 systemd-logind[1556]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jul 10 00:19:28.595378 systemd-logind[1556]: New seat seat0. Jul 10 00:19:28.597491 systemd[1]: Started systemd-logind.service - User Login Management. Jul 10 00:19:28.606686 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Jul 10 00:19:28.606819 kernel: kvm_amd: Virtual GIF supported Jul 10 00:19:28.628639 locksmithd[1611]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 10 00:19:28.648926 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 10 00:19:28.653695 kernel: EDAC MC: Ver: 3.0.0 Jul 10 00:19:28.728140 containerd[1581]: time="2025-07-10T00:19:28Z" 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 Jul 10 00:19:28.731281 containerd[1581]: time="2025-07-10T00:19:28.731230374Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 10 00:19:28.758352 sshd_keygen[1590]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 10 00:19:28.793573 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 10 00:19:28.797849 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.808493860Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="13.245µs" Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.808596372Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.808650805Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.808967088Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.808990862Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 10 00:19:28.809106 containerd[1581]: time="2025-07-10T00:19:28.809031519Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 00:19:28.809380 containerd[1581]: time="2025-07-10T00:19:28.809324799Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 10 00:19:28.809380 containerd[1581]: time="2025-07-10T00:19:28.809370655Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 10 00:19:28.809910 containerd[1581]: time="2025-07-10T00:19:28.809872175Z" 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 Jul 10 00:19:28.809910 containerd[1581]: time="2025-07-10T00:19:28.809898234Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 00:19:28.809910 containerd[1581]: time="2025-07-10T00:19:28.809911950Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 10 00:19:28.810006 containerd[1581]: time="2025-07-10T00:19:28.809920325Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 10 00:19:28.810082 containerd[1581]: time="2025-07-10T00:19:28.810051822Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 10 00:19:28.810382 containerd[1581]: time="2025-07-10T00:19:28.810352175Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 10 00:19:28.810407 containerd[1581]: time="2025-07-10T00:19:28.810389285Z" 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 Jul 10 00:19:28.810407 containerd[1581]: time="2025-07-10T00:19:28.810399895Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 10 00:19:28.810463 containerd[1581]: time="2025-07-10T00:19:28.810445200Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 10 00:19:28.811091 containerd[1581]: time="2025-07-10T00:19:28.811022983Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 10 00:19:28.811241 containerd[1581]: time="2025-07-10T00:19:28.811215344Z" level=info msg="metadata content store policy set" policy=shared Jul 10 00:19:28.818076 containerd[1581]: time="2025-07-10T00:19:28.818020767Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 10 00:19:28.818076 containerd[1581]: time="2025-07-10T00:19:28.818076882Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818093333Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818106928Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818122227Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818133378Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818205633Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 10 00:19:28.818230 containerd[1581]: time="2025-07-10T00:19:28.818223607Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 10 00:19:28.818380 containerd[1581]: time="2025-07-10T00:19:28.818238475Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 10 00:19:28.818380 containerd[1581]: time="2025-07-10T00:19:28.818249996Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 10 00:19:28.818380 containerd[1581]: time="2025-07-10T00:19:28.818259334Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 10 00:19:28.818380 containerd[1581]: time="2025-07-10T00:19:28.818274603Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818412090Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818441285Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818456303Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818483164Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818495527Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 10 00:19:28.818505 containerd[1581]: time="2025-07-10T00:19:28.818505536Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818517157Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818527978Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818543978Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818554017Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818564466Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818666237Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 10 00:19:28.818683 containerd[1581]: time="2025-07-10T00:19:28.818680484Z" level=info msg="Start snapshots syncer" Jul 10 00:19:28.818840 containerd[1581]: time="2025-07-10T00:19:28.818715760Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 10 00:19:28.818982 containerd[1581]: time="2025-07-10T00:19:28.818934069Z" 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\"}" Jul 10 00:19:28.819120 containerd[1581]: time="2025-07-10T00:19:28.819060426Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 10 00:19:28.819161 containerd[1581]: time="2025-07-10T00:19:28.819140777Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 10 00:19:28.819284 containerd[1581]: time="2025-07-10T00:19:28.819251535Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 10 00:19:28.819284 containerd[1581]: time="2025-07-10T00:19:28.819275780Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 10 00:19:28.819352 containerd[1581]: time="2025-07-10T00:19:28.819286490Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 10 00:19:28.819352 containerd[1581]: time="2025-07-10T00:19:28.819296168Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 10 00:19:28.819352 containerd[1581]: time="2025-07-10T00:19:28.819307780Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 10 00:19:28.819352 containerd[1581]: time="2025-07-10T00:19:28.819318761Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 10 00:19:28.819352 containerd[1581]: time="2025-07-10T00:19:28.819328529Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819364246Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819388111Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819399883Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819446160Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819460667Z" 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 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819469403Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819479152Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819487417Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 10 00:19:28.819487 containerd[1581]: time="2025-07-10T00:19:28.819496975Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819507475Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819525178Z" level=info msg="runtime interface created" Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819531069Z" level=info msg="created NRI interface" Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819538783Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819548882Z" level=info msg="Connect containerd service" Jul 10 00:19:28.819742 containerd[1581]: time="2025-07-10T00:19:28.819570693Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 10 00:19:28.821054 containerd[1581]: time="2025-07-10T00:19:28.820659756Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jul 10 00:19:28.822759 systemd[1]: issuegen.service: Deactivated successfully. Jul 10 00:19:28.823119 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 10 00:19:28.826330 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 10 00:19:28.857928 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 10 00:19:28.862393 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 10 00:19:28.866327 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 10 00:19:28.868324 systemd[1]: Reached target getty.target - Login Prompts. Jul 10 00:19:29.002599 containerd[1581]: time="2025-07-10T00:19:29.002451821Z" level=info msg="Start subscribing containerd event" Jul 10 00:19:29.002599 containerd[1581]: time="2025-07-10T00:19:29.002538092Z" level=info msg="Start recovering state" Jul 10 00:19:29.002866 containerd[1581]: time="2025-07-10T00:19:29.002844898Z" level=info msg="Start event monitor" Jul 10 00:19:29.002890 containerd[1581]: time="2025-07-10T00:19:29.002882919Z" level=info msg="Start cni network conf syncer for default" Jul 10 00:19:29.002911 containerd[1581]: time="2025-07-10T00:19:29.002893509Z" level=info msg="Start streaming server" Jul 10 00:19:29.002931 containerd[1581]: time="2025-07-10T00:19:29.002851600Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 10 00:19:29.003056 containerd[1581]: time="2025-07-10T00:19:29.002905211Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 10 00:19:29.003056 containerd[1581]: time="2025-07-10T00:19:29.003046586Z" level=info msg="runtime interface starting up..." Jul 10 00:19:29.003056 containerd[1581]: time="2025-07-10T00:19:29.003059130Z" level=info msg="starting plugins..." Jul 10 00:19:29.003246 containerd[1581]: time="2025-07-10T00:19:29.003090498Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 10 00:19:29.003291 containerd[1581]: time="2025-07-10T00:19:29.003271498Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 10 00:19:29.003384 containerd[1581]: time="2025-07-10T00:19:29.003362318Z" level=info msg="containerd successfully booted in 0.275988s" Jul 10 00:19:29.003523 systemd[1]: Started containerd.service - containerd container runtime. Jul 10 00:19:30.003927 systemd-networkd[1485]: eth0: Gained IPv6LL Jul 10 00:19:30.007493 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 10 00:19:30.009742 systemd[1]: Reached target network-online.target - Network is Online. Jul 10 00:19:30.012743 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 10 00:19:30.015686 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:30.018211 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 10 00:19:30.050853 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 10 00:19:30.071260 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 10 00:19:30.071727 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 10 00:19:30.073844 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 10 00:19:31.525420 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:31.527317 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 10 00:19:31.528768 systemd[1]: Startup finished in 3.672s (kernel) + 6.235s (initrd) + 6.144s (userspace) = 16.052s. Jul 10 00:19:31.533080 (kubelet)[1688]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jul 10 00:19:32.148490 kubelet[1688]: E0710 00:19:32.148397 1688 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Jul 10 00:19:32.153976 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jul 10 00:19:32.154214 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jul 10 00:19:32.154670 systemd[1]: kubelet.service: Consumed 1.887s CPU time, 263.3M memory peak. Jul 10 00:19:33.072110 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 10 00:19:33.074172 systemd[1]: Started sshd@0-10.0.0.73:22-10.0.0.1:42884.service - OpenSSH per-connection server daemon (10.0.0.1:42884). Jul 10 00:19:33.159480 sshd[1701]: Accepted publickey for core from 10.0.0.1 port 42884 ssh2: RSA SHA256:a/WzkVKs173+YSebQY64/4LigDpieaPOYRH6W2gWTe4 Jul 10 00:19:33.161944 sshd-session[1701]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:33.170506 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 10 00:19:33.171884 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 10 00:19:33.179781 systemd-logind[1556]: New session 1 of user core. Jul 10 00:19:33.195677 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 10 00:19:33.199432 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 10 00:19:33.224406 (systemd)[1705]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 10 00:19:33.228171 systemd-logind[1556]: New session c1 of user core. Jul 10 00:19:33.402023 systemd[1705]: Queued start job for default target default.target. Jul 10 00:19:33.421368 systemd[1705]: Created slice app.slice - User Application Slice. Jul 10 00:19:33.421404 systemd[1705]: Reached target paths.target - Paths. Jul 10 00:19:33.421455 systemd[1705]: Reached target timers.target - Timers. Jul 10 00:19:33.423236 systemd[1705]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 10 00:19:33.435548 systemd[1705]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 10 00:19:33.435745 systemd[1705]: Reached target sockets.target - Sockets. Jul 10 00:19:33.435794 systemd[1705]: Reached target basic.target - Basic System. Jul 10 00:19:33.435846 systemd[1705]: Reached target default.target - Main User Target. Jul 10 00:19:33.435880 systemd[1705]: Startup finished in 199ms. Jul 10 00:19:33.436200 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 10 00:19:33.438268 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 10 00:19:33.509285 systemd[1]: Started sshd@1-10.0.0.73:22-10.0.0.1:42896.service - OpenSSH per-connection server daemon (10.0.0.1:42896). Jul 10 00:19:33.563516 sshd[1716]: Accepted publickey for core from 10.0.0.1 port 42896 ssh2: RSA SHA256:a/WzkVKs173+YSebQY64/4LigDpieaPOYRH6W2gWTe4 Jul 10 00:19:33.565186 sshd-session[1716]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:33.570782 systemd-logind[1556]: New session 2 of user core. Jul 10 00:19:33.584834 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 10 00:19:33.642464 sshd[1718]: Connection closed by 10.0.0.1 port 42896 Jul 10 00:19:33.642808 sshd-session[1716]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:33.651274 systemd[1]: sshd@1-10.0.0.73:22-10.0.0.1:42896.service: Deactivated successfully. Jul 10 00:19:33.653197 systemd[1]: session-2.scope: Deactivated successfully. Jul 10 00:19:33.654007 systemd-logind[1556]: Session 2 logged out. Waiting for processes to exit. Jul 10 00:19:33.656952 systemd[1]: Started sshd@2-10.0.0.73:22-10.0.0.1:42904.service - OpenSSH per-connection server daemon (10.0.0.1:42904). Jul 10 00:19:33.657485 systemd-logind[1556]: Removed session 2. Jul 10 00:19:33.712824 sshd[1724]: Accepted publickey for core from 10.0.0.1 port 42904 ssh2: RSA SHA256:a/WzkVKs173+YSebQY64/4LigDpieaPOYRH6W2gWTe4 Jul 10 00:19:33.714507 sshd-session[1724]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:33.719447 systemd-logind[1556]: New session 3 of user core. Jul 10 00:19:33.728977 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 10 00:19:33.781715 sshd[1726]: Connection closed by 10.0.0.1 port 42904 Jul 10 00:19:33.782072 sshd-session[1724]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:33.797984 systemd[1]: sshd@2-10.0.0.73:22-10.0.0.1:42904.service: Deactivated successfully. Jul 10 00:19:33.800198 systemd[1]: session-3.scope: Deactivated successfully. Jul 10 00:19:33.801011 systemd-logind[1556]: Session 3 logged out. Waiting for processes to exit. Jul 10 00:19:33.803148 systemd-logind[1556]: Removed session 3. Jul 10 00:19:33.804369 systemd[1]: Started sshd@3-10.0.0.73:22-10.0.0.1:42910.service - OpenSSH per-connection server daemon (10.0.0.1:42910). Jul 10 00:19:33.861019 sshd[1732]: Accepted publickey for core from 10.0.0.1 port 42910 ssh2: RSA SHA256:a/WzkVKs173+YSebQY64/4LigDpieaPOYRH6W2gWTe4 Jul 10 00:19:33.862738 sshd-session[1732]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:33.868222 systemd-logind[1556]: New session 4 of user core. Jul 10 00:19:33.877772 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 10 00:19:33.934085 sshd[1734]: Connection closed by 10.0.0.1 port 42910 Jul 10 00:19:33.934442 sshd-session[1732]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:33.947761 systemd[1]: sshd@3-10.0.0.73:22-10.0.0.1:42910.service: Deactivated successfully. Jul 10 00:19:33.949553 systemd[1]: session-4.scope: Deactivated successfully. Jul 10 00:19:33.950548 systemd-logind[1556]: Session 4 logged out. Waiting for processes to exit. Jul 10 00:19:33.953091 systemd[1]: Started sshd@4-10.0.0.73:22-10.0.0.1:42924.service - OpenSSH per-connection server daemon (10.0.0.1:42924). Jul 10 00:19:33.954434 systemd-logind[1556]: Removed session 4. Jul 10 00:19:34.013899 sshd[1740]: Accepted publickey for core from 10.0.0.1 port 42924 ssh2: RSA SHA256:a/WzkVKs173+YSebQY64/4LigDpieaPOYRH6W2gWTe4 Jul 10 00:19:34.015630 sshd-session[1740]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 10 00:19:34.020551 systemd-logind[1556]: New session 5 of user core. Jul 10 00:19:34.031835 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 10 00:19:34.093129 sudo[1743]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jul 10 00:19:34.093593 sudo[1743]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 10 00:19:34.115510 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 10 00:19:34.192999 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 10 00:19:34.193404 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 10 00:19:34.747936 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:34.748109 systemd[1]: kubelet.service: Consumed 1.887s CPU time, 263.3M memory peak. Jul 10 00:19:34.750524 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:34.776312 systemd[1]: Reload requested from client PID 1786 ('systemctl') (unit session-5.scope)... Jul 10 00:19:34.776330 systemd[1]: Reloading... Jul 10 00:19:34.875660 zram_generator::config[1834]: No configuration found. Jul 10 00:19:35.089385 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 10 00:19:35.210385 systemd[1]: Reloading finished in 433 ms. Jul 10 00:19:35.282767 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jul 10 00:19:35.282896 systemd[1]: kubelet.service: Failed with result 'signal'. Jul 10 00:19:35.283289 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:35.283350 systemd[1]: kubelet.service: Consumed 205ms CPU time, 98.3M memory peak. Jul 10 00:19:35.285400 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jul 10 00:19:35.519044 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jul 10 00:19:35.524346 (kubelet)[1876]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jul 10 00:19:35.577585 kubelet[1876]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jul 10 00:19:35.577585 kubelet[1876]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI. Jul 10 00:19:35.577585 kubelet[1876]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jul 10 00:19:35.578332 kubelet[1876]: I0710 00:19:35.577703 1876 server.go:211] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jul 10 00:19:35.871189 kubelet[1876]: I0710 00:19:35.871057 1876 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Jul 10 00:19:35.871189 kubelet[1876]: I0710 00:19:35.871095 1876 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jul 10 00:19:35.871429 kubelet[1876]: I0710 00:19:35.871382 1876 server.go:934] "Client rotation is on, will bootstrap in background" Jul 10 00:19:35.900690 kubelet[1876]: I0710 00:19:35.900643 1876 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jul 10 00:19:35.910934 kubelet[1876]: I0710 00:19:35.910891 1876 server.go:1431] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Jul 10 00:19:35.917718 kubelet[1876]: I0710 00:19:35.917686 1876 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jul 10 00:19:35.918355 kubelet[1876]: I0710 00:19:35.918324 1876 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Jul 10 00:19:35.918508 kubelet[1876]: I0710 00:19:35.918460 1876 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jul 10 00:19:35.918701 kubelet[1876]: I0710 00:19:35.918495 1876 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.73","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} Jul 10 00:19:35.918834 kubelet[1876]: I0710 00:19:35.918705 1876 topology_manager.go:138] "Creating topology manager with none policy" Jul 10 00:19:35.918834 kubelet[1876]: I0710 00:19:35.918714 1876 container_manager_linux.go:300] "Creating device plugin manager" Jul 10 00:19:35.918876 kubelet[1876]: I0710 00:19:35.918864 1876 state_mem.go:36] "Initialized new in-memory state store" Jul 10 00:19:35.921043 kubelet[1876]: I0710 00:19:35.920996 1876 kubelet.go:408] "Attempting to sync node with API server" Jul 10 00:19:35.921043 kubelet[1876]: I0710 00:19:35.921020 1876 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Jul 10 00:19:35.921242 kubelet[1876]: I0710 00:19:35.921069 1876 kubelet.go:314] "Adding apiserver pod source" Jul 10 00:19:35.921242 kubelet[1876]: I0710 00:19:35.921094 1876 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jul 10 00:19:35.921242 kubelet[1876]: E0710 00:19:35.921216 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:35.921379 kubelet[1876]: E0710 00:19:35.921269 1876 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:35.923565 kubelet[1876]: I0710 00:19:35.923542 1876 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v2.0.4" apiVersion="v1" Jul 10 00:19:35.924021 kubelet[1876]: I0710 00:19:35.924003 1876 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Jul 10 00:19:35.924593 kubelet[1876]: W0710 00:19:35.924568 1876 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jul 10 00:19:35.927272 kubelet[1876]: I0710 00:19:35.926713 1876 server.go:1274] "Started kubelet" Jul 10 00:19:35.928016 kubelet[1876]: I0710 00:19:35.927984 1876 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jul 10 00:19:35.929691 kubelet[1876]: I0710 00:19:35.929657 1876 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Jul 10 00:19:35.930291 kubelet[1876]: I0710 00:19:35.930270 1876 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jul 10 00:19:35.930903 kubelet[1876]: I0710 00:19:35.930861 1876 server.go:449] "Adding debug handlers to kubelet server" Jul 10 00:19:35.934865 kubelet[1876]: I0710 00:19:35.934847 1876 volume_manager.go:289] "Starting Kubelet Volume Manager" Jul 10 00:19:35.935006 kubelet[1876]: I0710 00:19:35.934954 1876 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jul 10 00:19:35.935210 kubelet[1876]: E0710 00:19:35.935190 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:35.935278 kubelet[1876]: I0710 00:19:35.935233 1876 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jul 10 00:19:35.935638 kubelet[1876]: I0710 00:19:35.935604 1876 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Jul 10 00:19:35.935825 kubelet[1876]: I0710 00:19:35.935813 1876 reconciler.go:26] "Reconciler: start to sync state" Jul 10 00:19:35.937223 kubelet[1876]: I0710 00:19:35.937203 1876 factory.go:221] Registration of the systemd container factory successfully Jul 10 00:19:35.937409 kubelet[1876]: I0710 00:19:35.937390 1876 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Jul 10 00:19:35.938346 kubelet[1876]: E0710 00:19:35.938241 1876 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jul 10 00:19:35.938964 kubelet[1876]: I0710 00:19:35.938918 1876 factory.go:221] Registration of the containerd container factory successfully Jul 10 00:19:35.939507 kubelet[1876]: E0710 00:19:35.939435 1876 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.73\" not found" node="10.0.0.73" Jul 10 00:19:35.954238 kubelet[1876]: I0710 00:19:35.954158 1876 cpu_manager.go:214] "Starting CPU manager" policy="none" Jul 10 00:19:35.954238 kubelet[1876]: I0710 00:19:35.954215 1876 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Jul 10 00:19:35.954238 kubelet[1876]: I0710 00:19:35.954241 1876 state_mem.go:36] "Initialized new in-memory state store" Jul 10 00:19:36.035660 kubelet[1876]: E0710 00:19:36.035574 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.136443 kubelet[1876]: E0710 00:19:36.136224 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.237375 kubelet[1876]: E0710 00:19:36.237307 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.337971 kubelet[1876]: E0710 00:19:36.337861 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.438473 kubelet[1876]: E0710 00:19:36.438310 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.499259 kubelet[1876]: E0710 00:19:36.499204 1876 csi_plugin.go:305] Failed to initialize CSINode: error updating CSINode annotation: timed out waiting for the condition; caused by: nodes "10.0.0.73" not found Jul 10 00:19:36.539495 kubelet[1876]: E0710 00:19:36.539420 1876 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.73\" not found" Jul 10 00:19:36.564893 kubelet[1876]: I0710 00:19:36.564849 1876 policy_none.go:49] "None policy: Start" Jul 10 00:19:36.566133 kubelet[1876]: I0710 00:19:36.566040 1876 memory_manager.go:170] "Starting memorymanager" policy="None" Jul 10 00:19:36.566133 kubelet[1876]: I0710 00:19:36.566078 1876 state_mem.go:35] "Initializing new in-memory state store" Jul 10 00:19:36.576253 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jul 10 00:19:36.591269 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jul 10 00:19:36.597005 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jul 10 00:19:36.599202 kubelet[1876]: I0710 00:19:36.599149 1876 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Jul 10 00:19:36.600747 kubelet[1876]: I0710 00:19:36.600697 1876 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Jul 10 00:19:36.600835 kubelet[1876]: I0710 00:19:36.600748 1876 status_manager.go:217] "Starting to sync pod status with apiserver" Jul 10 00:19:36.600835 kubelet[1876]: I0710 00:19:36.600789 1876 kubelet.go:2321] "Starting kubelet main sync loop" Jul 10 00:19:36.600894 kubelet[1876]: E0710 00:19:36.600854 1876 kubelet.go:2345] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Jul 10 00:19:36.604692 kubelet[1876]: I0710 00:19:36.604142 1876 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Jul 10 00:19:36.604692 kubelet[1876]: I0710 00:19:36.604431 1876 eviction_manager.go:189] "Eviction manager: starting control loop" Jul 10 00:19:36.604692 kubelet[1876]: I0710 00:19:36.604452 1876 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jul 10 00:19:36.605212 kubelet[1876]: I0710 00:19:36.605187 1876 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jul 10 00:19:36.606486 kubelet[1876]: E0710 00:19:36.606451 1876 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.73\" not found" Jul 10 00:19:36.706318 kubelet[1876]: I0710 00:19:36.706166 1876 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.73" Jul 10 00:19:36.861292 kubelet[1876]: I0710 00:19:36.861098 1876 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.73" Jul 10 00:19:36.869932 kubelet[1876]: I0710 00:19:36.869867 1876 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jul 10 00:19:36.870385 containerd[1581]: time="2025-07-10T00:19:36.870315113Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jul 10 00:19:36.870825 kubelet[1876]: I0710 00:19:36.870635 1876 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jul 10 00:19:36.873346 kubelet[1876]: I0710 00:19:36.873309 1876 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jul 10 00:19:36.873545 kubelet[1876]: W0710 00:19:36.873508 1876 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Jul 10 00:19:36.873545 kubelet[1876]: W0710 00:19:36.873530 1876 reflector.go:484] 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 Jul 10 00:19:36.873631 kubelet[1876]: W0710 00:19:36.873578 1876 reflector.go:484] 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 Jul 10 00:19:36.874706 kubelet[1876]: E0710 00:19:36.873482 1876 event.go:368] "Unable to write event (may retry after sleeping)" err="Patch \"https://10.0.0.68:6443/api/v1/namespaces/default/events/10.0.0.73.1850bbd4653f1a65\": read tcp 10.0.0.73:36142->10.0.0.68:6443: use of closed network connection" event="&Event{ObjectMeta:{10.0.0.73.1850bbd4653f1a65 default 489 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.73,UID:10.0.0.73,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.73 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.73,},FirstTimestamp:2025-07-10 00:19:35 +0000 UTC,LastTimestamp:2025-07-10 00:19:36.706132171 +0000 UTC m=+1.177705599,Count:2,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.73,}" Jul 10 00:19:36.921811 kubelet[1876]: I0710 00:19:36.921729 1876 apiserver.go:52] "Watching apiserver" Jul 10 00:19:36.921811 kubelet[1876]: E0710 00:19:36.921766 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:36.932390 systemd[1]: Created slice kubepods-besteffort-pod1ecccbca_bf42_47bc_a08d_1ddc64b2bbd0.slice - libcontainer container kubepods-besteffort-pod1ecccbca_bf42_47bc_a08d_1ddc64b2bbd0.slice. Jul 10 00:19:36.936118 kubelet[1876]: I0710 00:19:36.936076 1876 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Jul 10 00:19:36.941596 kubelet[1876]: I0710 00:19:36.941556 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0-kube-proxy\") pod \"kube-proxy-q4m6f\" (UID: \"1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0\") " pod="kube-system/kube-proxy-q4m6f" Jul 10 00:19:36.941596 kubelet[1876]: I0710 00:19:36.941594 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0-xtables-lock\") pod \"kube-proxy-q4m6f\" (UID: \"1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0\") " pod="kube-system/kube-proxy-q4m6f" Jul 10 00:19:36.941732 kubelet[1876]: I0710 00:19:36.941639 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2psjd\" (UniqueName: \"kubernetes.io/projected/1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0-kube-api-access-2psjd\") pod \"kube-proxy-q4m6f\" (UID: \"1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0\") " pod="kube-system/kube-proxy-q4m6f" Jul 10 00:19:36.941732 kubelet[1876]: I0710 00:19:36.941658 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-cni\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.941732 kubelet[1876]: I0710 00:19:36.941672 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-flannel-cfg\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.941732 kubelet[1876]: I0710 00:19:36.941687 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-xtables-lock\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.941732 kubelet[1876]: I0710 00:19:36.941702 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-mjmtx\" (UniqueName: \"kubernetes.io/projected/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-kube-api-access-mjmtx\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.941858 kubelet[1876]: I0710 00:19:36.941718 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0-lib-modules\") pod \"kube-proxy-q4m6f\" (UID: \"1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0\") " pod="kube-system/kube-proxy-q4m6f" Jul 10 00:19:36.941858 kubelet[1876]: I0710 00:19:36.941733 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-run\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.941858 kubelet[1876]: I0710 00:19:36.941748 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0b02e0f8-53a2-4782-a6a9-f4bc43848ff8-cni-plugin\") pod \"kube-flannel-ds-6kbbn\" (UID: \"0b02e0f8-53a2-4782-a6a9-f4bc43848ff8\") " pod="kube-flannel/kube-flannel-ds-6kbbn" Jul 10 00:19:36.947801 systemd[1]: Created slice kubepods-burstable-pod0b02e0f8_53a2_4782_a6a9_f4bc43848ff8.slice - libcontainer container kubepods-burstable-pod0b02e0f8_53a2_4782_a6a9_f4bc43848ff8.slice. Jul 10 00:19:37.049362 sudo[1743]: pam_unix(sudo:session): session closed for user root Jul 10 00:19:37.051521 sshd[1742]: Connection closed by 10.0.0.1 port 42924 Jul 10 00:19:37.053894 sshd-session[1740]: pam_unix(sshd:session): session closed for user core Jul 10 00:19:37.059916 systemd-logind[1556]: Session 5 logged out. Waiting for processes to exit. Jul 10 00:19:37.060330 systemd[1]: sshd@4-10.0.0.73:22-10.0.0.1:42924.service: Deactivated successfully. Jul 10 00:19:37.063132 systemd[1]: session-5.scope: Deactivated successfully. Jul 10 00:19:37.063453 systemd[1]: session-5.scope: Consumed 604ms CPU time, 74.1M memory peak. Jul 10 00:19:37.067056 systemd-logind[1556]: Removed session 5. Jul 10 00:19:37.243711 containerd[1581]: time="2025-07-10T00:19:37.243649508Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-q4m6f,Uid:1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0,Namespace:kube-system,Attempt:0,}" Jul 10 00:19:37.261636 containerd[1581]: time="2025-07-10T00:19:37.261495125Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-6kbbn,Uid:0b02e0f8-53a2-4782-a6a9-f4bc43848ff8,Namespace:kube-flannel,Attempt:0,}" Jul 10 00:19:37.764187 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3068820051.mount: Deactivated successfully. Jul 10 00:19:37.777445 containerd[1581]: time="2025-07-10T00:19:37.777383289Z" 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\"}" Jul 10 00:19:37.779178 containerd[1581]: time="2025-07-10T00:19:37.779145153Z" 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\"}" Jul 10 00:19:37.780017 containerd[1581]: time="2025-07-10T00:19:37.779979658Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=321138" Jul 10 00:19:37.780948 containerd[1581]: time="2025-07-10T00:19:37.780921775Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Jul 10 00:19:37.781869 containerd[1581]: time="2025-07-10T00:19:37.781836911Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jul 10 00:19:37.784036 containerd[1581]: time="2025-07-10T00:19:37.783995460Z" 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\"}" Jul 10 00:19:37.784677 containerd[1581]: time="2025-07-10T00:19:37.784652111Z" 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 516.946579ms" Jul 10 00:19:37.786036 containerd[1581]: time="2025-07-10T00:19:37.785973279Z" 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 527.215938ms" Jul 10 00:19:37.813569 containerd[1581]: time="2025-07-10T00:19:37.813515320Z" level=info msg="connecting to shim 958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7" address="unix:///run/containerd/s/c1fd8696f63995a2e07c69e44fa86ae93715f5326e5a6fc26f0506a634e466b4" namespace=k8s.io protocol=ttrpc version=3 Jul 10 00:19:37.813781 containerd[1581]: time="2025-07-10T00:19:37.813519748Z" level=info msg="connecting to shim b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d" address="unix:///run/containerd/s/31ee4a6b6be2a0581010bcf1919ab079008489e61a46e4157f08ddb296a28c2e" namespace=k8s.io protocol=ttrpc version=3 Jul 10 00:19:37.845748 systemd[1]: Started cri-containerd-958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7.scope - libcontainer container 958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7. Jul 10 00:19:37.848070 systemd[1]: Started cri-containerd-b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d.scope - libcontainer container b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d. Jul 10 00:19:37.874327 containerd[1581]: time="2025-07-10T00:19:37.874281949Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-q4m6f,Uid:1ecccbca-bf42-47bc-a08d-1ddc64b2bbd0,Namespace:kube-system,Attempt:0,} returns sandbox id \"958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7\"" Jul 10 00:19:37.877384 containerd[1581]: time="2025-07-10T00:19:37.877343711Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.10\"" Jul 10 00:19:37.910081 containerd[1581]: time="2025-07-10T00:19:37.910037022Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-6kbbn,Uid:0b02e0f8-53a2-4782-a6a9-f4bc43848ff8,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\"" Jul 10 00:19:37.922640 kubelet[1876]: E0710 00:19:37.922585 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:38.923539 kubelet[1876]: E0710 00:19:38.923340 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:39.919926 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2239568639.mount: Deactivated successfully. Jul 10 00:19:39.926089 kubelet[1876]: E0710 00:19:39.926024 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:40.193224 containerd[1581]: time="2025-07-10T00:19:40.193038966Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:40.193807 containerd[1581]: time="2025-07-10T00:19:40.193742325Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.10: active requests=0, bytes read=30383943" Jul 10 00:19:40.194841 containerd[1581]: time="2025-07-10T00:19:40.194803796Z" level=info msg="ImageCreate event name:\"sha256:3ed600862d3e69931e0f9f4dbf5c2b46343af40aa079772434f13de771bdc30c\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:40.196713 containerd[1581]: time="2025-07-10T00:19:40.196673181Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:bcbb293812bdf587b28ea98369a8c347ca84884160046296761acdf12b27029d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:40.197137 containerd[1581]: time="2025-07-10T00:19:40.197101865Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.10\" with image id \"sha256:3ed600862d3e69931e0f9f4dbf5c2b46343af40aa079772434f13de771bdc30c\", repo tag \"registry.k8s.io/kube-proxy:v1.31.10\", repo digest \"registry.k8s.io/kube-proxy@sha256:bcbb293812bdf587b28ea98369a8c347ca84884160046296761acdf12b27029d\", size \"30382962\" in 2.319715364s" Jul 10 00:19:40.197183 containerd[1581]: time="2025-07-10T00:19:40.197139756Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.10\" returns image reference \"sha256:3ed600862d3e69931e0f9f4dbf5c2b46343af40aa079772434f13de771bdc30c\"" Jul 10 00:19:40.198449 containerd[1581]: time="2025-07-10T00:19:40.198403156Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Jul 10 00:19:40.199807 containerd[1581]: time="2025-07-10T00:19:40.199767124Z" level=info msg="CreateContainer within sandbox \"958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jul 10 00:19:40.211336 containerd[1581]: time="2025-07-10T00:19:40.211279694Z" level=info msg="Container f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:19:40.222046 containerd[1581]: time="2025-07-10T00:19:40.222001691Z" level=info msg="CreateContainer within sandbox \"958fe10ff48a952bfd6a40743a72d4ad135db60cf5d71e6221caea9a61f5b1a7\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa\"" Jul 10 00:19:40.222978 containerd[1581]: time="2025-07-10T00:19:40.222936044Z" level=info msg="StartContainer for \"f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa\"" Jul 10 00:19:40.224512 containerd[1581]: time="2025-07-10T00:19:40.224484007Z" level=info msg="connecting to shim f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa" address="unix:///run/containerd/s/c1fd8696f63995a2e07c69e44fa86ae93715f5326e5a6fc26f0506a634e466b4" protocol=ttrpc version=3 Jul 10 00:19:40.253772 systemd[1]: Started cri-containerd-f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa.scope - libcontainer container f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa. Jul 10 00:19:40.298649 containerd[1581]: time="2025-07-10T00:19:40.298583540Z" level=info msg="StartContainer for \"f9cb6911c712384c052d2b12981054dfba180ef1fb57425806d7c306863a67fa\" returns successfully" Jul 10 00:19:40.927034 kubelet[1876]: E0710 00:19:40.926996 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:41.907988 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1408246598.mount: Deactivated successfully. Jul 10 00:19:41.927558 kubelet[1876]: E0710 00:19:41.927464 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:41.945044 containerd[1581]: time="2025-07-10T00:19:41.944968830Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:41.946998 containerd[1581]: time="2025-07-10T00:19:41.946954995Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852937" Jul 10 00:19:41.949252 containerd[1581]: time="2025-07-10T00:19:41.949210585Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:41.951579 containerd[1581]: time="2025-07-10T00:19:41.951542408Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:41.952235 containerd[1581]: time="2025-07-10T00:19:41.952199119Z" 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.75375692s" Jul 10 00:19:41.952301 containerd[1581]: time="2025-07-10T00:19:41.952232923Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Jul 10 00:19:41.954244 containerd[1581]: time="2025-07-10T00:19:41.954195072Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jul 10 00:19:41.963330 containerd[1581]: time="2025-07-10T00:19:41.963268528Z" level=info msg="Container 0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:19:41.967841 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3426316979.mount: Deactivated successfully. Jul 10 00:19:41.970954 containerd[1581]: time="2025-07-10T00:19:41.970913405Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\"" Jul 10 00:19:41.971522 containerd[1581]: time="2025-07-10T00:19:41.971494816Z" level=info msg="StartContainer for \"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\"" Jul 10 00:19:41.972503 containerd[1581]: time="2025-07-10T00:19:41.972474653Z" level=info msg="connecting to shim 0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f" address="unix:///run/containerd/s/31ee4a6b6be2a0581010bcf1919ab079008489e61a46e4157f08ddb296a28c2e" protocol=ttrpc version=3 Jul 10 00:19:41.993810 systemd[1]: Started cri-containerd-0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f.scope - libcontainer container 0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f. Jul 10 00:19:42.033941 systemd[1]: cri-containerd-0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f.scope: Deactivated successfully. Jul 10 00:19:42.035931 containerd[1581]: time="2025-07-10T00:19:42.035893196Z" level=info msg="StartContainer for \"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\" returns successfully" Jul 10 00:19:42.036592 containerd[1581]: time="2025-07-10T00:19:42.036566999Z" level=info msg="received exit event container_id:\"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\" id:\"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\" pid:2208 exited_at:{seconds:1752106782 nanos:36157181}" Jul 10 00:19:42.036721 containerd[1581]: time="2025-07-10T00:19:42.036679831Z" level=info msg="TaskExit event in podsandbox handler container_id:\"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\" id:\"0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f\" pid:2208 exited_at:{seconds:1752106782 nanos:36157181}" Jul 10 00:19:42.482567 kubelet[1876]: I0710 00:19:42.482484 1876 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-q4m6f" podStartSLOduration=4.160813732 podStartE2EDuration="6.48246114s" podCreationTimestamp="2025-07-10 00:19:36 +0000 UTC" firstStartedPulling="2025-07-10 00:19:37.876487455 +0000 UTC m=+2.348060873" lastFinishedPulling="2025-07-10 00:19:40.198134853 +0000 UTC m=+4.669708281" observedRunningTime="2025-07-10 00:19:40.454091002 +0000 UTC m=+4.925664430" watchObservedRunningTime="2025-07-10 00:19:42.48246114 +0000 UTC m=+6.954034568" Jul 10 00:19:42.836869 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-0ef1db3c9afb8da977897590d72c04af194a97367c8e4bd55233d9359c02041f-rootfs.mount: Deactivated successfully. Jul 10 00:19:42.928437 kubelet[1876]: E0710 00:19:42.928354 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:43.452128 containerd[1581]: time="2025-07-10T00:19:43.452075252Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Jul 10 00:19:43.928942 kubelet[1876]: E0710 00:19:43.928766 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:44.929571 kubelet[1876]: E0710 00:19:44.929494 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:46.115946 kubelet[1876]: E0710 00:19:46.115850 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:46.133716 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2060244246.mount: Deactivated successfully. Jul 10 00:19:47.116808 kubelet[1876]: E0710 00:19:47.116691 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:47.517578 containerd[1581]: time="2025-07-10T00:19:47.517392022Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:47.518498 containerd[1581]: time="2025-07-10T00:19:47.518463432Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866358" Jul 10 00:19:47.519774 containerd[1581]: time="2025-07-10T00:19:47.519734415Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:47.522639 containerd[1581]: time="2025-07-10T00:19:47.522530709Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:19:47.523580 containerd[1581]: time="2025-07-10T00:19:47.523516408Z" 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 4.07140589s" Jul 10 00:19:47.523580 containerd[1581]: time="2025-07-10T00:19:47.523571621Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Jul 10 00:19:47.525974 containerd[1581]: time="2025-07-10T00:19:47.525925716Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jul 10 00:19:47.535706 containerd[1581]: time="2025-07-10T00:19:47.535643020Z" level=info msg="Container 0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:19:47.541560 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount83616071.mount: Deactivated successfully. Jul 10 00:19:47.545234 containerd[1581]: time="2025-07-10T00:19:47.545174444Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\"" Jul 10 00:19:47.545784 containerd[1581]: time="2025-07-10T00:19:47.545741408Z" level=info msg="StartContainer for \"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\"" Jul 10 00:19:47.547053 containerd[1581]: time="2025-07-10T00:19:47.547021899Z" level=info msg="connecting to shim 0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057" address="unix:///run/containerd/s/31ee4a6b6be2a0581010bcf1919ab079008489e61a46e4157f08ddb296a28c2e" protocol=ttrpc version=3 Jul 10 00:19:47.580982 systemd[1]: Started cri-containerd-0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057.scope - libcontainer container 0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057. Jul 10 00:19:47.625211 systemd[1]: cri-containerd-0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057.scope: Deactivated successfully. Jul 10 00:19:47.625947 containerd[1581]: time="2025-07-10T00:19:47.625872692Z" level=info msg="TaskExit event in podsandbox handler container_id:\"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\" id:\"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\" pid:2280 exited_at:{seconds:1752106787 nanos:625295450}" Jul 10 00:19:47.628334 containerd[1581]: time="2025-07-10T00:19:47.628297670Z" level=info msg="received exit event container_id:\"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\" id:\"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\" pid:2280 exited_at:{seconds:1752106787 nanos:625295450}" Jul 10 00:19:47.629748 containerd[1581]: time="2025-07-10T00:19:47.629695792Z" level=info msg="StartContainer for \"0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057\" returns successfully" Jul 10 00:19:47.658547 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-0e0e2866c4772fb931cab1b872ebd57a832f1c62d479181968a9a93e56432057-rootfs.mount: Deactivated successfully. Jul 10 00:19:47.660392 kubelet[1876]: I0710 00:19:47.660352 1876 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Jul 10 00:19:48.056359 kubelet[1876]: W0710 00:19:48.056302 1876 reflector.go:561] object-"default"/"kube-root-ca.crt": failed to list *v1.ConfigMap: configmaps "kube-root-ca.crt" is forbidden: User "system:node:10.0.0.73" cannot list resource "configmaps" in API group "" in the namespace "default": no relationship found between node '10.0.0.73' and this object Jul 10 00:19:48.056656 kubelet[1876]: E0710 00:19:48.056393 1876 reflector.go:158] "Unhandled Error" err="object-\"default\"/\"kube-root-ca.crt\": Failed to watch *v1.ConfigMap: failed to list *v1.ConfigMap: configmaps \"kube-root-ca.crt\" is forbidden: User \"system:node:10.0.0.73\" cannot list resource \"configmaps\" in API group \"\" in the namespace \"default\": no relationship found between node '10.0.0.73' and this object" logger="UnhandledError" Jul 10 00:19:48.062338 systemd[1]: Created slice kubepods-besteffort-pod183dc5dc_5d17_45c1_bc20_94a49a648bc9.slice - libcontainer container kubepods-besteffort-pod183dc5dc_5d17_45c1_bc20_94a49a648bc9.slice. Jul 10 00:19:48.117344 kubelet[1876]: E0710 00:19:48.117240 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:48.131840 kubelet[1876]: I0710 00:19:48.131755 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-l5qz8\" (UniqueName: \"kubernetes.io/projected/183dc5dc-5d17-45c1-bc20-94a49a648bc9-kube-api-access-l5qz8\") pod \"nginx-deployment-8587fbcb89-6k6mq\" (UID: \"183dc5dc-5d17-45c1-bc20-94a49a648bc9\") " pod="default/nginx-deployment-8587fbcb89-6k6mq" Jul 10 00:19:48.464005 containerd[1581]: time="2025-07-10T00:19:48.463873393Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jul 10 00:19:48.474818 containerd[1581]: time="2025-07-10T00:19:48.474756232Z" level=info msg="Container a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:19:48.483360 containerd[1581]: time="2025-07-10T00:19:48.483314041Z" level=info msg="CreateContainer within sandbox \"b2acbe738caf528c45e3ab69abaae1ecfd9a6034126bdbbc00005bf2482a016d\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6\"" Jul 10 00:19:48.483925 containerd[1581]: time="2025-07-10T00:19:48.483886925Z" level=info msg="StartContainer for \"a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6\"" Jul 10 00:19:48.484772 containerd[1581]: time="2025-07-10T00:19:48.484744874Z" level=info msg="connecting to shim a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6" address="unix:///run/containerd/s/31ee4a6b6be2a0581010bcf1919ab079008489e61a46e4157f08ddb296a28c2e" protocol=ttrpc version=3 Jul 10 00:19:48.513815 systemd[1]: Started cri-containerd-a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6.scope - libcontainer container a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6. Jul 10 00:19:48.553833 containerd[1581]: time="2025-07-10T00:19:48.553779118Z" level=info msg="StartContainer for \"a66dafd9ab31a5c797f3c7c12a4fcee7e55d2eed3ee53eb7e4ea430bae0cccb6\" returns successfully" Jul 10 00:19:49.117901 kubelet[1876]: E0710 00:19:49.117728 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:49.267435 containerd[1581]: time="2025-07-10T00:19:49.267349267Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6k6mq,Uid:183dc5dc-5d17-45c1-bc20-94a49a648bc9,Namespace:default,Attempt:0,}" Jul 10 00:19:49.406314 containerd[1581]: time="2025-07-10T00:19:49.406145720Z" level=error msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6k6mq,Uid:183dc5dc-5d17-45c1-bc20-94a49a648bc9,Namespace:default,Attempt:0,} failed, error" error="rpc error: code = Unknown desc = failed to setup network for sandbox \"2d439a444e88dfd712cb11199a8eb900fed3918d7921e16e08d4d0168b5ea54c\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jul 10 00:19:49.406849 systemd[1]: run-netns-cni\x2d22a34520\x2d3ac5\x2de368\x2d6304\x2d6ff303c8f7be.mount: Deactivated successfully. Jul 10 00:19:49.407240 kubelet[1876]: E0710 00:19:49.407026 1876 log.go:32] "RunPodSandbox from runtime service failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"2d439a444e88dfd712cb11199a8eb900fed3918d7921e16e08d4d0168b5ea54c\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Jul 10 00:19:49.407240 kubelet[1876]: E0710 00:19:49.407151 1876 kuberuntime_sandbox.go:72] "Failed to create sandbox for pod" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"2d439a444e88dfd712cb11199a8eb900fed3918d7921e16e08d4d0168b5ea54c\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-6k6mq" Jul 10 00:19:49.407240 kubelet[1876]: E0710 00:19:49.407189 1876 kuberuntime_manager.go:1170] "CreatePodSandbox for pod failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"2d439a444e88dfd712cb11199a8eb900fed3918d7921e16e08d4d0168b5ea54c\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-6k6mq" Jul 10 00:19:49.407343 kubelet[1876]: E0710 00:19:49.407257 1876 pod_workers.go:1301] "Error syncing pod, skipping" err="failed to \"CreatePodSandbox\" for \"nginx-deployment-8587fbcb89-6k6mq_default(183dc5dc-5d17-45c1-bc20-94a49a648bc9)\" with CreatePodSandboxError: \"Failed to create sandbox for pod \\\"nginx-deployment-8587fbcb89-6k6mq_default(183dc5dc-5d17-45c1-bc20-94a49a648bc9)\\\": rpc error: code = Unknown desc = failed to setup network for sandbox \\\"2d439a444e88dfd712cb11199a8eb900fed3918d7921e16e08d4d0168b5ea54c\\\": plugin type=\\\"flannel\\\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory\"" pod="default/nginx-deployment-8587fbcb89-6k6mq" podUID="183dc5dc-5d17-45c1-bc20-94a49a648bc9" Jul 10 00:19:49.477631 kubelet[1876]: I0710 00:19:49.477570 1876 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-6kbbn" podStartSLOduration=3.864279475 podStartE2EDuration="13.477551441s" podCreationTimestamp="2025-07-10 00:19:36 +0000 UTC" firstStartedPulling="2025-07-10 00:19:37.911116858 +0000 UTC m=+2.382690286" lastFinishedPulling="2025-07-10 00:19:47.524388824 +0000 UTC m=+11.995962252" observedRunningTime="2025-07-10 00:19:49.477330747 +0000 UTC m=+13.948904175" watchObservedRunningTime="2025-07-10 00:19:49.477551441 +0000 UTC m=+13.949124869" Jul 10 00:19:49.596634 systemd-networkd[1485]: flannel.1: Link UP Jul 10 00:19:49.596645 systemd-networkd[1485]: flannel.1: Gained carrier Jul 10 00:19:50.118986 kubelet[1876]: E0710 00:19:50.118883 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:51.059963 systemd-networkd[1485]: flannel.1: Gained IPv6LL Jul 10 00:19:51.119590 kubelet[1876]: E0710 00:19:51.119509 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:52.120297 kubelet[1876]: E0710 00:19:52.120150 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:53.120852 kubelet[1876]: E0710 00:19:53.120762 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:54.122046 kubelet[1876]: E0710 00:19:54.121944 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:55.123151 kubelet[1876]: E0710 00:19:55.123016 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:55.921943 kubelet[1876]: E0710 00:19:55.921871 1876 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:56.123533 kubelet[1876]: E0710 00:19:56.123451 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:57.124791 kubelet[1876]: E0710 00:19:57.124683 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:58.125492 kubelet[1876]: E0710 00:19:58.125396 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:19:59.126455 kubelet[1876]: E0710 00:19:59.126375 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:00.127472 kubelet[1876]: E0710 00:20:00.127376 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:01.128602 kubelet[1876]: E0710 00:20:01.128506 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:02.129679 kubelet[1876]: E0710 00:20:02.129559 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:02.602296 containerd[1581]: time="2025-07-10T00:20:02.602151662Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6k6mq,Uid:183dc5dc-5d17-45c1-bc20-94a49a648bc9,Namespace:default,Attempt:0,}" Jul 10 00:20:02.612781 systemd-networkd[1485]: cni0: Link UP Jul 10 00:20:02.612795 systemd-networkd[1485]: cni0: Gained carrier Jul 10 00:20:02.616878 systemd-networkd[1485]: cni0: Lost carrier Jul 10 00:20:02.621297 systemd-networkd[1485]: veth64298f31: Link UP Jul 10 00:20:02.623504 kernel: cni0: port 1(veth64298f31) entered blocking state Jul 10 00:20:02.623585 kernel: cni0: port 1(veth64298f31) entered disabled state Jul 10 00:20:02.625177 kernel: veth64298f31: entered allmulticast mode Jul 10 00:20:02.625226 kernel: veth64298f31: entered promiscuous mode Jul 10 00:20:02.632034 kernel: cni0: port 1(veth64298f31) entered blocking state Jul 10 00:20:02.632116 kernel: cni0: port 1(veth64298f31) entered forwarding state Jul 10 00:20:02.633434 systemd-networkd[1485]: veth64298f31: Gained carrier Jul 10 00:20:02.633732 systemd-networkd[1485]: cni0: Gained carrier Jul 10 00:20:02.637589 containerd[1581]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00001a938), "name":"cbr0", "type":"bridge"} Jul 10 00:20:02.637589 containerd[1581]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:02.668596 containerd[1581]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-07-10T00:20:02.668544652Z" level=info msg="connecting to shim b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e" address="unix:///run/containerd/s/b80b511f53f84652de4e5ad6664bfd74ca8385c1c9800599f93d1b36149beabb" namespace=k8s.io protocol=ttrpc version=3 Jul 10 00:20:02.698820 systemd[1]: Started cri-containerd-b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e.scope - libcontainer container b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e. Jul 10 00:20:02.712296 systemd-resolved[1405]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:02.743680 containerd[1581]: time="2025-07-10T00:20:02.743591841Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-6k6mq,Uid:183dc5dc-5d17-45c1-bc20-94a49a648bc9,Namespace:default,Attempt:0,} returns sandbox id \"b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e\"" Jul 10 00:20:02.745939 containerd[1581]: time="2025-07-10T00:20:02.745882386Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 10 00:20:03.130350 kubelet[1876]: E0710 00:20:03.130282 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:04.131117 kubelet[1876]: E0710 00:20:04.131051 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:04.372832 systemd-networkd[1485]: veth64298f31: Gained IPv6LL Jul 10 00:20:04.435817 systemd-networkd[1485]: cni0: Gained IPv6LL Jul 10 00:20:05.131588 kubelet[1876]: E0710 00:20:05.131533 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:06.132651 kubelet[1876]: E0710 00:20:06.132582 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:06.577886 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1238514926.mount: Deactivated successfully. Jul 10 00:20:07.133918 kubelet[1876]: E0710 00:20:07.133842 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:08.134515 kubelet[1876]: E0710 00:20:08.134429 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:08.659371 containerd[1581]: time="2025-07-10T00:20:08.659305400Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:08.660166 containerd[1581]: time="2025-07-10T00:20:08.660139369Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73309401" Jul 10 00:20:08.661575 containerd[1581]: time="2025-07-10T00:20:08.661500321Z" level=info msg="ImageCreate event name:\"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:08.664738 containerd[1581]: time="2025-07-10T00:20:08.664673717Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:08.665838 containerd[1581]: time="2025-07-10T00:20:08.665778180Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"73309279\" in 5.919699868s" Jul 10 00:20:08.665838 containerd[1581]: time="2025-07-10T00:20:08.665832825Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\"" Jul 10 00:20:08.668519 containerd[1581]: time="2025-07-10T00:20:08.668482312Z" level=info msg="CreateContainer within sandbox \"b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jul 10 00:20:08.677813 containerd[1581]: time="2025-07-10T00:20:08.677751961Z" level=info msg="Container 4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:20:08.684965 containerd[1581]: time="2025-07-10T00:20:08.684894106Z" level=info msg="CreateContainer within sandbox \"b485a55ff80614f36ecfd64d97364c58772880548e34692e980d29e1f9030e8e\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319\"" Jul 10 00:20:08.685596 containerd[1581]: time="2025-07-10T00:20:08.685530389Z" level=info msg="StartContainer for \"4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319\"" Jul 10 00:20:08.686467 containerd[1581]: time="2025-07-10T00:20:08.686427668Z" level=info msg="connecting to shim 4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319" address="unix:///run/containerd/s/b80b511f53f84652de4e5ad6664bfd74ca8385c1c9800599f93d1b36149beabb" protocol=ttrpc version=3 Jul 10 00:20:08.723811 systemd[1]: Started cri-containerd-4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319.scope - libcontainer container 4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319. Jul 10 00:20:08.800029 containerd[1581]: time="2025-07-10T00:20:08.799980859Z" level=info msg="StartContainer for \"4a957769a073937bc9c388102dc36231ddb8afe2c5333d15e6f010fece483319\" returns successfully" Jul 10 00:20:09.134968 kubelet[1876]: E0710 00:20:09.134747 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:09.518129 kubelet[1876]: I0710 00:20:09.517961 1876 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-6k6mq" podStartSLOduration=15.596247427 podStartE2EDuration="21.517940397s" podCreationTimestamp="2025-07-10 00:19:48 +0000 UTC" firstStartedPulling="2025-07-10 00:20:02.745017436 +0000 UTC m=+27.216590854" lastFinishedPulling="2025-07-10 00:20:08.666710396 +0000 UTC m=+33.138283824" observedRunningTime="2025-07-10 00:20:09.517172496 +0000 UTC m=+33.988745924" watchObservedRunningTime="2025-07-10 00:20:09.517940397 +0000 UTC m=+33.989513825" Jul 10 00:20:10.135660 kubelet[1876]: E0710 00:20:10.135568 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:11.136196 kubelet[1876]: E0710 00:20:11.136094 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:12.136939 kubelet[1876]: E0710 00:20:12.136852 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:13.137961 kubelet[1876]: E0710 00:20:13.137857 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:13.481842 update_engine[1568]: I20250710 00:20:13.481496 1568 update_attempter.cc:509] Updating boot flags... Jul 10 00:20:14.139040 kubelet[1876]: E0710 00:20:14.138965 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:15.139699 kubelet[1876]: E0710 00:20:15.139586 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:15.921842 kubelet[1876]: E0710 00:20:15.921756 1876 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:16.140339 kubelet[1876]: E0710 00:20:16.140263 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:17.077279 systemd[1]: Created slice kubepods-besteffort-pod7af7b674_1442_44de_b13c_dbffb64def0e.slice - libcontainer container kubepods-besteffort-pod7af7b674_1442_44de_b13c_dbffb64def0e.slice. Jul 10 00:20:17.141533 kubelet[1876]: E0710 00:20:17.141409 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:17.169967 kubelet[1876]: I0710 00:20:17.169871 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/7af7b674-1442-44de-b13c-dbffb64def0e-data\") pod \"nfs-server-provisioner-0\" (UID: \"7af7b674-1442-44de-b13c-dbffb64def0e\") " pod="default/nfs-server-provisioner-0" Jul 10 00:20:17.169967 kubelet[1876]: I0710 00:20:17.169946 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-srstv\" (UniqueName: \"kubernetes.io/projected/7af7b674-1442-44de-b13c-dbffb64def0e-kube-api-access-srstv\") pod \"nfs-server-provisioner-0\" (UID: \"7af7b674-1442-44de-b13c-dbffb64def0e\") " pod="default/nfs-server-provisioner-0" Jul 10 00:20:17.380991 containerd[1581]: time="2025-07-10T00:20:17.380827717Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7af7b674-1442-44de-b13c-dbffb64def0e,Namespace:default,Attempt:0,}" Jul 10 00:20:17.827527 systemd-networkd[1485]: vethaf1438c2: Link UP Jul 10 00:20:17.842672 kernel: cni0: port 2(vethaf1438c2) entered blocking state Jul 10 00:20:17.842801 kernel: cni0: port 2(vethaf1438c2) entered disabled state Jul 10 00:20:17.842820 kernel: vethaf1438c2: entered allmulticast mode Jul 10 00:20:17.843974 kernel: vethaf1438c2: entered promiscuous mode Jul 10 00:20:17.851052 kernel: cni0: port 2(vethaf1438c2) entered blocking state Jul 10 00:20:17.851145 kernel: cni0: port 2(vethaf1438c2) entered forwarding state Jul 10 00:20:17.851297 systemd-networkd[1485]: vethaf1438c2: Gained carrier Jul 10 00:20:17.853019 containerd[1581]: 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)(0xc00009c8e8), "name":"cbr0", "type":"bridge"} Jul 10 00:20:17.853019 containerd[1581]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:18.126274 containerd[1581]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-07-10T00:20:18.126120475Z" level=info msg="connecting to shim fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4" address="unix:///run/containerd/s/e2adf0170c55ccee4771becb6289631a3b70711d9c9a2a692d943ffc0e031088" namespace=k8s.io protocol=ttrpc version=3 Jul 10 00:20:18.142015 kubelet[1876]: E0710 00:20:18.141956 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:18.164968 systemd[1]: Started cri-containerd-fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4.scope - libcontainer container fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4. Jul 10 00:20:18.182412 systemd-resolved[1405]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:18.328122 containerd[1581]: time="2025-07-10T00:20:18.328059453Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7af7b674-1442-44de-b13c-dbffb64def0e,Namespace:default,Attempt:0,} returns sandbox id \"fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4\"" Jul 10 00:20:18.330088 containerd[1581]: time="2025-07-10T00:20:18.330036472Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jul 10 00:20:19.142332 kubelet[1876]: E0710 00:20:19.142265 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:19.284515 systemd-networkd[1485]: vethaf1438c2: Gained IPv6LL Jul 10 00:20:20.143396 kubelet[1876]: E0710 00:20:20.143291 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:21.143694 kubelet[1876]: E0710 00:20:21.143496 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:21.739759 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3344876370.mount: Deactivated successfully. Jul 10 00:20:22.144660 kubelet[1876]: E0710 00:20:22.144529 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:23.145084 kubelet[1876]: E0710 00:20:23.144982 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:24.145824 kubelet[1876]: E0710 00:20:24.145733 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:24.464982 containerd[1581]: time="2025-07-10T00:20:24.464705198Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:24.493342 containerd[1581]: time="2025-07-10T00:20:24.493257978Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Jul 10 00:20:24.567236 containerd[1581]: time="2025-07-10T00:20:24.567169230Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:24.571016 containerd[1581]: time="2025-07-10T00:20:24.570919032Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:24.571842 containerd[1581]: time="2025-07-10T00:20:24.571800003Z" 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 6.241715751s" Jul 10 00:20:24.571928 containerd[1581]: time="2025-07-10T00:20:24.571844407Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jul 10 00:20:24.575092 containerd[1581]: time="2025-07-10T00:20:24.575049892Z" level=info msg="CreateContainer within sandbox \"fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jul 10 00:20:24.589465 containerd[1581]: time="2025-07-10T00:20:24.589351104Z" level=info msg="Container afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:20:24.603399 containerd[1581]: time="2025-07-10T00:20:24.603343071Z" level=info msg="CreateContainer within sandbox \"fa795ff7415c3812789482d7dd2fd22f0d0fe2e501610a83356ee380210ed5b4\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73\"" Jul 10 00:20:24.604592 containerd[1581]: time="2025-07-10T00:20:24.604117932Z" level=info msg="StartContainer for \"afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73\"" Jul 10 00:20:24.605436 containerd[1581]: time="2025-07-10T00:20:24.605399639Z" level=info msg="connecting to shim afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73" address="unix:///run/containerd/s/e2adf0170c55ccee4771becb6289631a3b70711d9c9a2a692d943ffc0e031088" protocol=ttrpc version=3 Jul 10 00:20:24.641042 systemd[1]: Started cri-containerd-afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73.scope - libcontainer container afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73. Jul 10 00:20:24.696653 containerd[1581]: time="2025-07-10T00:20:24.696557265Z" level=info msg="StartContainer for \"afb01b7ea25bf501999d6ea9e3d6f098c9946527f113ca707318b9694a538e73\" returns successfully" Jul 10 00:20:25.146333 kubelet[1876]: E0710 00:20:25.146248 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:25.610372 kubelet[1876]: I0710 00:20:25.610249 1876 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=3.366750835 podStartE2EDuration="9.610213504s" podCreationTimestamp="2025-07-10 00:20:16 +0000 UTC" firstStartedPulling="2025-07-10 00:20:18.329589526 +0000 UTC m=+42.801162944" lastFinishedPulling="2025-07-10 00:20:24.573052185 +0000 UTC m=+49.044625613" observedRunningTime="2025-07-10 00:20:25.609742135 +0000 UTC m=+50.081315564" watchObservedRunningTime="2025-07-10 00:20:25.610213504 +0000 UTC m=+50.081786943" Jul 10 00:20:26.146875 kubelet[1876]: E0710 00:20:26.146757 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:27.147044 kubelet[1876]: E0710 00:20:27.146965 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:28.147926 kubelet[1876]: E0710 00:20:28.147807 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:29.148879 kubelet[1876]: E0710 00:20:29.148771 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:30.149731 kubelet[1876]: E0710 00:20:30.149651 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:31.150645 kubelet[1876]: E0710 00:20:31.150551 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:32.151371 kubelet[1876]: E0710 00:20:32.151288 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:33.151648 kubelet[1876]: E0710 00:20:33.151541 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:34.152370 kubelet[1876]: E0710 00:20:34.152295 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:35.152674 kubelet[1876]: E0710 00:20:35.152574 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:35.329026 systemd[1]: Created slice kubepods-besteffort-pod2d6d96b2_a3fc_4c3d_acf2_91d988f8000e.slice - libcontainer container kubepods-besteffort-pod2d6d96b2_a3fc_4c3d_acf2_91d988f8000e.slice. Jul 10 00:20:35.490670 kubelet[1876]: I0710 00:20:35.490480 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zk2d5\" (UniqueName: \"kubernetes.io/projected/2d6d96b2-a3fc-4c3d-acf2-91d988f8000e-kube-api-access-zk2d5\") pod \"test-pod-1\" (UID: \"2d6d96b2-a3fc-4c3d-acf2-91d988f8000e\") " pod="default/test-pod-1" Jul 10 00:20:35.490670 kubelet[1876]: I0710 00:20:35.490550 1876 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-e44b74d6-49ed-4284-9214-7e8c3fbe9167\" (UniqueName: \"kubernetes.io/nfs/2d6d96b2-a3fc-4c3d-acf2-91d988f8000e-pvc-e44b74d6-49ed-4284-9214-7e8c3fbe9167\") pod \"test-pod-1\" (UID: \"2d6d96b2-a3fc-4c3d-acf2-91d988f8000e\") " pod="default/test-pod-1" Jul 10 00:20:35.629689 kernel: netfs: FS-Cache loaded Jul 10 00:20:35.700080 kernel: RPC: Registered named UNIX socket transport module. Jul 10 00:20:35.700241 kernel: RPC: Registered udp transport module. Jul 10 00:20:35.700262 kernel: RPC: Registered tcp transport module. Jul 10 00:20:35.701211 kernel: RPC: Registered tcp-with-tls transport module. Jul 10 00:20:35.701256 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jul 10 00:20:35.921340 kubelet[1876]: E0710 00:20:35.921251 1876 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:35.985159 kernel: NFS: Registering the id_resolver key type Jul 10 00:20:35.985338 kernel: Key type id_resolver registered Jul 10 00:20:35.985377 kernel: Key type id_legacy registered Jul 10 00:20:36.036633 nfsidmap[3046]: 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 Jul 10 00:20:36.037280 nfsidmap[3046]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 10 00:20:36.039334 nfsidmap[3047]: 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 Jul 10 00:20:36.039559 nfsidmap[3047]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Jul 10 00:20:36.049269 nfsrahead[3049]: setting /var/lib/kubelet/pods/2d6d96b2-a3fc-4c3d-acf2-91d988f8000e/volumes/kubernetes.io~nfs/pvc-e44b74d6-49ed-4284-9214-7e8c3fbe9167 readahead to 128 Jul 10 00:20:36.153549 kubelet[1876]: E0710 00:20:36.153421 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:36.233518 containerd[1581]: time="2025-07-10T00:20:36.233282551Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:2d6d96b2-a3fc-4c3d-acf2-91d988f8000e,Namespace:default,Attempt:0,}" Jul 10 00:20:36.246811 systemd-networkd[1485]: veth55a94307: Link UP Jul 10 00:20:36.248182 kernel: cni0: port 3(veth55a94307) entered blocking state Jul 10 00:20:36.248236 kernel: cni0: port 3(veth55a94307) entered disabled state Jul 10 00:20:36.248255 kernel: veth55a94307: entered allmulticast mode Jul 10 00:20:36.249646 kernel: veth55a94307: entered promiscuous mode Jul 10 00:20:36.257835 kernel: cni0: port 3(veth55a94307) entered blocking state Jul 10 00:20:36.257938 kernel: cni0: port 3(veth55a94307) entered forwarding state Jul 10 00:20:36.258083 systemd-networkd[1485]: veth55a94307: Gained carrier Jul 10 00:20:36.261271 containerd[1581]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00001a938), "name":"cbr0", "type":"bridge"} Jul 10 00:20:36.261271 containerd[1581]: delegateAdd: netconf sent to delegate plugin: Jul 10 00:20:36.291940 containerd[1581]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-07-10T00:20:36.291867534Z" level=info msg="connecting to shim cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44" address="unix:///run/containerd/s/0aa072a77718dec836057fde6d531a12315a1ff0434d867743dc4395b59d9091" namespace=k8s.io protocol=ttrpc version=3 Jul 10 00:20:36.320814 systemd[1]: Started cri-containerd-cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44.scope - libcontainer container cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44. Jul 10 00:20:36.335520 systemd-resolved[1405]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 10 00:20:36.367148 containerd[1581]: time="2025-07-10T00:20:36.367101110Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:2d6d96b2-a3fc-4c3d-acf2-91d988f8000e,Namespace:default,Attempt:0,} returns sandbox id \"cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44\"" Jul 10 00:20:36.368718 containerd[1581]: time="2025-07-10T00:20:36.368584589Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jul 10 00:20:36.767056 containerd[1581]: time="2025-07-10T00:20:36.766957900Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jul 10 00:20:36.767821 containerd[1581]: time="2025-07-10T00:20:36.767765588Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jul 10 00:20:36.770161 containerd[1581]: time="2025-07-10T00:20:36.770102813Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:30bb68e656e0665bce700e67d2756f68bdca3345fa1099a32bfdb8febcf621cd\", size \"73309279\" in 401.484551ms" Jul 10 00:20:36.770161 containerd[1581]: time="2025-07-10T00:20:36.770137989Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:f6422896ca84c9af48d5417d6b7a573bf6b38f81edc15538907d987fc658d909\"" Jul 10 00:20:36.772542 containerd[1581]: time="2025-07-10T00:20:36.772493478Z" level=info msg="CreateContainer within sandbox \"cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jul 10 00:20:36.783699 containerd[1581]: time="2025-07-10T00:20:36.783630108Z" level=info msg="Container d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3: CDI devices from CRI Config.CDIDevices: []" Jul 10 00:20:36.788909 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3874171957.mount: Deactivated successfully. Jul 10 00:20:36.795931 containerd[1581]: time="2025-07-10T00:20:36.795871774Z" level=info msg="CreateContainer within sandbox \"cb683148f6308663cd27ce64fd38d1bfdb17809d3ea4848a3edd1d48efa71f44\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3\"" Jul 10 00:20:36.796826 containerd[1581]: time="2025-07-10T00:20:36.796758913Z" level=info msg="StartContainer for \"d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3\"" Jul 10 00:20:36.797927 containerd[1581]: time="2025-07-10T00:20:36.797877255Z" level=info msg="connecting to shim d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3" address="unix:///run/containerd/s/0aa072a77718dec836057fde6d531a12315a1ff0434d867743dc4395b59d9091" protocol=ttrpc version=3 Jul 10 00:20:36.829961 systemd[1]: Started cri-containerd-d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3.scope - libcontainer container d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3. Jul 10 00:20:36.870171 containerd[1581]: time="2025-07-10T00:20:36.870125799Z" level=info msg="StartContainer for \"d66242afe0d7e84388c0e5a5fa2bce57bb6c87ad397697a1b3d02448e632c1e3\" returns successfully" Jul 10 00:20:37.154198 kubelet[1876]: E0710 00:20:37.154099 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:37.590923 kubelet[1876]: I0710 00:20:37.590838 1876 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=20.188245025 podStartE2EDuration="20.590815028s" podCreationTimestamp="2025-07-10 00:20:17 +0000 UTC" firstStartedPulling="2025-07-10 00:20:36.368286067 +0000 UTC m=+60.839859495" lastFinishedPulling="2025-07-10 00:20:36.77085606 +0000 UTC m=+61.242429498" observedRunningTime="2025-07-10 00:20:37.590555108 +0000 UTC m=+62.062128536" watchObservedRunningTime="2025-07-10 00:20:37.590815028 +0000 UTC m=+62.062388446" Jul 10 00:20:37.971824 systemd-networkd[1485]: veth55a94307: Gained IPv6LL Jul 10 00:20:38.155134 kubelet[1876]: E0710 00:20:38.155062 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:39.155908 kubelet[1876]: E0710 00:20:39.155798 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jul 10 00:20:40.156952 kubelet[1876]: E0710 00:20:40.156878 1876 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"