Nov 1 10:10:12.324519 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT_DYNAMIC Sat Nov 1 08:12:41 -00 2025 Nov 1 10:10:12.324546 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=91cbcb3658f876d239d31cc29b206c4e950f20e536a8e14bd58a23c6f0ecf128 Nov 1 10:10:12.324558 kernel: BIOS-provided physical RAM map: Nov 1 10:10:12.324566 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Nov 1 10:10:12.324572 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Nov 1 10:10:12.324579 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Nov 1 10:10:12.324587 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdbfff] usable Nov 1 10:10:12.324594 kernel: BIOS-e820: [mem 0x000000009cfdc000-0x000000009cffffff] reserved Nov 1 10:10:12.324606 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Nov 1 10:10:12.324613 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Nov 1 10:10:12.324622 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Nov 1 10:10:12.324629 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Nov 1 10:10:12.324636 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Nov 1 10:10:12.324643 kernel: NX (Execute Disable) protection: active Nov 1 10:10:12.324652 kernel: APIC: Static calls initialized Nov 1 10:10:12.324662 kernel: SMBIOS 2.8 present. Nov 1 10:10:12.324672 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Nov 1 10:10:12.324680 kernel: DMI: Memory slots populated: 1/1 Nov 1 10:10:12.324687 kernel: Hypervisor detected: KVM Nov 1 10:10:12.324695 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Nov 1 10:10:12.324702 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Nov 1 10:10:12.324710 kernel: kvm-clock: using sched offset of 4105104812 cycles Nov 1 10:10:12.324718 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Nov 1 10:10:12.324726 kernel: tsc: Detected 2794.750 MHz processor Nov 1 10:10:12.324737 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Nov 1 10:10:12.324746 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Nov 1 10:10:12.324754 kernel: last_pfn = 0x9cfdc max_arch_pfn = 0x400000000 Nov 1 10:10:12.324762 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Nov 1 10:10:12.324771 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Nov 1 10:10:12.324779 kernel: Using GB pages for direct mapping Nov 1 10:10:12.324787 kernel: ACPI: Early table checksum verification disabled Nov 1 10:10:12.324797 kernel: ACPI: RSDP 0x00000000000F59D0 000014 (v00 BOCHS ) Nov 1 10:10:12.324806 kernel: ACPI: RSDT 0x000000009CFE241A 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324814 kernel: ACPI: FACP 0x000000009CFE21FA 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324822 kernel: ACPI: DSDT 0x000000009CFE0040 0021BA (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324830 kernel: ACPI: FACS 0x000000009CFE0000 000040 Nov 1 10:10:12.324849 kernel: ACPI: APIC 0x000000009CFE22EE 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324860 kernel: ACPI: HPET 0x000000009CFE237E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324874 kernel: ACPI: MCFG 0x000000009CFE23B6 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324885 kernel: ACPI: WAET 0x000000009CFE23F2 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 10:10:12.324899 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe21fa-0x9cfe22ed] Nov 1 10:10:12.324907 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe21f9] Nov 1 10:10:12.324915 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Nov 1 10:10:12.324926 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe22ee-0x9cfe237d] Nov 1 10:10:12.324934 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe237e-0x9cfe23b5] Nov 1 10:10:12.324942 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cfe23b6-0x9cfe23f1] Nov 1 10:10:12.324950 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe23f2-0x9cfe2419] Nov 1 10:10:12.324958 kernel: No NUMA configuration found Nov 1 10:10:12.324966 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdbfff] Nov 1 10:10:12.324975 kernel: NODE_DATA(0) allocated [mem 0x9cfd4dc0-0x9cfdbfff] Nov 1 10:10:12.324985 kernel: Zone ranges: Nov 1 10:10:12.324994 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Nov 1 10:10:12.325002 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdbfff] Nov 1 10:10:12.325010 kernel: Normal empty Nov 1 10:10:12.325018 kernel: Device empty Nov 1 10:10:12.325026 kernel: Movable zone start for each node Nov 1 10:10:12.325034 kernel: Early memory node ranges Nov 1 10:10:12.325045 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Nov 1 10:10:12.325053 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdbfff] Nov 1 10:10:12.325061 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdbfff] Nov 1 10:10:12.325069 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Nov 1 10:10:12.325081 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Nov 1 10:10:12.325089 kernel: On node 0, zone DMA32: 12324 pages in unavailable ranges Nov 1 10:10:12.325099 kernel: ACPI: PM-Timer IO Port: 0x608 Nov 1 10:10:12.325108 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Nov 1 10:10:12.325119 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Nov 1 10:10:12.325127 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Nov 1 10:10:12.325137 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Nov 1 10:10:12.325145 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Nov 1 10:10:12.325154 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Nov 1 10:10:12.325162 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Nov 1 10:10:12.325170 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Nov 1 10:10:12.325181 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Nov 1 10:10:12.325189 kernel: TSC deadline timer available Nov 1 10:10:12.325197 kernel: CPU topo: Max. logical packages: 1 Nov 1 10:10:12.325217 kernel: CPU topo: Max. logical dies: 1 Nov 1 10:10:12.325225 kernel: CPU topo: Max. dies per package: 1 Nov 1 10:10:12.325233 kernel: CPU topo: Max. threads per core: 1 Nov 1 10:10:12.325241 kernel: CPU topo: Num. cores per package: 4 Nov 1 10:10:12.325249 kernel: CPU topo: Num. threads per package: 4 Nov 1 10:10:12.325261 kernel: CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs Nov 1 10:10:12.325269 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Nov 1 10:10:12.325278 kernel: kvm-guest: KVM setup pv remote TLB flush Nov 1 10:10:12.325286 kernel: kvm-guest: setup PV sched yield Nov 1 10:10:12.325294 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Nov 1 10:10:12.325302 kernel: Booting paravirtualized kernel on KVM Nov 1 10:10:12.325311 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Nov 1 10:10:12.325322 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Nov 1 10:10:12.325330 kernel: percpu: Embedded 60 pages/cpu s207832 r8192 d29736 u524288 Nov 1 10:10:12.325338 kernel: pcpu-alloc: s207832 r8192 d29736 u524288 alloc=1*2097152 Nov 1 10:10:12.325346 kernel: pcpu-alloc: [0] 0 1 2 3 Nov 1 10:10:12.325354 kernel: kvm-guest: PV spinlocks enabled Nov 1 10:10:12.325363 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Nov 1 10:10:12.325372 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=91cbcb3658f876d239d31cc29b206c4e950f20e536a8e14bd58a23c6f0ecf128 Nov 1 10:10:12.325383 kernel: random: crng init done Nov 1 10:10:12.325392 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 1 10:10:12.325400 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 1 10:10:12.325422 kernel: Fallback order for Node 0: 0 Nov 1 10:10:12.325430 kernel: Built 1 zonelists, mobility grouping on. Total pages: 642938 Nov 1 10:10:12.325439 kernel: Policy zone: DMA32 Nov 1 10:10:12.325463 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 1 10:10:12.325475 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 1 10:10:12.325483 kernel: ftrace: allocating 40092 entries in 157 pages Nov 1 10:10:12.325492 kernel: ftrace: allocated 157 pages with 5 groups Nov 1 10:10:12.325500 kernel: Dynamic Preempt: voluntary Nov 1 10:10:12.325508 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 1 10:10:12.325518 kernel: rcu: RCU event tracing is enabled. Nov 1 10:10:12.325526 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 1 10:10:12.325537 kernel: Trampoline variant of Tasks RCU enabled. Nov 1 10:10:12.325549 kernel: Rude variant of Tasks RCU enabled. Nov 1 10:10:12.325557 kernel: Tracing variant of Tasks RCU enabled. Nov 1 10:10:12.325565 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 1 10:10:12.325574 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 1 10:10:12.325583 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 1 10:10:12.325594 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 1 10:10:12.325604 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Nov 1 10:10:12.325615 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Nov 1 10:10:12.325624 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 1 10:10:12.325639 kernel: Console: colour VGA+ 80x25 Nov 1 10:10:12.325650 kernel: printk: legacy console [ttyS0] enabled Nov 1 10:10:12.325658 kernel: ACPI: Core revision 20240827 Nov 1 10:10:12.325667 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Nov 1 10:10:12.325676 kernel: APIC: Switch to symmetric I/O mode setup Nov 1 10:10:12.325684 kernel: x2apic enabled Nov 1 10:10:12.325693 kernel: APIC: Switched APIC routing to: physical x2apic Nov 1 10:10:12.325707 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Nov 1 10:10:12.325716 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Nov 1 10:10:12.325724 kernel: kvm-guest: setup PV IPIs Nov 1 10:10:12.325733 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Nov 1 10:10:12.325744 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 1 10:10:12.325753 kernel: Calibrating delay loop (skipped) preset value.. 5589.50 BogoMIPS (lpj=2794750) Nov 1 10:10:12.325761 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Nov 1 10:10:12.325770 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Nov 1 10:10:12.325778 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Nov 1 10:10:12.325787 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Nov 1 10:10:12.325796 kernel: Spectre V2 : Mitigation: Retpolines Nov 1 10:10:12.325806 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Nov 1 10:10:12.325815 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Nov 1 10:10:12.325824 kernel: active return thunk: retbleed_return_thunk Nov 1 10:10:12.325832 kernel: RETBleed: Mitigation: untrained return thunk Nov 1 10:10:12.325851 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Nov 1 10:10:12.325863 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Nov 1 10:10:12.325874 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Nov 1 10:10:12.325889 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Nov 1 10:10:12.325900 kernel: active return thunk: srso_return_thunk Nov 1 10:10:12.325911 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Nov 1 10:10:12.325923 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Nov 1 10:10:12.325931 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Nov 1 10:10:12.325940 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Nov 1 10:10:12.325951 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Nov 1 10:10:12.325960 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Nov 1 10:10:12.325968 kernel: Freeing SMP alternatives memory: 32K Nov 1 10:10:12.325977 kernel: pid_max: default: 32768 minimum: 301 Nov 1 10:10:12.325985 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Nov 1 10:10:12.325994 kernel: landlock: Up and running. Nov 1 10:10:12.326002 kernel: SELinux: Initializing. Nov 1 10:10:12.326014 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 10:10:12.326025 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 10:10:12.326034 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Nov 1 10:10:12.326042 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Nov 1 10:10:12.326051 kernel: ... version: 0 Nov 1 10:10:12.326059 kernel: ... bit width: 48 Nov 1 10:10:12.326068 kernel: ... generic registers: 6 Nov 1 10:10:12.326077 kernel: ... value mask: 0000ffffffffffff Nov 1 10:10:12.326088 kernel: ... max period: 00007fffffffffff Nov 1 10:10:12.326096 kernel: ... fixed-purpose events: 0 Nov 1 10:10:12.326105 kernel: ... event mask: 000000000000003f Nov 1 10:10:12.326113 kernel: signal: max sigframe size: 1776 Nov 1 10:10:12.326122 kernel: rcu: Hierarchical SRCU implementation. Nov 1 10:10:12.326131 kernel: rcu: Max phase no-delay instances is 400. Nov 1 10:10:12.326139 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Nov 1 10:10:12.326150 kernel: smp: Bringing up secondary CPUs ... Nov 1 10:10:12.326158 kernel: smpboot: x86: Booting SMP configuration: Nov 1 10:10:12.326167 kernel: .... node #0, CPUs: #1 #2 #3 Nov 1 10:10:12.326175 kernel: smp: Brought up 1 node, 4 CPUs Nov 1 10:10:12.326184 kernel: smpboot: Total of 4 processors activated (22358.00 BogoMIPS) Nov 1 10:10:12.326193 kernel: Memory: 2447340K/2571752K available (14336K kernel code, 2443K rwdata, 29892K rodata, 15356K init, 2688K bss, 118472K reserved, 0K cma-reserved) Nov 1 10:10:12.326202 kernel: devtmpfs: initialized Nov 1 10:10:12.326213 kernel: x86/mm: Memory block size: 128MB Nov 1 10:10:12.326222 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 1 10:10:12.326230 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 1 10:10:12.326239 kernel: pinctrl core: initialized pinctrl subsystem Nov 1 10:10:12.326250 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 1 10:10:12.326258 kernel: audit: initializing netlink subsys (disabled) Nov 1 10:10:12.326267 kernel: audit: type=2000 audit(1761991808.485:1): state=initialized audit_enabled=0 res=1 Nov 1 10:10:12.326278 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 1 10:10:12.326286 kernel: thermal_sys: Registered thermal governor 'user_space' Nov 1 10:10:12.326295 kernel: cpuidle: using governor menu Nov 1 10:10:12.326303 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 1 10:10:12.326312 kernel: dca service started, version 1.12.1 Nov 1 10:10:12.326320 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff] Nov 1 10:10:12.326329 kernel: PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry Nov 1 10:10:12.326340 kernel: PCI: Using configuration type 1 for base access Nov 1 10:10:12.326349 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Nov 1 10:10:12.326357 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 1 10:10:12.326366 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Nov 1 10:10:12.326374 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 1 10:10:12.326382 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Nov 1 10:10:12.326391 kernel: ACPI: Added _OSI(Module Device) Nov 1 10:10:12.326402 kernel: ACPI: Added _OSI(Processor Device) Nov 1 10:10:12.326424 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 1 10:10:12.326433 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 1 10:10:12.326441 kernel: ACPI: Interpreter enabled Nov 1 10:10:12.326450 kernel: ACPI: PM: (supports S0 S3 S5) Nov 1 10:10:12.326459 kernel: ACPI: Using IOAPIC for interrupt routing Nov 1 10:10:12.326467 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Nov 1 10:10:12.326476 kernel: PCI: Using E820 reservations for host bridge windows Nov 1 10:10:12.326487 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Nov 1 10:10:12.326496 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 1 10:10:12.326752 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 1 10:10:12.326955 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Nov 1 10:10:12.327134 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Nov 1 10:10:12.327150 kernel: PCI host bridge to bus 0000:00 Nov 1 10:10:12.327339 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Nov 1 10:10:12.327520 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Nov 1 10:10:12.327682 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Nov 1 10:10:12.327851 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Nov 1 10:10:12.328023 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Nov 1 10:10:12.328187 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window] Nov 1 10:10:12.328346 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 1 10:10:12.328574 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint Nov 1 10:10:12.328764 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint Nov 1 10:10:12.328981 kernel: pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] Nov 1 10:10:12.329168 kernel: pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] Nov 1 10:10:12.329340 kernel: pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref] Nov 1 10:10:12.329530 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Nov 1 10:10:12.329796 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Nov 1 10:10:12.330002 kernel: pci 0000:00:02.0: BAR 0 [io 0xc0c0-0xc0df] Nov 1 10:10:12.330178 kernel: pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] Nov 1 10:10:12.330355 kernel: pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] Nov 1 10:10:12.330656 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint Nov 1 10:10:12.330834 kernel: pci 0000:00:03.0: BAR 0 [io 0xc000-0xc07f] Nov 1 10:10:12.331034 kernel: pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] Nov 1 10:10:12.331216 kernel: pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] Nov 1 10:10:12.331422 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint Nov 1 10:10:12.331605 kernel: pci 0000:00:04.0: BAR 0 [io 0xc0e0-0xc0ff] Nov 1 10:10:12.331777 kernel: pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] Nov 1 10:10:12.331968 kernel: pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] Nov 1 10:10:12.332148 kernel: pci 0000:00:04.0: ROM [mem 0xfeb80000-0xfebbffff pref] Nov 1 10:10:12.332350 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint Nov 1 10:10:12.332552 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Nov 1 10:10:12.332735 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint Nov 1 10:10:12.332928 kernel: pci 0000:00:1f.2: BAR 4 [io 0xc100-0xc11f] Nov 1 10:10:12.333103 kernel: pci 0000:00:1f.2: BAR 5 [mem 0xfebd4000-0xfebd4fff] Nov 1 10:10:12.333286 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint Nov 1 10:10:12.333502 kernel: pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f] Nov 1 10:10:12.333519 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Nov 1 10:10:12.333529 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Nov 1 10:10:12.333538 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Nov 1 10:10:12.333546 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Nov 1 10:10:12.333555 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Nov 1 10:10:12.333563 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Nov 1 10:10:12.333572 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Nov 1 10:10:12.333583 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Nov 1 10:10:12.333591 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Nov 1 10:10:12.333600 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Nov 1 10:10:12.333609 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Nov 1 10:10:12.333617 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Nov 1 10:10:12.333626 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Nov 1 10:10:12.333635 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Nov 1 10:10:12.333646 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Nov 1 10:10:12.333654 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Nov 1 10:10:12.333663 kernel: iommu: Default domain type: Translated Nov 1 10:10:12.333672 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Nov 1 10:10:12.333680 kernel: PCI: Using ACPI for IRQ routing Nov 1 10:10:12.333689 kernel: PCI: pci_cache_line_size set to 64 bytes Nov 1 10:10:12.333698 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Nov 1 10:10:12.333708 kernel: e820: reserve RAM buffer [mem 0x9cfdc000-0x9fffffff] Nov 1 10:10:12.333901 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Nov 1 10:10:12.334082 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Nov 1 10:10:12.334253 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Nov 1 10:10:12.334264 kernel: vgaarb: loaded Nov 1 10:10:12.334273 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Nov 1 10:10:12.334282 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Nov 1 10:10:12.334295 kernel: clocksource: Switched to clocksource kvm-clock Nov 1 10:10:12.334303 kernel: VFS: Disk quotas dquot_6.6.0 Nov 1 10:10:12.334312 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 1 10:10:12.334320 kernel: pnp: PnP ACPI init Nov 1 10:10:12.334530 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Nov 1 10:10:12.334547 kernel: pnp: PnP ACPI: found 6 devices Nov 1 10:10:12.334560 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Nov 1 10:10:12.334568 kernel: NET: Registered PF_INET protocol family Nov 1 10:10:12.334577 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 1 10:10:12.334586 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 1 10:10:12.334595 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 1 10:10:12.334604 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 1 10:10:12.334613 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 1 10:10:12.334624 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 1 10:10:12.334633 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 10:10:12.334642 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 10:10:12.334650 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 1 10:10:12.334659 kernel: NET: Registered PF_XDP protocol family Nov 1 10:10:12.334823 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Nov 1 10:10:12.335003 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Nov 1 10:10:12.335167 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Nov 1 10:10:12.335325 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Nov 1 10:10:12.335505 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Nov 1 10:10:12.335704 kernel: pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window] Nov 1 10:10:12.335716 kernel: PCI: CLS 0 bytes, default 64 Nov 1 10:10:12.335725 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2848e100549, max_idle_ns: 440795215505 ns Nov 1 10:10:12.335734 kernel: Initialise system trusted keyrings Nov 1 10:10:12.335748 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 1 10:10:12.335758 kernel: Key type asymmetric registered Nov 1 10:10:12.335767 kernel: Asymmetric key parser 'x509' registered Nov 1 10:10:12.335776 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 1 10:10:12.335785 kernel: io scheduler mq-deadline registered Nov 1 10:10:12.335794 kernel: io scheduler kyber registered Nov 1 10:10:12.335803 kernel: io scheduler bfq registered Nov 1 10:10:12.335815 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Nov 1 10:10:12.335824 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Nov 1 10:10:12.335833 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Nov 1 10:10:12.335853 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Nov 1 10:10:12.335865 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 1 10:10:12.335876 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Nov 1 10:10:12.335888 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Nov 1 10:10:12.335901 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Nov 1 10:10:12.335910 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Nov 1 10:10:12.335919 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Nov 1 10:10:12.336126 kernel: rtc_cmos 00:04: RTC can wake from S4 Nov 1 10:10:12.336307 kernel: rtc_cmos 00:04: registered as rtc0 Nov 1 10:10:12.336494 kernel: rtc_cmos 00:04: setting system clock to 2025-11-01T10:10:10 UTC (1761991810) Nov 1 10:10:12.336692 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Nov 1 10:10:12.336705 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Nov 1 10:10:12.336714 kernel: NET: Registered PF_INET6 protocol family Nov 1 10:10:12.336723 kernel: Segment Routing with IPv6 Nov 1 10:10:12.336732 kernel: In-situ OAM (IOAM) with IPv6 Nov 1 10:10:12.336740 kernel: NET: Registered PF_PACKET protocol family Nov 1 10:10:12.336749 kernel: Key type dns_resolver registered Nov 1 10:10:12.336758 kernel: IPI shorthand broadcast: enabled Nov 1 10:10:12.336771 kernel: sched_clock: Marking stable (2090003542, 204302186)->(2349041462, -54735734) Nov 1 10:10:12.336779 kernel: registered taskstats version 1 Nov 1 10:10:12.336788 kernel: Loading compiled-in X.509 certificates Nov 1 10:10:12.336797 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: d8ad6d63e9d0f6e32055e659cacaf9092255a45e' Nov 1 10:10:12.336805 kernel: Demotion targets for Node 0: null Nov 1 10:10:12.336814 kernel: Key type .fscrypt registered Nov 1 10:10:12.336822 kernel: Key type fscrypt-provisioning registered Nov 1 10:10:12.336833 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 1 10:10:12.336852 kernel: ima: Allocated hash algorithm: sha1 Nov 1 10:10:12.336863 kernel: ima: No architecture policies found Nov 1 10:10:12.336874 kernel: clk: Disabling unused clocks Nov 1 10:10:12.336886 kernel: Freeing unused kernel image (initmem) memory: 15356K Nov 1 10:10:12.336897 kernel: Write protecting the kernel read-only data: 45056k Nov 1 10:10:12.336909 kernel: Freeing unused kernel image (rodata/data gap) memory: 828K Nov 1 10:10:12.336921 kernel: Run /init as init process Nov 1 10:10:12.336929 kernel: with arguments: Nov 1 10:10:12.336938 kernel: /init Nov 1 10:10:12.336946 kernel: with environment: Nov 1 10:10:12.336955 kernel: HOME=/ Nov 1 10:10:12.336964 kernel: TERM=linux Nov 1 10:10:12.336972 kernel: SCSI subsystem initialized Nov 1 10:10:12.336983 kernel: libata version 3.00 loaded. Nov 1 10:10:12.337163 kernel: ahci 0000:00:1f.2: version 3.0 Nov 1 10:10:12.337193 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Nov 1 10:10:12.337365 kernel: ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode Nov 1 10:10:12.337563 kernel: ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f) Nov 1 10:10:12.337746 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Nov 1 10:10:12.337978 kernel: scsi host0: ahci Nov 1 10:10:12.338173 kernel: scsi host1: ahci Nov 1 10:10:12.338356 kernel: scsi host2: ahci Nov 1 10:10:12.338561 kernel: scsi host3: ahci Nov 1 10:10:12.338746 kernel: scsi host4: ahci Nov 1 10:10:12.338957 kernel: scsi host5: ahci Nov 1 10:10:12.338971 kernel: ata1: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4100 irq 26 lpm-pol 1 Nov 1 10:10:12.338980 kernel: ata2: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4180 irq 26 lpm-pol 1 Nov 1 10:10:12.338990 kernel: ata3: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4200 irq 26 lpm-pol 1 Nov 1 10:10:12.338999 kernel: ata4: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4280 irq 26 lpm-pol 1 Nov 1 10:10:12.339008 kernel: ata5: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4300 irq 26 lpm-pol 1 Nov 1 10:10:12.339017 kernel: ata6: SATA max UDMA/133 abar m4096@0xfebd4000 port 0xfebd4380 irq 26 lpm-pol 1 Nov 1 10:10:12.339029 kernel: ata6: SATA link down (SStatus 0 SControl 300) Nov 1 10:10:12.339038 kernel: ata4: SATA link down (SStatus 0 SControl 300) Nov 1 10:10:12.339047 kernel: ata5: SATA link down (SStatus 0 SControl 300) Nov 1 10:10:12.339056 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Nov 1 10:10:12.339065 kernel: ata1: SATA link down (SStatus 0 SControl 300) Nov 1 10:10:12.339074 kernel: ata2: SATA link down (SStatus 0 SControl 300) Nov 1 10:10:12.339083 kernel: ata3.00: LPM support broken, forcing max_power Nov 1 10:10:12.339094 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Nov 1 10:10:12.339103 kernel: ata3.00: applying bridge limits Nov 1 10:10:12.339112 kernel: ata3.00: LPM support broken, forcing max_power Nov 1 10:10:12.339121 kernel: ata3.00: configured for UDMA/100 Nov 1 10:10:12.339334 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Nov 1 10:10:12.339544 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Nov 1 10:10:12.339725 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Nov 1 10:10:12.339737 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 1 10:10:12.339746 kernel: GPT:16515071 != 27000831 Nov 1 10:10:12.339755 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 1 10:10:12.339764 kernel: GPT:16515071 != 27000831 Nov 1 10:10:12.339773 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 1 10:10:12.339781 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 10:10:12.339996 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Nov 1 10:10:12.340009 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Nov 1 10:10:12.340198 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Nov 1 10:10:12.340211 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 1 10:10:12.340220 kernel: device-mapper: uevent: version 1.0.3 Nov 1 10:10:12.340229 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Nov 1 10:10:12.340242 kernel: device-mapper: verity: sha256 using shash "sha256-generic" Nov 1 10:10:12.340253 kernel: raid6: avx2x4 gen() 21802 MB/s Nov 1 10:10:12.340262 kernel: raid6: avx2x2 gen() 28338 MB/s Nov 1 10:10:12.340271 kernel: raid6: avx2x1 gen() 24928 MB/s Nov 1 10:10:12.340280 kernel: raid6: using algorithm avx2x2 gen() 28338 MB/s Nov 1 10:10:12.340291 kernel: raid6: .... xor() 19095 MB/s, rmw enabled Nov 1 10:10:12.340300 kernel: raid6: using avx2x2 recovery algorithm Nov 1 10:10:12.340309 kernel: xor: automatically using best checksumming function avx Nov 1 10:10:12.340318 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 1 10:10:12.340327 kernel: BTRFS: device fsid 8763e8a0-bf7f-4ffe-acc8-da149b03dd0b devid 1 transid 35 /dev/mapper/usr (253:0) scanned by mount (180) Nov 1 10:10:12.340336 kernel: BTRFS info (device dm-0): first mount of filesystem 8763e8a0-bf7f-4ffe-acc8-da149b03dd0b Nov 1 10:10:12.340345 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Nov 1 10:10:12.340357 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 1 10:10:12.340366 kernel: BTRFS info (device dm-0): enabling free space tree Nov 1 10:10:12.340375 kernel: loop: module loaded Nov 1 10:10:12.340384 kernel: loop0: detected capacity change from 0 to 100136 Nov 1 10:10:12.340393 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 1 10:10:12.340403 systemd[1]: Successfully made /usr/ read-only. Nov 1 10:10:12.340429 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 1 10:10:12.340442 systemd[1]: Detected virtualization kvm. Nov 1 10:10:12.340452 systemd[1]: Detected architecture x86-64. Nov 1 10:10:12.340461 systemd[1]: Running in initrd. Nov 1 10:10:12.340470 systemd[1]: No hostname configured, using default hostname. Nov 1 10:10:12.340480 systemd[1]: Hostname set to . Nov 1 10:10:12.340490 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 1 10:10:12.340501 systemd[1]: Queued start job for default target initrd.target. Nov 1 10:10:12.340511 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 1 10:10:12.340521 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 1 10:10:12.340530 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 1 10:10:12.340540 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 1 10:10:12.340552 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 1 10:10:12.340565 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 1 10:10:12.340575 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 1 10:10:12.340585 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 1 10:10:12.340594 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 1 10:10:12.340604 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Nov 1 10:10:12.340613 systemd[1]: Reached target paths.target - Path Units. Nov 1 10:10:12.340625 systemd[1]: Reached target slices.target - Slice Units. Nov 1 10:10:12.340635 systemd[1]: Reached target swap.target - Swaps. Nov 1 10:10:12.340645 systemd[1]: Reached target timers.target - Timer Units. Nov 1 10:10:12.340654 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 1 10:10:12.340664 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 1 10:10:12.340673 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 1 10:10:12.340683 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Nov 1 10:10:12.340694 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 1 10:10:12.340704 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 1 10:10:12.340713 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 1 10:10:12.340723 systemd[1]: Reached target sockets.target - Socket Units. Nov 1 10:10:12.340733 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 1 10:10:12.340742 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 1 10:10:12.340754 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 1 10:10:12.340764 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 1 10:10:12.340774 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Nov 1 10:10:12.340783 systemd[1]: Starting systemd-fsck-usr.service... Nov 1 10:10:12.340793 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 1 10:10:12.340802 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 1 10:10:12.340812 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 1 10:10:12.340824 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 1 10:10:12.340834 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 1 10:10:12.340853 systemd[1]: Finished systemd-fsck-usr.service. Nov 1 10:10:12.340864 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 1 10:10:12.340900 systemd-journald[316]: Collecting audit messages is disabled. Nov 1 10:10:12.340922 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 1 10:10:12.340932 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 1 10:10:12.340944 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 1 10:10:12.340953 kernel: Bridge firewalling registered Nov 1 10:10:12.340962 systemd-journald[316]: Journal started Nov 1 10:10:12.340982 systemd-journald[316]: Runtime Journal (/run/log/journal/6904367a9d204100a15e516e463b2138) is 6M, max 48.2M, 42.2M free. Nov 1 10:10:12.336667 systemd-modules-load[317]: Inserted module 'br_netfilter' Nov 1 10:10:12.350435 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 1 10:10:12.350468 systemd[1]: Started systemd-journald.service - Journal Service. Nov 1 10:10:12.355887 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 1 10:10:12.426218 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 1 10:10:12.432135 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 1 10:10:12.437699 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 1 10:10:12.446715 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 1 10:10:12.448484 systemd-tmpfiles[338]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Nov 1 10:10:12.454556 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 1 10:10:12.463710 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 1 10:10:12.470375 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 1 10:10:12.492604 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 1 10:10:12.499151 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 1 10:10:12.532180 dracut-cmdline[360]: 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=91cbcb3658f876d239d31cc29b206c4e950f20e536a8e14bd58a23c6f0ecf128 Nov 1 10:10:12.568720 systemd-resolved[349]: Positive Trust Anchors: Nov 1 10:10:12.568739 systemd-resolved[349]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 10:10:12.568745 systemd-resolved[349]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 1 10:10:12.568793 systemd-resolved[349]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 1 10:10:12.609102 systemd-resolved[349]: Defaulting to hostname 'linux'. Nov 1 10:10:12.610492 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 1 10:10:12.611926 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 1 10:10:12.684442 kernel: Loading iSCSI transport class v2.0-870. Nov 1 10:10:12.698450 kernel: iscsi: registered transport (tcp) Nov 1 10:10:12.725115 kernel: iscsi: registered transport (qla4xxx) Nov 1 10:10:12.725161 kernel: QLogic iSCSI HBA Driver Nov 1 10:10:12.757132 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 1 10:10:12.782029 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 1 10:10:12.788549 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 1 10:10:12.859757 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 1 10:10:12.865181 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 1 10:10:12.866813 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 1 10:10:12.912008 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 1 10:10:12.917627 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 1 10:10:12.959792 systemd-udevd[602]: Using default interface naming scheme 'v257'. Nov 1 10:10:12.975043 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 1 10:10:12.977920 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 1 10:10:13.006768 dracut-pre-trigger[676]: rd.md=0: removing MD RAID activation Nov 1 10:10:13.007378 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 1 10:10:13.013203 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 1 10:10:13.048262 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 1 10:10:13.050505 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 1 10:10:13.073976 systemd-networkd[709]: lo: Link UP Nov 1 10:10:13.073984 systemd-networkd[709]: lo: Gained carrier Nov 1 10:10:13.074623 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 1 10:10:13.075427 systemd[1]: Reached target network.target - Network. Nov 1 10:10:13.146071 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 1 10:10:13.152443 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 1 10:10:13.275964 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Nov 1 10:10:13.301454 kernel: cryptd: max_cpu_qlen set to 1000 Nov 1 10:10:13.326446 kernel: AES CTR mode by8 optimization enabled Nov 1 10:10:13.332440 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Nov 1 10:10:13.347828 systemd-networkd[709]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 1 10:10:13.348982 systemd-networkd[709]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 10:10:13.349484 systemd-networkd[709]: eth0: Link UP Nov 1 10:10:13.350113 systemd-networkd[709]: eth0: Gained carrier Nov 1 10:10:13.350126 systemd-networkd[709]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 1 10:10:13.373058 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2 Nov 1 10:10:13.369527 systemd-networkd[709]: eth0: DHCPv4 address 10.0.0.124/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 1 10:10:13.370488 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 1 10:10:13.381336 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Nov 1 10:10:13.386582 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 1 10:10:13.387666 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 1 10:10:13.387837 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 1 10:10:13.392176 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 1 10:10:13.416839 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 1 10:10:13.426551 disk-uuid[836]: Primary Header is updated. Nov 1 10:10:13.426551 disk-uuid[836]: Secondary Entries is updated. Nov 1 10:10:13.426551 disk-uuid[836]: Secondary Header is updated. Nov 1 10:10:13.490097 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 1 10:10:13.547865 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 1 10:10:13.571332 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 1 10:10:13.572023 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 1 10:10:13.575790 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 1 10:10:13.582940 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 1 10:10:13.611422 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 1 10:10:14.450713 systemd-networkd[709]: eth0: Gained IPv6LL Nov 1 10:10:14.494311 disk-uuid[837]: Warning: The kernel is still using the old partition table. Nov 1 10:10:14.494311 disk-uuid[837]: The new table will be used at the next reboot or after you Nov 1 10:10:14.494311 disk-uuid[837]: run partprobe(8) or kpartx(8) Nov 1 10:10:14.494311 disk-uuid[837]: The operation has completed successfully. Nov 1 10:10:14.508894 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 1 10:10:14.509100 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 1 10:10:14.512348 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 1 10:10:14.550462 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (865) Nov 1 10:10:14.554069 kernel: BTRFS info (device vda6): first mount of filesystem 75c18d9e-3deb-43e1-a433-af20f45ab517 Nov 1 10:10:14.554106 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 1 10:10:14.558269 kernel: BTRFS info (device vda6): turning on async discard Nov 1 10:10:14.558298 kernel: BTRFS info (device vda6): enabling free space tree Nov 1 10:10:14.566430 kernel: BTRFS info (device vda6): last unmount of filesystem 75c18d9e-3deb-43e1-a433-af20f45ab517 Nov 1 10:10:14.567910 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 1 10:10:14.572799 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 1 10:10:14.915971 ignition[884]: Ignition 2.22.0 Nov 1 10:10:14.915985 ignition[884]: Stage: fetch-offline Nov 1 10:10:14.916052 ignition[884]: no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:14.916075 ignition[884]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:14.916218 ignition[884]: parsed url from cmdline: "" Nov 1 10:10:14.916222 ignition[884]: no config URL provided Nov 1 10:10:14.916231 ignition[884]: reading system config file "/usr/lib/ignition/user.ign" Nov 1 10:10:14.916243 ignition[884]: no config at "/usr/lib/ignition/user.ign" Nov 1 10:10:14.916290 ignition[884]: op(1): [started] loading QEMU firmware config module Nov 1 10:10:14.916296 ignition[884]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 1 10:10:14.928034 ignition[884]: op(1): [finished] loading QEMU firmware config module Nov 1 10:10:14.929140 ignition[884]: parsing config with SHA512: a45c7f40da643ac792f777de78348dc68e56816168ab7ff4e91ee6fad2e70feab10a2f7d81873266e25ca44b554ad6450a724f658bfcaae5abbc23ad4ad70ea3 Nov 1 10:10:14.933423 unknown[884]: fetched base config from "system" Nov 1 10:10:14.933440 unknown[884]: fetched user config from "qemu" Nov 1 10:10:14.933970 ignition[884]: fetch-offline: fetch-offline passed Nov 1 10:10:14.934070 ignition[884]: Ignition finished successfully Nov 1 10:10:14.938917 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 1 10:10:14.942666 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 1 10:10:14.995529 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 1 10:10:15.053916 ignition[895]: Ignition 2.22.0 Nov 1 10:10:15.053929 ignition[895]: Stage: kargs Nov 1 10:10:15.054103 ignition[895]: no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:15.054114 ignition[895]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:15.055660 ignition[895]: kargs: kargs passed Nov 1 10:10:15.055726 ignition[895]: Ignition finished successfully Nov 1 10:10:15.065313 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 1 10:10:15.067141 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 1 10:10:15.140500 ignition[903]: Ignition 2.22.0 Nov 1 10:10:15.140512 ignition[903]: Stage: disks Nov 1 10:10:15.140711 ignition[903]: no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:15.140722 ignition[903]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:15.141620 ignition[903]: disks: disks passed Nov 1 10:10:15.145924 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 1 10:10:15.141668 ignition[903]: Ignition finished successfully Nov 1 10:10:15.147029 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 1 10:10:15.149281 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 1 10:10:15.152832 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 1 10:10:15.156007 systemd[1]: Reached target sysinit.target - System Initialization. Nov 1 10:10:15.159015 systemd[1]: Reached target basic.target - Basic System. Nov 1 10:10:15.161578 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 1 10:10:15.207679 systemd-fsck[913]: ROOT: clean, 15/456736 files, 38230/456704 blocks Nov 1 10:10:15.302328 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 1 10:10:15.309165 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 1 10:10:15.451447 kernel: EXT4-fs (vda9): mounted filesystem 9a0b584a-8c68-48a6-a0f9-92613ad0f15d r/w with ordered data mode. Quota mode: none. Nov 1 10:10:15.451856 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 1 10:10:15.458743 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 1 10:10:15.463021 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 1 10:10:15.466192 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 1 10:10:15.467290 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 1 10:10:15.467340 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 1 10:10:15.467389 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 1 10:10:15.491937 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 1 10:10:15.495350 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 1 10:10:15.501531 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (921) Nov 1 10:10:15.504443 kernel: BTRFS info (device vda6): first mount of filesystem 75c18d9e-3deb-43e1-a433-af20f45ab517 Nov 1 10:10:15.504473 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 1 10:10:15.512449 kernel: BTRFS info (device vda6): turning on async discard Nov 1 10:10:15.512493 kernel: BTRFS info (device vda6): enabling free space tree Nov 1 10:10:15.513978 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 1 10:10:15.566683 initrd-setup-root[945]: cut: /sysroot/etc/passwd: No such file or directory Nov 1 10:10:15.571001 initrd-setup-root[952]: cut: /sysroot/etc/group: No such file or directory Nov 1 10:10:15.577172 initrd-setup-root[959]: cut: /sysroot/etc/shadow: No such file or directory Nov 1 10:10:15.582221 initrd-setup-root[966]: cut: /sysroot/etc/gshadow: No such file or directory Nov 1 10:10:15.698779 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 1 10:10:15.702518 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 1 10:10:15.704384 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 1 10:10:15.732083 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 1 10:10:15.734683 kernel: BTRFS info (device vda6): last unmount of filesystem 75c18d9e-3deb-43e1-a433-af20f45ab517 Nov 1 10:10:15.749589 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 1 10:10:15.782817 ignition[1035]: INFO : Ignition 2.22.0 Nov 1 10:10:15.782817 ignition[1035]: INFO : Stage: mount Nov 1 10:10:15.785982 ignition[1035]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:15.785982 ignition[1035]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:15.785982 ignition[1035]: INFO : mount: mount passed Nov 1 10:10:15.785982 ignition[1035]: INFO : Ignition finished successfully Nov 1 10:10:15.795681 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 1 10:10:15.797609 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 1 10:10:15.822784 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 1 10:10:15.852385 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1047) Nov 1 10:10:15.852454 kernel: BTRFS info (device vda6): first mount of filesystem 75c18d9e-3deb-43e1-a433-af20f45ab517 Nov 1 10:10:15.852467 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Nov 1 10:10:15.858953 kernel: BTRFS info (device vda6): turning on async discard Nov 1 10:10:15.858978 kernel: BTRFS info (device vda6): enabling free space tree Nov 1 10:10:15.861269 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 1 10:10:15.927250 ignition[1064]: INFO : Ignition 2.22.0 Nov 1 10:10:15.927250 ignition[1064]: INFO : Stage: files Nov 1 10:10:15.930683 ignition[1064]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:15.930683 ignition[1064]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:15.930683 ignition[1064]: DEBUG : files: compiled without relabeling support, skipping Nov 1 10:10:15.936820 ignition[1064]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 1 10:10:15.936820 ignition[1064]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 1 10:10:15.943138 ignition[1064]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 1 10:10:15.945853 ignition[1064]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 1 10:10:15.948937 ignition[1064]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 1 10:10:15.946476 unknown[1064]: wrote ssh authorized keys file for user: core Nov 1 10:10:15.954144 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Nov 1 10:10:15.954144 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 1 10:10:15.962067 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-x86-64.raw: attempt #1 Nov 1 10:10:16.248054 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Nov 1 10:10:17.129369 ignition[1064]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-x86-64.raw" Nov 1 10:10:17.129369 ignition[1064]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Nov 1 10:10:17.136759 ignition[1064]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 1 10:10:17.136759 ignition[1064]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 1 10:10:17.136759 ignition[1064]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Nov 1 10:10:17.136759 ignition[1064]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Nov 1 10:10:17.174869 ignition[1064]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 1 10:10:17.180641 ignition[1064]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 1 10:10:17.183609 ignition[1064]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Nov 1 10:10:17.186326 ignition[1064]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 1 10:10:17.189284 ignition[1064]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 1 10:10:17.189284 ignition[1064]: INFO : files: files passed Nov 1 10:10:17.189284 ignition[1064]: INFO : Ignition finished successfully Nov 1 10:10:17.193401 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 1 10:10:17.196703 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 1 10:10:17.198779 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 1 10:10:17.221657 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 1 10:10:17.221856 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 1 10:10:17.231317 initrd-setup-root-after-ignition[1095]: grep: /sysroot/oem/oem-release: No such file or directory Nov 1 10:10:17.236772 initrd-setup-root-after-ignition[1097]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 1 10:10:17.239557 initrd-setup-root-after-ignition[1097]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 1 10:10:17.242227 initrd-setup-root-after-ignition[1101]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 1 10:10:17.247049 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 1 10:10:17.251479 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 1 10:10:17.253055 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 1 10:10:17.315910 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 1 10:10:17.316098 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 1 10:10:17.317598 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 1 10:10:17.323367 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 1 10:10:17.327252 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 1 10:10:17.328537 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 1 10:10:17.371358 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 1 10:10:17.374760 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 1 10:10:17.404791 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Nov 1 10:10:17.405109 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 1 10:10:17.408892 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 1 10:10:17.410433 systemd[1]: Stopped target timers.target - Timer Units. Nov 1 10:10:17.415944 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 1 10:10:17.416118 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 1 10:10:17.422754 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 1 10:10:17.426197 systemd[1]: Stopped target basic.target - Basic System. Nov 1 10:10:17.427022 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 1 10:10:17.429965 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 1 10:10:17.430853 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 1 10:10:17.437256 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Nov 1 10:10:17.443995 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 1 10:10:17.445096 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 1 10:10:17.448122 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 1 10:10:17.451900 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 1 10:10:17.452434 systemd[1]: Stopped target swap.target - Swaps. Nov 1 10:10:17.459688 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 1 10:10:17.459871 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 1 10:10:17.464582 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 1 10:10:17.465377 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 1 10:10:17.465893 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 1 10:10:17.473379 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 1 10:10:17.478158 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 1 10:10:17.478351 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 1 10:10:17.484143 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 1 10:10:17.484338 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 1 10:10:17.485367 systemd[1]: Stopped target paths.target - Path Units. Nov 1 10:10:17.490213 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 1 10:10:17.494159 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 1 10:10:17.494921 systemd[1]: Stopped target slices.target - Slice Units. Nov 1 10:10:17.495468 systemd[1]: Stopped target sockets.target - Socket Units. Nov 1 10:10:17.502038 systemd[1]: iscsid.socket: Deactivated successfully. Nov 1 10:10:17.502172 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 1 10:10:17.504925 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 1 10:10:17.505018 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 1 10:10:17.508053 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 1 10:10:17.508226 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 1 10:10:17.514875 systemd[1]: ignition-files.service: Deactivated successfully. Nov 1 10:10:17.515029 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 1 10:10:17.521927 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 1 10:10:17.526071 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 1 10:10:17.528096 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 1 10:10:17.528376 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 1 10:10:17.531468 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 1 10:10:17.531672 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 1 10:10:17.532164 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 1 10:10:17.532294 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 1 10:10:17.548386 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 1 10:10:17.548545 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 1 10:10:17.578473 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 1 10:10:17.595607 ignition[1122]: INFO : Ignition 2.22.0 Nov 1 10:10:17.595607 ignition[1122]: INFO : Stage: umount Nov 1 10:10:17.598876 ignition[1122]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 10:10:17.598876 ignition[1122]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 10:10:17.598876 ignition[1122]: INFO : umount: umount passed Nov 1 10:10:17.598876 ignition[1122]: INFO : Ignition finished successfully Nov 1 10:10:17.604242 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 1 10:10:17.604394 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 1 10:10:17.604997 systemd[1]: Stopped target network.target - Network. Nov 1 10:10:17.607438 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 1 10:10:17.607505 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 1 10:10:17.610320 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 1 10:10:17.610391 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 1 10:10:17.613349 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 1 10:10:17.613440 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 1 10:10:17.616204 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 1 10:10:17.616267 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 1 10:10:17.619404 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 1 10:10:17.622788 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 1 10:10:17.639563 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 1 10:10:17.639744 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 1 10:10:17.646109 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 1 10:10:17.646262 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 1 10:10:17.649279 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 1 10:10:17.649379 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 1 10:10:17.659041 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 1 10:10:17.659245 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 1 10:10:17.666944 systemd[1]: Stopped target network-pre.target - Preparation for Network. Nov 1 10:10:17.668056 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 1 10:10:17.668149 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 1 10:10:17.674444 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 1 10:10:17.675317 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 1 10:10:17.675383 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 1 10:10:17.676205 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 1 10:10:17.676311 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 1 10:10:17.683430 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 1 10:10:17.683544 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 1 10:10:17.684343 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 1 10:10:17.715953 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 1 10:10:17.716197 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 1 10:10:17.722903 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 1 10:10:17.723083 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 1 10:10:17.724277 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 1 10:10:17.724368 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 1 10:10:17.725204 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 1 10:10:17.725338 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 1 10:10:17.726988 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 1 10:10:17.727056 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 1 10:10:17.739811 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 1 10:10:17.739873 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 1 10:10:17.753197 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 1 10:10:17.753872 systemd[1]: systemd-network-generator.service: Deactivated successfully. Nov 1 10:10:17.753954 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Nov 1 10:10:17.754819 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 1 10:10:17.754884 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 1 10:10:17.761400 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 1 10:10:17.761511 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 1 10:10:17.775275 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 1 10:10:17.775341 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 1 10:10:17.776288 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 1 10:10:17.776340 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 1 10:10:17.785040 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 1 10:10:17.785162 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 1 10:10:17.787146 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 1 10:10:17.787253 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 1 10:10:17.792670 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 1 10:10:17.794166 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 1 10:10:17.816652 systemd[1]: Switching root. Nov 1 10:10:17.862560 systemd-journald[316]: Journal stopped Nov 1 10:10:19.589600 systemd-journald[316]: Received SIGTERM from PID 1 (systemd). Nov 1 10:10:19.589707 kernel: SELinux: policy capability network_peer_controls=1 Nov 1 10:10:19.589728 kernel: SELinux: policy capability open_perms=1 Nov 1 10:10:19.589745 kernel: SELinux: policy capability extended_socket_class=1 Nov 1 10:10:19.589766 kernel: SELinux: policy capability always_check_network=0 Nov 1 10:10:19.589791 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 1 10:10:19.589816 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 1 10:10:19.589836 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 1 10:10:19.589856 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 1 10:10:19.589873 kernel: SELinux: policy capability userspace_initial_context=0 Nov 1 10:10:19.589891 kernel: audit: type=1403 audit(1761991818.603:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 1 10:10:19.589910 systemd[1]: Successfully loaded SELinux policy in 72.502ms. Nov 1 10:10:19.589936 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 10.457ms. Nov 1 10:10:19.589967 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +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 -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Nov 1 10:10:19.589986 systemd[1]: Detected virtualization kvm. Nov 1 10:10:19.590004 systemd[1]: Detected architecture x86-64. Nov 1 10:10:19.590021 systemd[1]: Detected first boot. Nov 1 10:10:19.590039 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Nov 1 10:10:19.590057 zram_generator::config[1168]: No configuration found. Nov 1 10:10:19.590080 kernel: Guest personality initialized and is inactive Nov 1 10:10:19.590097 kernel: VMCI host device registered (name=vmci, major=10, minor=125) Nov 1 10:10:19.590114 kernel: Initialized host personality Nov 1 10:10:19.590130 kernel: NET: Registered PF_VSOCK protocol family Nov 1 10:10:19.590147 systemd[1]: Populated /etc with preset unit settings. Nov 1 10:10:19.590164 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 1 10:10:19.590182 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 1 10:10:19.590204 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 1 10:10:19.590223 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 1 10:10:19.590242 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 1 10:10:19.590259 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 1 10:10:19.590278 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 1 10:10:19.590300 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 1 10:10:19.590322 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 1 10:10:19.590342 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 1 10:10:19.590367 systemd[1]: Created slice user.slice - User and Session Slice. Nov 1 10:10:19.590386 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 1 10:10:19.590404 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 1 10:10:19.590442 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 1 10:10:19.590467 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 1 10:10:19.590486 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 1 10:10:19.590504 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 1 10:10:19.590522 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 1 10:10:19.590540 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 1 10:10:19.590558 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 1 10:10:19.590579 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 1 10:10:19.590597 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 1 10:10:19.590615 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 1 10:10:19.590633 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 1 10:10:19.590651 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 1 10:10:19.590680 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 1 10:10:19.590706 systemd[1]: Reached target slices.target - Slice Units. Nov 1 10:10:19.590728 systemd[1]: Reached target swap.target - Swaps. Nov 1 10:10:19.590747 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 1 10:10:19.590765 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 1 10:10:19.590782 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Nov 1 10:10:19.590809 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 1 10:10:19.590827 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 1 10:10:19.590845 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 1 10:10:19.590867 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 1 10:10:19.590885 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 1 10:10:19.590902 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 1 10:10:19.590920 systemd[1]: Mounting media.mount - External Media Directory... Nov 1 10:10:19.590938 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:19.590956 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 1 10:10:19.590973 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 1 10:10:19.590999 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 1 10:10:19.591018 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 1 10:10:19.591037 systemd[1]: Reached target machines.target - Containers. Nov 1 10:10:19.591054 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 1 10:10:19.591073 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 1 10:10:19.591090 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 1 10:10:19.591108 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 1 10:10:19.591130 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 1 10:10:19.591148 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 1 10:10:19.591166 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 1 10:10:19.591183 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 1 10:10:19.591208 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 1 10:10:19.591227 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 1 10:10:19.591249 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 1 10:10:19.591266 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 1 10:10:19.591284 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 1 10:10:19.591303 systemd[1]: Stopped systemd-fsck-usr.service. Nov 1 10:10:19.591321 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 1 10:10:19.591339 kernel: ACPI: bus type drm_connector registered Nov 1 10:10:19.591356 kernel: fuse: init (API version 7.41) Nov 1 10:10:19.591376 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 1 10:10:19.591394 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 1 10:10:19.591539 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 1 10:10:19.591565 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 1 10:10:19.591589 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Nov 1 10:10:19.591607 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 1 10:10:19.591650 systemd-journald[1253]: Collecting audit messages is disabled. Nov 1 10:10:19.591692 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:19.591712 systemd-journald[1253]: Journal started Nov 1 10:10:19.591746 systemd-journald[1253]: Runtime Journal (/run/log/journal/6904367a9d204100a15e516e463b2138) is 6M, max 48.2M, 42.2M free. Nov 1 10:10:19.243484 systemd[1]: Queued start job for default target multi-user.target. Nov 1 10:10:19.256715 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Nov 1 10:10:19.257309 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 1 10:10:19.596454 systemd[1]: Started systemd-journald.service - Journal Service. Nov 1 10:10:19.599090 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 1 10:10:19.601164 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 1 10:10:19.603162 systemd[1]: Mounted media.mount - External Media Directory. Nov 1 10:10:19.605169 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 1 10:10:19.607434 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 1 10:10:19.609470 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 1 10:10:19.611532 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 1 10:10:19.613886 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 1 10:10:19.616233 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 1 10:10:19.616712 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 1 10:10:19.619041 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 10:10:19.619318 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 1 10:10:19.621609 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 10:10:19.621903 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 1 10:10:19.624013 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 10:10:19.624299 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 1 10:10:19.626782 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 1 10:10:19.627049 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 1 10:10:19.629161 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 10:10:19.629458 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 1 10:10:19.631705 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 1 10:10:19.634055 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 1 10:10:19.637393 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 1 10:10:19.639915 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Nov 1 10:10:19.657575 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 1 10:10:19.660209 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Nov 1 10:10:19.663927 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 1 10:10:19.667155 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 1 10:10:19.669217 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 1 10:10:19.669345 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 1 10:10:19.672657 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Nov 1 10:10:19.675630 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 1 10:10:19.687714 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 1 10:10:19.691630 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 1 10:10:19.694152 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 10:10:19.697565 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 1 10:10:19.699570 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 1 10:10:19.704511 systemd-journald[1253]: Time spent on flushing to /var/log/journal/6904367a9d204100a15e516e463b2138 is 23.691ms for 947 entries. Nov 1 10:10:19.704511 systemd-journald[1253]: System Journal (/var/log/journal/6904367a9d204100a15e516e463b2138) is 8M, max 163.5M, 155.5M free. Nov 1 10:10:19.745066 systemd-journald[1253]: Received client request to flush runtime journal. Nov 1 10:10:19.745146 kernel: loop1: detected capacity change from 0 to 111544 Nov 1 10:10:19.703584 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 1 10:10:19.709339 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 1 10:10:19.714558 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 1 10:10:19.722353 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 1 10:10:19.729160 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 1 10:10:19.731793 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 1 10:10:19.736075 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 1 10:10:19.742666 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 1 10:10:19.748372 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Nov 1 10:10:19.751699 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 1 10:10:19.754792 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 1 10:10:19.759735 systemd-tmpfiles[1289]: ACLs are not supported, ignoring. Nov 1 10:10:19.759759 systemd-tmpfiles[1289]: ACLs are not supported, ignoring. Nov 1 10:10:19.770088 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 1 10:10:19.774900 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 1 10:10:19.789442 kernel: loop2: detected capacity change from 0 to 224512 Nov 1 10:10:19.817462 kernel: loop3: detected capacity change from 0 to 119080 Nov 1 10:10:19.858444 kernel: loop4: detected capacity change from 0 to 111544 Nov 1 10:10:19.868439 kernel: loop5: detected capacity change from 0 to 224512 Nov 1 10:10:19.876447 kernel: loop6: detected capacity change from 0 to 119080 Nov 1 10:10:19.947845 (sd-merge)[1307]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'kubernetes.raw'. Nov 1 10:10:19.948484 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 1 10:10:19.953689 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 1 10:10:19.957607 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 1 10:10:19.960583 (sd-merge)[1307]: Merged extensions into '/usr'. Nov 1 10:10:19.965886 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 1 10:10:19.970797 systemd[1]: Reload requested from client PID 1287 ('systemd-sysext') (unit systemd-sysext.service)... Nov 1 10:10:19.970813 systemd[1]: Reloading... Nov 1 10:10:20.014120 systemd-tmpfiles[1310]: ACLs are not supported, ignoring. Nov 1 10:10:20.014530 systemd-tmpfiles[1310]: ACLs are not supported, ignoring. Nov 1 10:10:20.074482 zram_generator::config[1338]: No configuration found. Nov 1 10:10:20.176626 systemd-resolved[1309]: Positive Trust Anchors: Nov 1 10:10:20.176991 systemd-resolved[1309]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 10:10:20.176999 systemd-resolved[1309]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Nov 1 10:10:20.177031 systemd-resolved[1309]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Nov 1 10:10:20.181126 systemd-resolved[1309]: Defaulting to hostname 'linux'. Nov 1 10:10:20.271092 systemd[1]: Reloading finished in 299 ms. Nov 1 10:10:20.515799 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 1 10:10:20.532779 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 1 10:10:20.535158 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 1 10:10:20.537717 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 1 10:10:20.540597 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Nov 1 10:10:20.543494 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 1 10:10:20.551247 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 1 10:10:20.555074 systemd[1]: Starting ensure-sysext.service... Nov 1 10:10:20.557573 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 1 10:10:20.588662 systemd[1]: Reload requested from client PID 1383 ('systemctl') (unit ensure-sysext.service)... Nov 1 10:10:20.588790 systemd[1]: Reloading... Nov 1 10:10:20.595313 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Nov 1 10:10:20.595354 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Nov 1 10:10:20.595649 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 1 10:10:20.595886 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 1 10:10:20.597405 systemd-tmpfiles[1384]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 1 10:10:20.597770 systemd-tmpfiles[1384]: ACLs are not supported, ignoring. Nov 1 10:10:20.597900 systemd-tmpfiles[1384]: ACLs are not supported, ignoring. Nov 1 10:10:20.604287 systemd-tmpfiles[1384]: Detected autofs mount point /boot during canonicalization of boot. Nov 1 10:10:20.604301 systemd-tmpfiles[1384]: Skipping /boot Nov 1 10:10:20.615524 systemd-tmpfiles[1384]: Detected autofs mount point /boot during canonicalization of boot. Nov 1 10:10:20.615537 systemd-tmpfiles[1384]: Skipping /boot Nov 1 10:10:20.659705 zram_generator::config[1415]: No configuration found. Nov 1 10:10:20.873855 systemd[1]: Reloading finished in 284 ms. Nov 1 10:10:20.886676 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 1 10:10:20.889605 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 1 10:10:20.918696 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 1 10:10:20.922008 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 1 10:10:20.937400 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 1 10:10:20.941465 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 1 10:10:20.946696 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 1 10:10:20.950394 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 1 10:10:20.957069 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:20.957458 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 1 10:10:20.966321 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 1 10:10:20.970854 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 1 10:10:20.986081 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 1 10:10:20.988187 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 1 10:10:20.988366 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 1 10:10:20.988563 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:20.992533 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 1 10:10:20.999012 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 10:10:20.999381 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 1 10:10:21.002463 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 10:10:21.002740 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 1 10:10:21.014318 systemd-udevd[1458]: Using default interface naming scheme 'v257'. Nov 1 10:10:21.015481 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 1 10:10:21.022798 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:21.023161 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 1 10:10:21.026669 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 1 10:10:21.030981 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 1 10:10:21.033685 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 1 10:10:21.033816 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 1 10:10:21.033934 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:21.034889 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 10:10:21.040635 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 1 10:10:21.044490 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 10:10:21.044879 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 1 10:10:21.049537 augenrules[1488]: No rules Nov 1 10:10:21.051098 systemd[1]: audit-rules.service: Deactivated successfully. Nov 1 10:10:21.051506 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 1 10:10:21.053992 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 10:10:21.054289 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 1 10:10:21.060931 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 1 10:10:21.074901 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:21.077727 systemd[1]: Starting audit-rules.service - Load Audit Rules... Nov 1 10:10:21.079709 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 1 10:10:21.080937 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 1 10:10:21.084767 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 1 10:10:21.088607 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 1 10:10:21.093690 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 1 10:10:21.095864 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 1 10:10:21.095917 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Nov 1 10:10:21.236082 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 1 10:10:21.238189 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Nov 1 10:10:21.240329 systemd[1]: Finished ensure-sysext.service. Nov 1 10:10:21.243634 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 1 10:10:21.256302 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 10:10:21.258664 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 1 10:10:21.264012 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 10:10:21.264444 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 1 10:10:21.276810 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Nov 1 10:10:21.284673 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 10:10:21.285169 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 10:10:21.285503 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 1 10:10:21.293825 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 10:10:21.294093 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 1 10:10:21.298771 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 10:10:21.298856 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 1 10:10:21.303551 augenrules[1506]: /sbin/augenrules: No change Nov 1 10:10:21.305106 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 1 10:10:21.326635 augenrules[1549]: No rules Nov 1 10:10:21.329232 systemd[1]: audit-rules.service: Deactivated successfully. Nov 1 10:10:21.334689 systemd[1]: Finished audit-rules.service - Load Audit Rules. Nov 1 10:10:21.425514 systemd-networkd[1515]: lo: Link UP Nov 1 10:10:21.425530 systemd-networkd[1515]: lo: Gained carrier Nov 1 10:10:21.425594 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Nov 1 10:10:21.433446 kernel: mousedev: PS/2 mouse device common for all mice Nov 1 10:10:21.433512 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Nov 1 10:10:21.432384 systemd-networkd[1515]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 1 10:10:21.432396 systemd-networkd[1515]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 10:10:21.433051 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 1 10:10:21.435568 systemd[1]: Reached target network.target - Network. Nov 1 10:10:21.449953 kernel: ACPI: button: Power Button [PWRF] Nov 1 10:10:21.452008 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 1 10:10:21.452012 systemd-networkd[1515]: eth0: Link UP Nov 1 10:10:21.453120 systemd-networkd[1515]: eth0: Gained carrier Nov 1 10:10:21.453203 systemd-networkd[1515]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Nov 1 10:10:21.460561 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Nov 1 10:10:21.464551 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 1 10:10:21.469476 systemd-networkd[1515]: eth0: DHCPv4 address 10.0.0.124/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 1 10:10:21.471270 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Nov 1 10:10:21.472498 systemd[1]: Reached target time-set.target - System Time Set. Nov 1 10:10:21.475541 systemd-timesyncd[1532]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 1 10:10:21.475628 systemd-timesyncd[1532]: Initial clock synchronization to Sat 2025-11-01 10:10:21.663181 UTC. Nov 1 10:10:21.482523 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 1 10:10:21.514316 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Nov 1 10:10:21.523367 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Nov 1 10:10:21.523753 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Nov 1 10:10:21.577358 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 1 10:10:21.741101 kernel: kvm_amd: TSC scaling supported Nov 1 10:10:21.741172 kernel: kvm_amd: Nested Virtualization enabled Nov 1 10:10:21.741212 kernel: kvm_amd: Nested Paging enabled Nov 1 10:10:21.742317 kernel: kvm_amd: LBR virtualization supported Nov 1 10:10:21.743697 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Nov 1 10:10:21.743779 kernel: kvm_amd: Virtual GIF supported Nov 1 10:10:21.782480 kernel: EDAC MC: Ver: 3.0.0 Nov 1 10:10:21.809198 ldconfig[1456]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 1 10:10:21.815727 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 1 10:10:21.819642 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 1 10:10:21.897924 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 1 10:10:21.909963 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 1 10:10:21.912201 systemd[1]: Reached target sysinit.target - System Initialization. Nov 1 10:10:21.914185 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 1 10:10:21.916364 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 1 10:10:21.918536 systemd[1]: Started google-oslogin-cache.timer - NSS cache refresh timer. Nov 1 10:10:21.920804 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 1 10:10:21.922777 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 1 10:10:21.924965 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 1 10:10:21.927140 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 1 10:10:21.927183 systemd[1]: Reached target paths.target - Path Units. Nov 1 10:10:21.929316 systemd[1]: Reached target timers.target - Timer Units. Nov 1 10:10:21.932114 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 1 10:10:21.935893 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 1 10:10:21.940141 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Nov 1 10:10:21.942440 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Nov 1 10:10:21.944697 systemd[1]: Reached target ssh-access.target - SSH Access Available. Nov 1 10:10:21.951755 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 1 10:10:21.953889 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Nov 1 10:10:21.956803 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 1 10:10:21.959621 systemd[1]: Reached target sockets.target - Socket Units. Nov 1 10:10:21.961199 systemd[1]: Reached target basic.target - Basic System. Nov 1 10:10:21.962765 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 1 10:10:21.962800 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 1 10:10:21.964241 systemd[1]: Starting containerd.service - containerd container runtime... Nov 1 10:10:21.967137 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 1 10:10:21.969748 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 1 10:10:21.972918 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 1 10:10:21.976707 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 1 10:10:21.979504 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Nov 1 10:10:21.981315 systemd[1]: Starting google-oslogin-cache.service - NSS cache refresh... Nov 1 10:10:21.986591 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 1 10:10:21.987895 jq[1602]: false Nov 1 10:10:21.989551 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 1 10:10:21.992506 extend-filesystems[1603]: Found /dev/vda6 Nov 1 10:10:21.993468 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 1 10:10:21.999691 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Refreshing passwd entry cache Nov 1 10:10:21.998557 oslogin_cache_refresh[1604]: Refreshing passwd entry cache Nov 1 10:10:22.001003 extend-filesystems[1603]: Found /dev/vda9 Nov 1 10:10:22.006485 extend-filesystems[1603]: Checking size of /dev/vda9 Nov 1 10:10:22.008639 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 1 10:10:22.010548 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 1 10:10:22.011062 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 1 10:10:22.012427 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Failure getting users, quitting Nov 1 10:10:22.012427 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 1 10:10:22.012427 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Refreshing group entry cache Nov 1 10:10:22.011792 systemd[1]: Starting update-engine.service - Update Engine... Nov 1 10:10:22.011717 oslogin_cache_refresh[1604]: Failure getting users, quitting Nov 1 10:10:22.011745 oslogin_cache_refresh[1604]: Produced empty passwd cache file, removing /etc/oslogin_passwd.cache.bak. Nov 1 10:10:22.011812 oslogin_cache_refresh[1604]: Refreshing group entry cache Nov 1 10:10:22.014632 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 1 10:10:22.024826 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 1 10:10:22.026516 extend-filesystems[1603]: Resized partition /dev/vda9 Nov 1 10:10:22.029662 extend-filesystems[1630]: resize2fs 1.47.3 (8-Jul-2025) Nov 1 10:10:22.029470 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 1 10:10:22.031546 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 1 10:10:22.032045 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 1 10:10:22.032393 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 1 10:10:22.036463 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Nov 1 10:10:22.037119 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Failure getting groups, quitting Nov 1 10:10:22.037119 google_oslogin_nss_cache[1604]: oslogin_cache_refresh[1604]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 1 10:10:22.036968 oslogin_cache_refresh[1604]: Failure getting groups, quitting Nov 1 10:10:22.036988 oslogin_cache_refresh[1604]: Produced empty group cache file, removing /etc/oslogin_group.cache.bak. Nov 1 10:10:22.039129 systemd[1]: motdgen.service: Deactivated successfully. Nov 1 10:10:22.039534 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 1 10:10:22.042740 jq[1621]: true Nov 1 10:10:22.046174 systemd[1]: google-oslogin-cache.service: Deactivated successfully. Nov 1 10:10:22.046575 systemd[1]: Finished google-oslogin-cache.service - NSS cache refresh. Nov 1 10:10:22.059449 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Nov 1 10:10:22.087582 update_engine[1620]: I20251101 10:10:22.072575 1620 main.cc:92] Flatcar Update Engine starting Nov 1 10:10:22.088328 jq[1635]: true Nov 1 10:10:22.095033 extend-filesystems[1630]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 1 10:10:22.095033 extend-filesystems[1630]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 1 10:10:22.095033 extend-filesystems[1630]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Nov 1 10:10:22.106699 extend-filesystems[1603]: Resized filesystem in /dev/vda9 Nov 1 10:10:22.097000 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 1 10:10:22.097306 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 1 10:10:22.151549 dbus-daemon[1600]: [system] SELinux support is enabled Nov 1 10:10:22.152116 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 1 10:10:22.155583 sshd_keygen[1619]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 1 10:10:22.157840 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Nov 1 10:10:22.157876 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 1 10:10:22.161406 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 1 10:10:22.161454 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 1 10:10:22.163948 update_engine[1620]: I20251101 10:10:22.163885 1620 update_check_scheduler.cc:74] Next update check in 7m20s Nov 1 10:10:22.164097 systemd[1]: Started update-engine.service - Update Engine. Nov 1 10:10:22.167409 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 1 10:10:22.182525 bash[1665]: Updated "/home/core/.ssh/authorized_keys" Nov 1 10:10:22.246145 systemd-logind[1613]: Watching system buttons on /dev/input/event2 (Power Button) Nov 1 10:10:22.246178 systemd-logind[1613]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Nov 1 10:10:22.246492 systemd-logind[1613]: New seat seat0. Nov 1 10:10:22.250923 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 1 10:10:22.256842 systemd[1]: Started systemd-logind.service - User Login Management. Nov 1 10:10:22.259069 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 1 10:10:22.266515 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 1 10:10:22.270119 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Nov 1 10:10:22.293877 systemd[1]: issuegen.service: Deactivated successfully. Nov 1 10:10:22.294282 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 1 10:10:22.298755 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 1 10:10:22.303135 locksmithd[1671]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 1 10:10:22.327975 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 1 10:10:22.331933 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 1 10:10:22.335012 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 1 10:10:22.336093 systemd[1]: Reached target getty.target - Login Prompts. Nov 1 10:10:22.489808 containerd[1633]: time="2025-11-01T10:10:22Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Nov 1 10:10:22.490461 containerd[1633]: time="2025-11-01T10:10:22.490412792Z" level=info msg="starting containerd" revision=75cb2b7193e4e490e9fbdc236c0e811ccaba3376 version=v2.1.4 Nov 1 10:10:22.504940 containerd[1633]: time="2025-11-01T10:10:22.504863725Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.762µs" Nov 1 10:10:22.504940 containerd[1633]: time="2025-11-01T10:10:22.504924735Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Nov 1 10:10:22.505033 containerd[1633]: time="2025-11-01T10:10:22.505011904Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Nov 1 10:10:22.505033 containerd[1633]: time="2025-11-01T10:10:22.505029736Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Nov 1 10:10:22.505316 containerd[1633]: time="2025-11-01T10:10:22.505279981Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Nov 1 10:10:22.505316 containerd[1633]: time="2025-11-01T10:10:22.505301689Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505427 containerd[1633]: time="2025-11-01T10:10:22.505382304Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505427 containerd[1633]: time="2025-11-01T10:10:22.505399542Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505771 containerd[1633]: time="2025-11-01T10:10:22.505732937Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505771 containerd[1633]: time="2025-11-01T10:10:22.505753578Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505771 containerd[1633]: time="2025-11-01T10:10:22.505765677Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Nov 1 10:10:22.505843 containerd[1633]: time="2025-11-01T10:10:22.505776279Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506001 containerd[1633]: time="2025-11-01T10:10:22.505966263Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506001 containerd[1633]: time="2025-11-01T10:10:22.505984915Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506143 containerd[1633]: time="2025-11-01T10:10:22.506110023Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506448 containerd[1633]: time="2025-11-01T10:10:22.506408606Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506514 containerd[1633]: time="2025-11-01T10:10:22.506490924Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Nov 1 10:10:22.506514 containerd[1633]: time="2025-11-01T10:10:22.506506141Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Nov 1 10:10:22.506579 containerd[1633]: time="2025-11-01T10:10:22.506552868Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Nov 1 10:10:22.506821 containerd[1633]: time="2025-11-01T10:10:22.506781786Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Nov 1 10:10:22.506921 containerd[1633]: time="2025-11-01T10:10:22.506894661Z" level=info msg="metadata content store policy set" policy=shared Nov 1 10:10:22.914318 containerd[1633]: time="2025-11-01T10:10:22.914165090Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Nov 1 10:10:22.914405 containerd[1633]: time="2025-11-01T10:10:22.914316263Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 1 10:10:22.914602 containerd[1633]: time="2025-11-01T10:10:22.914563842Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Nov 1 10:10:22.914602 containerd[1633]: time="2025-11-01T10:10:22.914595209Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Nov 1 10:10:22.914661 containerd[1633]: time="2025-11-01T10:10:22.914622177Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Nov 1 10:10:22.914661 containerd[1633]: time="2025-11-01T10:10:22.914641423Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Nov 1 10:10:22.914704 containerd[1633]: time="2025-11-01T10:10:22.914667991Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Nov 1 10:10:22.914704 containerd[1633]: time="2025-11-01T10:10:22.914685064Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Nov 1 10:10:22.914758 containerd[1633]: time="2025-11-01T10:10:22.914701901Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Nov 1 10:10:22.914758 containerd[1633]: time="2025-11-01T10:10:22.914722716Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Nov 1 10:10:22.914758 containerd[1633]: time="2025-11-01T10:10:22.914743490Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Nov 1 10:10:22.914868 containerd[1633]: time="2025-11-01T10:10:22.914845220Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Nov 1 10:10:22.914908 containerd[1633]: time="2025-11-01T10:10:22.914869151Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Nov 1 10:10:22.914908 containerd[1633]: time="2025-11-01T10:10:22.914889690Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Nov 1 10:10:22.915151 containerd[1633]: time="2025-11-01T10:10:22.915114999Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Nov 1 10:10:22.915151 containerd[1633]: time="2025-11-01T10:10:22.915148120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Nov 1 10:10:22.915213 containerd[1633]: time="2025-11-01T10:10:22.915193359Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Nov 1 10:10:22.915256 containerd[1633]: time="2025-11-01T10:10:22.915220276Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Nov 1 10:10:22.915256 containerd[1633]: time="2025-11-01T10:10:22.915235677Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Nov 1 10:10:22.915256 containerd[1633]: time="2025-11-01T10:10:22.915249601Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Nov 1 10:10:22.915321 containerd[1633]: time="2025-11-01T10:10:22.915265537Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Nov 1 10:10:22.915321 containerd[1633]: time="2025-11-01T10:10:22.915283829Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Nov 1 10:10:22.915321 containerd[1633]: time="2025-11-01T10:10:22.915299385Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Nov 1 10:10:22.915321 containerd[1633]: time="2025-11-01T10:10:22.915315934Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Nov 1 10:10:22.915431 containerd[1633]: time="2025-11-01T10:10:22.915329695Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Nov 1 10:10:22.915431 containerd[1633]: time="2025-11-01T10:10:22.915376114Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Nov 1 10:10:22.915556 containerd[1633]: time="2025-11-01T10:10:22.915522673Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Nov 1 10:10:22.915595 containerd[1633]: time="2025-11-01T10:10:22.915558654Z" level=info msg="Start snapshots syncer" Nov 1 10:10:22.915619 containerd[1633]: time="2025-11-01T10:10:22.915611256Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Nov 1 10:10:22.916166 containerd[1633]: time="2025-11-01T10:10:22.916101412Z" 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,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Nov 1 10:10:22.916308 containerd[1633]: time="2025-11-01T10:10:22.916197604Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Nov 1 10:10:22.916386 containerd[1633]: time="2025-11-01T10:10:22.916359544Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Nov 1 10:10:22.916556 containerd[1633]: time="2025-11-01T10:10:22.916521678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Nov 1 10:10:22.916609 containerd[1633]: time="2025-11-01T10:10:22.916581130Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916610220Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916620638Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916633855Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916643772Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916654825Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916664751Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916678491Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916715097Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916726940Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Nov 1 10:10:22.916733 containerd[1633]: time="2025-11-01T10:10:22.916735841Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916744536Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916752411Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916762809Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916776970Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916816888Z" level=info msg="runtime interface created" Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916827849Z" level=info msg="created NRI interface" Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916838964Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916852663Z" level=info msg="Connect containerd service" Nov 1 10:10:22.916961 containerd[1633]: time="2025-11-01T10:10:22.916880851Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 1 10:10:22.918205 containerd[1633]: time="2025-11-01T10:10:22.918167170Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Nov 1 10:10:23.154606 systemd-networkd[1515]: eth0: Gained IPv6LL Nov 1 10:10:23.158137 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 1 10:10:23.161146 systemd[1]: Reached target network-online.target - Network is Online. Nov 1 10:10:23.165032 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 1 10:10:23.168882 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 1 10:10:23.172243 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 1 10:10:23.268483 containerd[1633]: time="2025-11-01T10:10:23.265200011Z" level=info msg="Start subscribing containerd event" Nov 1 10:10:23.268483 containerd[1633]: time="2025-11-01T10:10:23.267214053Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 1 10:10:23.268483 containerd[1633]: time="2025-11-01T10:10:23.267282496Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 1 10:10:23.268678 containerd[1633]: time="2025-11-01T10:10:23.268614594Z" level=info msg="Start recovering state" Nov 1 10:10:23.268882 containerd[1633]: time="2025-11-01T10:10:23.268850320Z" level=info msg="Start event monitor" Nov 1 10:10:23.268882 containerd[1633]: time="2025-11-01T10:10:23.268883305Z" level=info msg="Start cni network conf syncer for default" Nov 1 10:10:23.268960 containerd[1633]: time="2025-11-01T10:10:23.268893652Z" level=info msg="Start streaming server" Nov 1 10:10:23.268960 containerd[1633]: time="2025-11-01T10:10:23.268925194Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Nov 1 10:10:23.268960 containerd[1633]: time="2025-11-01T10:10:23.268941195Z" level=info msg="runtime interface starting up..." Nov 1 10:10:23.268960 containerd[1633]: time="2025-11-01T10:10:23.268957923Z" level=info msg="starting plugins..." Nov 1 10:10:23.269096 containerd[1633]: time="2025-11-01T10:10:23.269046488Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Nov 1 10:10:23.269251 containerd[1633]: time="2025-11-01T10:10:23.269218270Z" level=info msg="containerd successfully booted in 0.780049s" Nov 1 10:10:23.269582 systemd[1]: Started containerd.service - containerd container runtime. Nov 1 10:10:23.288268 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 1 10:10:23.290764 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 1 10:10:23.291048 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 1 10:10:23.294138 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 1 10:10:24.333392 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 1 10:10:24.337721 systemd[1]: Started sshd@0-10.0.0.124:22-10.0.0.1:57616.service - OpenSSH per-connection server daemon (10.0.0.1:57616). Nov 1 10:10:24.973519 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 1 10:10:24.976656 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 1 10:10:24.978341 systemd[1]: Startup finished in 3.448s (kernel) + 6.656s (initrd) + 6.444s (userspace) = 16.549s. Nov 1 10:10:24.987968 (kubelet)[1735]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 1 10:10:25.154869 sshd[1727]: Accepted publickey for core from 10.0.0.1 port 57616 ssh2: RSA SHA256:ka1Waf/EnFdMzWNpUvsADTzjgcbA0C+uOQYPAI4nGO0 Nov 1 10:10:25.158015 sshd-session[1727]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 1 10:10:25.170052 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 1 10:10:25.172103 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 1 10:10:25.179465 systemd-logind[1613]: New session 1 of user core. Nov 1 10:10:25.235255 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 1 10:10:25.239091 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 1 10:10:25.263244 (systemd)[1743]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 1 10:10:25.266019 systemd-logind[1613]: New session c1 of user core. Nov 1 10:10:25.445768 systemd[1743]: Queued start job for default target default.target. Nov 1 10:10:25.464819 systemd[1743]: Created slice app.slice - User Application Slice. Nov 1 10:10:25.464847 systemd[1743]: Reached target paths.target - Paths. Nov 1 10:10:25.464888 systemd[1743]: Reached target timers.target - Timers. Nov 1 10:10:25.466571 systemd[1743]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 1 10:10:25.480807 systemd[1743]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 1 10:10:25.480939 systemd[1743]: Reached target sockets.target - Sockets. Nov 1 10:10:25.480976 systemd[1743]: Reached target basic.target - Basic System. Nov 1 10:10:25.481045 systemd[1743]: Reached target default.target - Main User Target. Nov 1 10:10:25.481078 systemd[1743]: Startup finished in 204ms. Nov 1 10:10:25.483391 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 1 10:10:25.498639 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 1 10:10:25.524823 systemd[1]: Started sshd@1-10.0.0.124:22-10.0.0.1:57622.service - OpenSSH per-connection server daemon (10.0.0.1:57622). Nov 1 10:10:25.587901 sshd[1759]: Accepted publickey for core from 10.0.0.1 port 57622 ssh2: RSA SHA256:ka1Waf/EnFdMzWNpUvsADTzjgcbA0C+uOQYPAI4nGO0 Nov 1 10:10:25.589709 sshd-session[1759]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 1 10:10:25.594775 systemd-logind[1613]: New session 2 of user core. Nov 1 10:10:25.632655 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 1 10:10:25.648566 sshd[1762]: Connection closed by 10.0.0.1 port 57622 Nov 1 10:10:25.649641 sshd-session[1759]: pam_unix(sshd:session): session closed for user core Nov 1 10:10:25.663789 systemd[1]: sshd@1-10.0.0.124:22-10.0.0.1:57622.service: Deactivated successfully. Nov 1 10:10:25.666279 systemd[1]: session-2.scope: Deactivated successfully. Nov 1 10:10:25.667176 systemd-logind[1613]: Session 2 logged out. Waiting for processes to exit. Nov 1 10:10:25.670504 systemd[1]: Started sshd@2-10.0.0.124:22-10.0.0.1:57632.service - OpenSSH per-connection server daemon (10.0.0.1:57632). Nov 1 10:10:25.671469 systemd-logind[1613]: Removed session 2. Nov 1 10:10:25.714366 kubelet[1735]: E1101 10:10:25.714319 1735 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Nov 1 10:10:25.718703 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 1 10:10:25.718919 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 1 10:10:25.719607 systemd[1]: kubelet.service: Consumed 2.072s CPU time, 264.1M memory peak. Nov 1 10:10:25.722924 sshd[1768]: Accepted publickey for core from 10.0.0.1 port 57632 ssh2: RSA SHA256:ka1Waf/EnFdMzWNpUvsADTzjgcbA0C+uOQYPAI4nGO0 Nov 1 10:10:25.724816 sshd-session[1768]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 1 10:10:25.729632 systemd-logind[1613]: New session 3 of user core. Nov 1 10:10:25.740586 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 1 10:10:25.750040 sshd[1773]: Connection closed by 10.0.0.1 port 57632 Nov 1 10:10:25.750250 sshd-session[1768]: pam_unix(sshd:session): session closed for user core Nov 1 10:10:25.759158 systemd[1]: sshd@2-10.0.0.124:22-10.0.0.1:57632.service: Deactivated successfully. Nov 1 10:10:25.761455 systemd[1]: session-3.scope: Deactivated successfully. Nov 1 10:10:25.762269 systemd-logind[1613]: Session 3 logged out. Waiting for processes to exit. Nov 1 10:10:25.765685 systemd[1]: Started sshd@3-10.0.0.124:22-10.0.0.1:57648.service - OpenSSH per-connection server daemon (10.0.0.1:57648). Nov 1 10:10:25.766376 systemd-logind[1613]: Removed session 3. Nov 1 10:10:25.832230 sshd[1779]: Accepted publickey for core from 10.0.0.1 port 57648 ssh2: RSA SHA256:ka1Waf/EnFdMzWNpUvsADTzjgcbA0C+uOQYPAI4nGO0 Nov 1 10:10:25.833888 sshd-session[1779]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 1 10:10:25.838901 systemd-logind[1613]: New session 4 of user core. Nov 1 10:10:25.852600 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 1 10:10:25.868294 sshd[1782]: Connection closed by 10.0.0.1 port 57648 Nov 1 10:10:25.868667 sshd-session[1779]: pam_unix(sshd:session): session closed for user core Nov 1 10:10:25.876949 systemd[1]: sshd@3-10.0.0.124:22-10.0.0.1:57648.service: Deactivated successfully. Nov 1 10:10:25.878903 systemd[1]: session-4.scope: Deactivated successfully. Nov 1 10:10:25.879805 systemd-logind[1613]: Session 4 logged out. Waiting for processes to exit. Nov 1 10:10:25.882960 systemd[1]: Started sshd@4-10.0.0.124:22-10.0.0.1:57654.service - OpenSSH per-connection server daemon (10.0.0.1:57654). Nov 1 10:10:25.883692 systemd-logind[1613]: Removed session 4. Nov 1 10:10:25.946757 sshd[1788]: Accepted publickey for core from 10.0.0.1 port 57654 ssh2: RSA SHA256:ka1Waf/EnFdMzWNpUvsADTzjgcbA0C+uOQYPAI4nGO0 Nov 1 10:10:25.948913 sshd-session[1788]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 1 10:10:25.954314 systemd-logind[1613]: New session 5 of user core. Nov 1 10:10:25.964579 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 1 10:10:25.987564 sudo[1792]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 1 10:10:25.987939 sudo[1792]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 1 10:10:26.004133 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Nov 1 10:10:26.055444 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 1 10:10:26.055786 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Nov 1 10:10:26.776444 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 1 10:10:26.776713 systemd[1]: kubelet.service: Consumed 2.072s CPU time, 264.1M memory peak. Nov 1 10:10:26.779957 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 1 10:10:26.939600 systemd[1]: Reload requested from client PID 1831 ('systemctl') (unit session-5.scope)... Nov 1 10:10:26.939628 systemd[1]: Reloading... Nov 1 10:10:27.125444 zram_generator::config[1884]: No configuration found. Nov 1 10:10:27.599399 systemd[1]: Reloading finished in 659 ms. Nov 1 10:10:27.680504 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Nov 1 10:10:27.680632 systemd[1]: kubelet.service: Failed with result 'signal'. Nov 1 10:10:27.681027 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 1 10:10:27.681085 systemd[1]: kubelet.service: Consumed 345ms CPU time, 98.2M memory peak. Nov 1 10:10:27.683278 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 1 10:10:27.865670 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 1 10:10:27.871950 (kubelet)[1923]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Nov 1 10:10:27.931572 kubelet[1923]: 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. Nov 1 10:10:27.931572 kubelet[1923]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 1 10:10:27.931572 kubelet[1923]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Nov 1 10:10:27.932682 kubelet[1923]: I1101 10:10:27.931694 1923 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Nov 1 10:10:28.720209 kubelet[1923]: I1101 10:10:28.720148 1923 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Nov 1 10:10:28.720209 kubelet[1923]: I1101 10:10:28.720188 1923 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 1 10:10:28.720518 kubelet[1923]: I1101 10:10:28.720500 1923 server.go:954] "Client rotation is on, will bootstrap in background" Nov 1 10:10:28.753892 kubelet[1923]: I1101 10:10:28.753848 1923 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 1 10:10:28.761627 kubelet[1923]: I1101 10:10:28.761594 1923 server.go:1444] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Nov 1 10:10:28.768219 kubelet[1923]: I1101 10:10:28.768178 1923 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Nov 1 10:10:28.768564 kubelet[1923]: I1101 10:10:28.768509 1923 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 1 10:10:28.768792 kubelet[1923]: I1101 10:10:28.768550 1923 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.124","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} Nov 1 10:10:28.769370 kubelet[1923]: I1101 10:10:28.769331 1923 topology_manager.go:138] "Creating topology manager with none policy" Nov 1 10:10:28.769370 kubelet[1923]: I1101 10:10:28.769356 1923 container_manager_linux.go:304] "Creating device plugin manager" Nov 1 10:10:28.769563 kubelet[1923]: I1101 10:10:28.769541 1923 state_mem.go:36] "Initialized new in-memory state store" Nov 1 10:10:28.772895 kubelet[1923]: I1101 10:10:28.772861 1923 kubelet.go:446] "Attempting to sync node with API server" Nov 1 10:10:28.772895 kubelet[1923]: I1101 10:10:28.772892 1923 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 1 10:10:28.772948 kubelet[1923]: I1101 10:10:28.772924 1923 kubelet.go:352] "Adding apiserver pod source" Nov 1 10:10:28.772948 kubelet[1923]: I1101 10:10:28.772939 1923 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 1 10:10:28.773094 kubelet[1923]: E1101 10:10:28.773058 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:28.773656 kubelet[1923]: E1101 10:10:28.773628 1923 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:28.776382 kubelet[1923]: I1101 10:10:28.776355 1923 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="v2.1.4" apiVersion="v1" Nov 1 10:10:28.776841 kubelet[1923]: I1101 10:10:28.776802 1923 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Nov 1 10:10:28.776889 kubelet[1923]: W1101 10:10:28.776879 1923 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 1 10:10:28.781498 kubelet[1923]: I1101 10:10:28.781476 1923 watchdog_linux.go:99] "Systemd watchdog is not enabled" Nov 1 10:10:28.781575 kubelet[1923]: I1101 10:10:28.781519 1923 server.go:1287] "Started kubelet" Nov 1 10:10:28.783320 kubelet[1923]: I1101 10:10:28.783258 1923 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 1 10:10:28.783998 kubelet[1923]: I1101 10:10:28.783976 1923 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 1 10:10:28.784136 kubelet[1923]: I1101 10:10:28.784097 1923 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Nov 1 10:10:28.785424 kubelet[1923]: I1101 10:10:28.785401 1923 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 1 10:10:28.785933 kubelet[1923]: I1101 10:10:28.785772 1923 server.go:479] "Adding debug handlers to kubelet server" Nov 1 10:10:28.791450 kubelet[1923]: I1101 10:10:28.791404 1923 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 1 10:10:28.792284 kubelet[1923]: W1101 10:10:28.792260 1923 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.124" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Nov 1 10:10:28.792361 kubelet[1923]: E1101 10:10:28.792317 1923 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.124\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Nov 1 10:10:28.793375 kubelet[1923]: I1101 10:10:28.793299 1923 volume_manager.go:297] "Starting Kubelet Volume Manager" Nov 1 10:10:28.793567 kubelet[1923]: E1101 10:10:28.793406 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:28.793806 kubelet[1923]: I1101 10:10:28.793691 1923 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Nov 1 10:10:28.793806 kubelet[1923]: I1101 10:10:28.793769 1923 reconciler.go:26] "Reconciler: start to sync state" Nov 1 10:10:28.793991 kubelet[1923]: I1101 10:10:28.793933 1923 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 Nov 1 10:10:28.796675 kubelet[1923]: E1101 10:10:28.796567 1923 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.124\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Nov 1 10:10:28.796854 kubelet[1923]: E1101 10:10:28.796742 1923 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 1 10:10:28.796854 kubelet[1923]: W1101 10:10:28.796748 1923 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Nov 1 10:10:28.796854 kubelet[1923]: E1101 10:10:28.796820 1923 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Nov 1 10:10:28.797036 kubelet[1923]: I1101 10:10:28.796982 1923 factory.go:221] Registration of the containerd container factory successfully Nov 1 10:10:28.797036 kubelet[1923]: I1101 10:10:28.796999 1923 factory.go:221] Registration of the systemd container factory successfully Nov 1 10:10:28.798475 kubelet[1923]: W1101 10:10:28.797087 1923 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Nov 1 10:10:28.798475 kubelet[1923]: E1101 10:10:28.797114 1923 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Nov 1 10:10:28.798475 kubelet[1923]: E1101 10:10:28.796866 1923 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.1873da3b9ba971ea default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-11-01 10:10:28.781494762 +0000 UTC m=+0.901381621,LastTimestamp:2025-11-01 10:10:28.781494762 +0000 UTC m=+0.901381621,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Nov 1 10:10:28.799804 kubelet[1923]: E1101 10:10:28.799694 1923 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.1873da3b9c91e9cc default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-11-01 10:10:28.796729804 +0000 UTC m=+0.916616663,LastTimestamp:2025-11-01 10:10:28.796729804 +0000 UTC m=+0.916616663,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Nov 1 10:10:28.810835 kubelet[1923]: I1101 10:10:28.810798 1923 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 1 10:10:28.810835 kubelet[1923]: I1101 10:10:28.810814 1923 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 1 10:10:28.810835 kubelet[1923]: I1101 10:10:28.810832 1923 state_mem.go:36] "Initialized new in-memory state store" Nov 1 10:10:28.815071 kubelet[1923]: E1101 10:10:28.814959 1923 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.1873da3b9d5c8bd8 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.124 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-11-01 10:10:28.81000956 +0000 UTC m=+0.929896420,LastTimestamp:2025-11-01 10:10:28.81000956 +0000 UTC m=+0.929896420,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Nov 1 10:10:28.818805 kubelet[1923]: E1101 10:10:28.818726 1923 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.1873da3b9d5cb652 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasNoDiskPressure,Message:Node 10.0.0.124 status is now: NodeHasNoDiskPressure,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-11-01 10:10:28.810020434 +0000 UTC m=+0.929907293,LastTimestamp:2025-11-01 10:10:28.810020434 +0000 UTC m=+0.929907293,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Nov 1 10:10:28.822488 kubelet[1923]: E1101 10:10:28.822400 1923 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.124.1873da3b9d5cc7a4 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.124,UID:10.0.0.124,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientPID,Message:Node 10.0.0.124 status is now: NodeHasSufficientPID,Source:EventSource{Component:kubelet,Host:10.0.0.124,},FirstTimestamp:2025-11-01 10:10:28.810024868 +0000 UTC m=+0.929911727,LastTimestamp:2025-11-01 10:10:28.810024868 +0000 UTC m=+0.929911727,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.124,}" Nov 1 10:10:28.894259 kubelet[1923]: E1101 10:10:28.894223 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:28.962775 kubelet[1923]: I1101 10:10:28.962718 1923 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Nov 1 10:10:28.964232 kubelet[1923]: I1101 10:10:28.964204 1923 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Nov 1 10:10:28.964282 kubelet[1923]: I1101 10:10:28.964236 1923 status_manager.go:227] "Starting to sync pod status with apiserver" Nov 1 10:10:28.964282 kubelet[1923]: I1101 10:10:28.964260 1923 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 1 10:10:28.964282 kubelet[1923]: I1101 10:10:28.964267 1923 kubelet.go:2382] "Starting kubelet main sync loop" Nov 1 10:10:28.964358 kubelet[1923]: E1101 10:10:28.964320 1923 kubelet.go:2406] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Nov 1 10:10:28.968948 kubelet[1923]: W1101 10:10:28.968922 1923 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.RuntimeClass: runtimeclasses.node.k8s.io is forbidden: User "system:anonymous" cannot list resource "runtimeclasses" in API group "node.k8s.io" at the cluster scope Nov 1 10:10:28.969078 kubelet[1923]: E1101 10:10:28.968953 1923 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.RuntimeClass: failed to list *v1.RuntimeClass: runtimeclasses.node.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"runtimeclasses\" in API group \"node.k8s.io\" at the cluster scope" logger="UnhandledError" Nov 1 10:10:28.994521 kubelet[1923]: E1101 10:10:28.994437 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.001892 kubelet[1923]: E1101 10:10:29.001853 1923 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.124\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="400ms" Nov 1 10:10:29.015537 kubelet[1923]: I1101 10:10:29.015513 1923 policy_none.go:49] "None policy: Start" Nov 1 10:10:29.015537 kubelet[1923]: I1101 10:10:29.015539 1923 memory_manager.go:186] "Starting memorymanager" policy="None" Nov 1 10:10:29.015602 kubelet[1923]: I1101 10:10:29.015558 1923 state_mem.go:35] "Initializing new in-memory state store" Nov 1 10:10:29.044152 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Nov 1 10:10:29.061377 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Nov 1 10:10:29.064482 kubelet[1923]: E1101 10:10:29.064453 1923 kubelet.go:2406] "Skipping pod synchronization" err="container runtime status check may not have completed yet" Nov 1 10:10:29.064742 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Nov 1 10:10:29.075269 kubelet[1923]: I1101 10:10:29.075241 1923 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Nov 1 10:10:29.075527 kubelet[1923]: I1101 10:10:29.075509 1923 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 1 10:10:29.075579 kubelet[1923]: I1101 10:10:29.075529 1923 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 1 10:10:29.075826 kubelet[1923]: I1101 10:10:29.075807 1923 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 1 10:10:29.076567 kubelet[1923]: E1101 10:10:29.076542 1923 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 1 10:10:29.076623 kubelet[1923]: E1101 10:10:29.076604 1923 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.124\" not found" Nov 1 10:10:29.176816 kubelet[1923]: I1101 10:10:29.176759 1923 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.124" Nov 1 10:10:29.181966 kubelet[1923]: I1101 10:10:29.181932 1923 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.124" Nov 1 10:10:29.181966 kubelet[1923]: E1101 10:10:29.181954 1923 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"10.0.0.124\": node \"10.0.0.124\" not found" Nov 1 10:10:29.199093 kubelet[1923]: E1101 10:10:29.199050 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.300290 kubelet[1923]: E1101 10:10:29.300170 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.400745 kubelet[1923]: E1101 10:10:29.400683 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.501253 kubelet[1923]: E1101 10:10:29.501146 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.601666 kubelet[1923]: E1101 10:10:29.601595 1923 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.124\" not found" Nov 1 10:10:29.703301 kubelet[1923]: I1101 10:10:29.703257 1923 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 1 10:10:29.703779 containerd[1633]: time="2025-11-01T10:10:29.703701903Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 1 10:10:29.704220 kubelet[1923]: I1101 10:10:29.703900 1923 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 1 10:10:29.723882 kubelet[1923]: I1101 10:10:29.723807 1923 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 1 10:10:29.724118 kubelet[1923]: W1101 10:10:29.724085 1923 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Nov 1 10:10:29.724162 kubelet[1923]: W1101 10:10:29.724085 1923 reflector.go:492] k8s.io/client-go/informers/factory.go:160: watch of *v1.Node 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 Nov 1 10:10:29.773850 kubelet[1923]: E1101 10:10:29.773785 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:29.773850 kubelet[1923]: I1101 10:10:29.773786 1923 apiserver.go:52] "Watching apiserver" Nov 1 10:10:29.791587 systemd[1]: Created slice kubepods-besteffort-pod6c6f2b88_e4e4_4a86_8152_62064c4ac66a.slice - libcontainer container kubepods-besteffort-pod6c6f2b88_e4e4_4a86_8152_62064c4ac66a.slice. Nov 1 10:10:29.793916 kubelet[1923]: I1101 10:10:29.793893 1923 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Nov 1 10:10:29.797985 kubelet[1923]: I1101 10:10:29.797950 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/6c6f2b88-e4e4-4a86-8152-62064c4ac66a-xtables-lock\") pod \"kube-proxy-mlkrt\" (UID: \"6c6f2b88-e4e4-4a86-8152-62064c4ac66a\") " pod="kube-system/kube-proxy-mlkrt" Nov 1 10:10:29.798036 kubelet[1923]: I1101 10:10:29.797993 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-9xvmf\" (UniqueName: \"kubernetes.io/projected/6c6f2b88-e4e4-4a86-8152-62064c4ac66a-kube-api-access-9xvmf\") pod \"kube-proxy-mlkrt\" (UID: \"6c6f2b88-e4e4-4a86-8152-62064c4ac66a\") " pod="kube-system/kube-proxy-mlkrt" Nov 1 10:10:29.798063 kubelet[1923]: I1101 10:10:29.798039 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0ed8ac38-31ec-4451-88bb-837e7f31f608-run\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.798089 kubelet[1923]: I1101 10:10:29.798073 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-j8tg2\" (UniqueName: \"kubernetes.io/projected/0ed8ac38-31ec-4451-88bb-837e7f31f608-kube-api-access-j8tg2\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.798144 kubelet[1923]: I1101 10:10:29.798102 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0ed8ac38-31ec-4451-88bb-837e7f31f608-xtables-lock\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.798144 kubelet[1923]: I1101 10:10:29.798121 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/6c6f2b88-e4e4-4a86-8152-62064c4ac66a-kube-proxy\") pod \"kube-proxy-mlkrt\" (UID: \"6c6f2b88-e4e4-4a86-8152-62064c4ac66a\") " pod="kube-system/kube-proxy-mlkrt" Nov 1 10:10:29.798144 kubelet[1923]: I1101 10:10:29.798137 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/6c6f2b88-e4e4-4a86-8152-62064c4ac66a-lib-modules\") pod \"kube-proxy-mlkrt\" (UID: \"6c6f2b88-e4e4-4a86-8152-62064c4ac66a\") " pod="kube-system/kube-proxy-mlkrt" Nov 1 10:10:29.798216 kubelet[1923]: I1101 10:10:29.798153 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0ed8ac38-31ec-4451-88bb-837e7f31f608-cni-plugin\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.798216 kubelet[1923]: I1101 10:10:29.798166 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0ed8ac38-31ec-4451-88bb-837e7f31f608-cni\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.798216 kubelet[1923]: I1101 10:10:29.798178 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0ed8ac38-31ec-4451-88bb-837e7f31f608-flannel-cfg\") pod \"kube-flannel-ds-k9cn2\" (UID: \"0ed8ac38-31ec-4451-88bb-837e7f31f608\") " pod="kube-flannel/kube-flannel-ds-k9cn2" Nov 1 10:10:29.813757 systemd[1]: Created slice kubepods-burstable-pod0ed8ac38_31ec_4451_88bb_837e7f31f608.slice - libcontainer container kubepods-burstable-pod0ed8ac38_31ec_4451_88bb_837e7f31f608.slice. Nov 1 10:10:29.898885 sudo[1792]: pam_unix(sudo:session): session closed for user root Nov 1 10:10:29.901603 sshd[1791]: Connection closed by 10.0.0.1 port 57654 Nov 1 10:10:29.901936 sshd-session[1788]: pam_unix(sshd:session): session closed for user core Nov 1 10:10:29.906365 systemd[1]: sshd@4-10.0.0.124:22-10.0.0.1:57654.service: Deactivated successfully. Nov 1 10:10:29.908987 systemd[1]: session-5.scope: Deactivated successfully. Nov 1 10:10:29.909238 systemd[1]: session-5.scope: Consumed 731ms CPU time, 78.1M memory peak. Nov 1 10:10:29.919697 systemd-logind[1613]: Session 5 logged out. Waiting for processes to exit. Nov 1 10:10:29.920609 systemd-logind[1613]: Removed session 5. Nov 1 10:10:30.112656 kubelet[1923]: E1101 10:10:30.112615 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:30.113457 containerd[1633]: time="2025-11-01T10:10:30.113386147Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-mlkrt,Uid:6c6f2b88-e4e4-4a86-8152-62064c4ac66a,Namespace:kube-system,Attempt:0,}" Nov 1 10:10:30.129547 kubelet[1923]: E1101 10:10:30.129521 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:30.129886 containerd[1633]: time="2025-11-01T10:10:30.129844877Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k9cn2,Uid:0ed8ac38-31ec-4451-88bb-837e7f31f608,Namespace:kube-flannel,Attempt:0,}" Nov 1 10:10:30.774882 kubelet[1923]: E1101 10:10:30.774783 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:30.918477 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3275630799.mount: Deactivated successfully. Nov 1 10:10:30.927251 containerd[1633]: time="2025-11-01T10:10:30.927199420Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 1 10:10:30.928883 containerd[1633]: time="2025-11-01T10:10:30.928821622Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 1 10:10:30.929647 containerd[1633]: time="2025-11-01T10:10:30.929599976Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 1 10:10:30.931845 containerd[1633]: time="2025-11-01T10:10:30.931808832Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Nov 1 10:10:30.932824 containerd[1633]: time="2025-11-01T10:10:30.932787843Z" level=info msg="ImageCreate event name:\"sha256:873ed75102791e5b0b8a7fcd41606c92fcec98d56d05ead4ac5131650004c136\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 1 10:10:30.935023 containerd[1633]: time="2025-11-01T10:10:30.934990166Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 1 10:10:30.935815 containerd[1633]: time="2025-11-01T10:10:30.935777811Z" 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 611.100944ms" Nov 1 10:10:30.936880 containerd[1633]: time="2025-11-01T10:10:30.936844789Z" 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 610.236776ms" Nov 1 10:10:30.962772 containerd[1633]: time="2025-11-01T10:10:30.962716033Z" level=info msg="connecting to shim abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9" address="unix:///run/containerd/s/2262f76b83092030631f9cea0706a2bf7ee7e31ebbd9d5bd1ff3f87f63d4f51a" namespace=k8s.io protocol=ttrpc version=3 Nov 1 10:10:30.965125 containerd[1633]: time="2025-11-01T10:10:30.965083271Z" level=info msg="connecting to shim 7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01" address="unix:///run/containerd/s/fb3aef1b27b51a6e9ea679a64c66b0936372a6b74506996d596a0770cc549276" namespace=k8s.io protocol=ttrpc version=3 Nov 1 10:10:31.021701 systemd[1]: Started cri-containerd-abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9.scope - libcontainer container abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9. Nov 1 10:10:31.027753 systemd[1]: Started cri-containerd-7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01.scope - libcontainer container 7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01. Nov 1 10:10:31.055727 containerd[1633]: time="2025-11-01T10:10:31.055665563Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-mlkrt,Uid:6c6f2b88-e4e4-4a86-8152-62064c4ac66a,Namespace:kube-system,Attempt:0,} returns sandbox id \"7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01\"" Nov 1 10:10:31.056900 kubelet[1923]: E1101 10:10:31.056857 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:31.059304 containerd[1633]: time="2025-11-01T10:10:31.059269703Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\"" Nov 1 10:10:31.069603 containerd[1633]: time="2025-11-01T10:10:31.069558481Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k9cn2,Uid:0ed8ac38-31ec-4451-88bb-837e7f31f608,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\"" Nov 1 10:10:31.070293 kubelet[1923]: E1101 10:10:31.070249 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:31.775233 kubelet[1923]: E1101 10:10:31.775193 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:32.093044 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount821431071.mount: Deactivated successfully. Nov 1 10:10:32.370193 containerd[1633]: time="2025-11-01T10:10:32.370130638Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.32.9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:32.370998 containerd[1633]: time="2025-11-01T10:10:32.370943299Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.32.9: active requests=0, bytes read=30920484" Nov 1 10:10:32.372079 containerd[1633]: time="2025-11-01T10:10:32.372040778Z" level=info msg="ImageCreate event name:\"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:32.374253 containerd[1633]: time="2025-11-01T10:10:32.374219656Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:32.374869 containerd[1633]: time="2025-11-01T10:10:32.374813133Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.32.9\" with image id \"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\", repo tag \"registry.k8s.io/kube-proxy:v1.32.9\", repo digest \"registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064\", size \"30923225\" in 1.31549828s" Nov 1 10:10:32.374869 containerd[1633]: time="2025-11-01T10:10:32.374864635Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\" returns image reference \"sha256:fa3fdca615a501743d8deb39729a96e731312aac8d96accec061d5265360332f\"" Nov 1 10:10:32.376017 containerd[1633]: time="2025-11-01T10:10:32.375972427Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Nov 1 10:10:32.377567 containerd[1633]: time="2025-11-01T10:10:32.377510822Z" level=info msg="CreateContainer within sandbox \"7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 1 10:10:32.388922 containerd[1633]: time="2025-11-01T10:10:32.388874781Z" level=info msg="Container ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:10:32.397452 containerd[1633]: time="2025-11-01T10:10:32.397405215Z" level=info msg="CreateContainer within sandbox \"7928e3d07cfb1cd701de3a7a99b07c99cfe61fdb42d28a54979802fe4d777c01\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb\"" Nov 1 10:10:32.398127 containerd[1633]: time="2025-11-01T10:10:32.398087714Z" level=info msg="StartContainer for \"ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb\"" Nov 1 10:10:32.399609 containerd[1633]: time="2025-11-01T10:10:32.399574124Z" level=info msg="connecting to shim ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb" address="unix:///run/containerd/s/fb3aef1b27b51a6e9ea679a64c66b0936372a6b74506996d596a0770cc549276" protocol=ttrpc version=3 Nov 1 10:10:32.423557 systemd[1]: Started cri-containerd-ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb.scope - libcontainer container ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb. Nov 1 10:10:32.466916 containerd[1633]: time="2025-11-01T10:10:32.466855523Z" level=info msg="StartContainer for \"ab641ab8108e9dc546e907c79ab33ad6a95dafa021662dd75d0720d1387f87bb\" returns successfully" Nov 1 10:10:32.776113 kubelet[1923]: E1101 10:10:32.775963 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:32.976879 kubelet[1923]: E1101 10:10:32.976834 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:32.986772 kubelet[1923]: I1101 10:10:32.986667 1923 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-mlkrt" podStartSLOduration=2.669578195 podStartE2EDuration="3.986633716s" podCreationTimestamp="2025-11-01 10:10:29 +0000 UTC" firstStartedPulling="2025-11-01 10:10:31.058732126 +0000 UTC m=+3.178618976" lastFinishedPulling="2025-11-01 10:10:32.375787628 +0000 UTC m=+4.495674497" observedRunningTime="2025-11-01 10:10:32.986598756 +0000 UTC m=+5.106485616" watchObservedRunningTime="2025-11-01 10:10:32.986633716 +0000 UTC m=+5.106520575" Nov 1 10:10:33.776293 kubelet[1923]: E1101 10:10:33.776227 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:33.977875 kubelet[1923]: E1101 10:10:33.977834 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:34.776737 kubelet[1923]: E1101 10:10:34.776681 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:35.723813 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3980821214.mount: Deactivated successfully. Nov 1 10:10:35.777660 kubelet[1923]: E1101 10:10:35.777623 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:35.930382 containerd[1633]: time="2025-11-01T10:10:35.930309852Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:35.931164 containerd[1633]: time="2025-11-01T10:10:35.931127185Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=1012657" Nov 1 10:10:35.932346 containerd[1633]: time="2025-11-01T10:10:35.932288093Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:35.935378 containerd[1633]: time="2025-11-01T10:10:35.935325102Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:35.935955 containerd[1633]: time="2025-11-01T10:10:35.935925708Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3842055\" in 3.559926865s" Nov 1 10:10:35.936002 containerd[1633]: time="2025-11-01T10:10:35.935959359Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Nov 1 10:10:35.938338 containerd[1633]: time="2025-11-01T10:10:35.938310915Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 1 10:10:35.951346 containerd[1633]: time="2025-11-01T10:10:35.951259403Z" level=info msg="Container 43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:10:36.077612 containerd[1633]: time="2025-11-01T10:10:36.075763681Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41\"" Nov 1 10:10:36.079535 containerd[1633]: time="2025-11-01T10:10:36.079442086Z" level=info msg="StartContainer for \"43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41\"" Nov 1 10:10:36.081151 containerd[1633]: time="2025-11-01T10:10:36.081091575Z" level=info msg="connecting to shim 43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41" address="unix:///run/containerd/s/2262f76b83092030631f9cea0706a2bf7ee7e31ebbd9d5bd1ff3f87f63d4f51a" protocol=ttrpc version=3 Nov 1 10:10:36.778994 kubelet[1923]: E1101 10:10:36.778669 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:36.859837 systemd[1]: Started cri-containerd-43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41.scope - libcontainer container 43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41. Nov 1 10:10:36.926528 systemd[1]: cri-containerd-43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41.scope: Deactivated successfully. Nov 1 10:10:37.041302 containerd[1633]: time="2025-11-01T10:10:37.041098841Z" level=info msg="received exit event container_id:\"43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41\" id:\"43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41\" pid:2257 exited_at:{seconds:1761991836 nanos:927591431}" Nov 1 10:10:37.042522 containerd[1633]: time="2025-11-01T10:10:37.042485610Z" level=info msg="StartContainer for \"43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41\" returns successfully" Nov 1 10:10:37.077716 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-43eaf529ca92c0945713e51a793590bc38aaea36c92155ff40f69a29ee7e8e41-rootfs.mount: Deactivated successfully. Nov 1 10:10:37.779332 kubelet[1923]: E1101 10:10:37.779279 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:38.047522 kubelet[1923]: E1101 10:10:38.047370 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:38.048257 containerd[1633]: time="2025-11-01T10:10:38.048222604Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Nov 1 10:10:38.780040 kubelet[1923]: E1101 10:10:38.779974 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:39.780592 kubelet[1923]: E1101 10:10:39.780546 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:40.781045 kubelet[1923]: E1101 10:10:40.780996 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:41.627567 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2365861607.mount: Deactivated successfully. Nov 1 10:10:41.781699 kubelet[1923]: E1101 10:10:41.781649 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:42.436456 containerd[1633]: time="2025-11-01T10:10:42.436346397Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:42.437176 containerd[1633]: time="2025-11-01T10:10:42.437125418Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=13354889" Nov 1 10:10:42.438328 containerd[1633]: time="2025-11-01T10:10:42.438289314Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:42.441129 containerd[1633]: time="2025-11-01T10:10:42.441052958Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:42.441998 containerd[1633]: time="2025-11-01T10:10:42.441959585Z" 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.393689937s" Nov 1 10:10:42.442072 containerd[1633]: time="2025-11-01T10:10:42.441998673Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Nov 1 10:10:42.444599 containerd[1633]: time="2025-11-01T10:10:42.444549052Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 1 10:10:42.454337 containerd[1633]: time="2025-11-01T10:10:42.454274365Z" level=info msg="Container c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:10:42.462205 containerd[1633]: time="2025-11-01T10:10:42.462154985Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf\"" Nov 1 10:10:42.462995 containerd[1633]: time="2025-11-01T10:10:42.462940068Z" level=info msg="StartContainer for \"c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf\"" Nov 1 10:10:42.463998 containerd[1633]: time="2025-11-01T10:10:42.463968992Z" level=info msg="connecting to shim c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf" address="unix:///run/containerd/s/2262f76b83092030631f9cea0706a2bf7ee7e31ebbd9d5bd1ff3f87f63d4f51a" protocol=ttrpc version=3 Nov 1 10:10:42.517723 systemd[1]: Started cri-containerd-c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf.scope - libcontainer container c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf. Nov 1 10:10:42.570541 systemd[1]: cri-containerd-c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf.scope: Deactivated successfully. Nov 1 10:10:42.575710 containerd[1633]: time="2025-11-01T10:10:42.575656779Z" level=info msg="received exit event container_id:\"c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf\" id:\"c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf\" pid:2335 exited_at:{seconds:1761991842 nanos:570937915}" Nov 1 10:10:42.577279 containerd[1633]: time="2025-11-01T10:10:42.577055165Z" level=info msg="StartContainer for \"c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf\" returns successfully" Nov 1 10:10:42.603040 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-c74627af3b44d5a464239709c656066ec0c4655fbc32672219ce4e5828429cdf-rootfs.mount: Deactivated successfully. Nov 1 10:10:42.607701 kubelet[1923]: I1101 10:10:42.607670 1923 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Nov 1 10:10:42.782276 kubelet[1923]: E1101 10:10:42.782099 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:43.105834 kubelet[1923]: E1101 10:10:43.105806 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:43.107516 containerd[1633]: time="2025-11-01T10:10:43.107473978Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 1 10:10:43.741231 containerd[1633]: time="2025-11-01T10:10:43.740564145Z" level=info msg="Container 940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:10:43.783285 kubelet[1923]: E1101 10:10:43.783237 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:44.191767 containerd[1633]: time="2025-11-01T10:10:44.191715896Z" level=info msg="CreateContainer within sandbox \"abb4208d85e7193bc253a46cc102a9c964e4b28c51aa302ba86bfb6753d91ed9\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7\"" Nov 1 10:10:44.192085 containerd[1633]: time="2025-11-01T10:10:44.192049675Z" level=info msg="StartContainer for \"940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7\"" Nov 1 10:10:44.192884 containerd[1633]: time="2025-11-01T10:10:44.192852085Z" level=info msg="connecting to shim 940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7" address="unix:///run/containerd/s/2262f76b83092030631f9cea0706a2bf7ee7e31ebbd9d5bd1ff3f87f63d4f51a" protocol=ttrpc version=3 Nov 1 10:10:44.220568 systemd[1]: Started cri-containerd-940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7.scope - libcontainer container 940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7. Nov 1 10:10:44.410577 containerd[1633]: time="2025-11-01T10:10:44.410514681Z" level=info msg="StartContainer for \"940c1a784c4d16e1d82a51cd5d286145479fc531584e0bfabc4d014aba9395b7\" returns successfully" Nov 1 10:10:44.783551 kubelet[1923]: E1101 10:10:44.783496 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:45.111267 kubelet[1923]: E1101 10:10:45.111232 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:45.343262 systemd-networkd[1515]: flannel.1: Link UP Nov 1 10:10:45.343289 systemd-networkd[1515]: flannel.1: Gained carrier Nov 1 10:10:45.784056 kubelet[1923]: E1101 10:10:45.783983 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:46.056024 kubelet[1923]: I1101 10:10:46.055805 1923 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-k9cn2" podStartSLOduration=5.683699983 podStartE2EDuration="17.055772705s" podCreationTimestamp="2025-11-01 10:10:29 +0000 UTC" firstStartedPulling="2025-11-01 10:10:31.070850851 +0000 UTC m=+3.190737710" lastFinishedPulling="2025-11-01 10:10:42.442923573 +0000 UTC m=+14.562810432" observedRunningTime="2025-11-01 10:10:45.127311904 +0000 UTC m=+17.247198763" watchObservedRunningTime="2025-11-01 10:10:46.055772705 +0000 UTC m=+18.175659564" Nov 1 10:10:46.057728 kubelet[1923]: I1101 10:10:46.057650 1923 status_manager.go:890] "Failed to get status for pod" podUID="885960f4-b56f-4724-a8ae-2198bcd51587" pod="default/nginx-deployment-7fcdb87857-xhjfg" err="pods \"nginx-deployment-7fcdb87857-xhjfg\" is forbidden: User \"system:node:10.0.0.124\" cannot get resource \"pods\" in API group \"\" in the namespace \"default\": no relationship found between node '10.0.0.124' and this object" Nov 1 10:10:46.065378 systemd[1]: Created slice kubepods-besteffort-pod885960f4_b56f_4724_a8ae_2198bcd51587.slice - libcontainer container kubepods-besteffort-pod885960f4_b56f_4724_a8ae_2198bcd51587.slice. Nov 1 10:10:46.114052 kubelet[1923]: E1101 10:10:46.113940 1923 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 10:10:46.219954 kubelet[1923]: I1101 10:10:46.219876 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qjkdc\" (UniqueName: \"kubernetes.io/projected/885960f4-b56f-4724-a8ae-2198bcd51587-kube-api-access-qjkdc\") pod \"nginx-deployment-7fcdb87857-xhjfg\" (UID: \"885960f4-b56f-4724-a8ae-2198bcd51587\") " pod="default/nginx-deployment-7fcdb87857-xhjfg" Nov 1 10:10:46.369140 containerd[1633]: time="2025-11-01T10:10:46.369070450Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-xhjfg,Uid:885960f4-b56f-4724-a8ae-2198bcd51587,Namespace:default,Attempt:0,}" Nov 1 10:10:46.785239 kubelet[1923]: E1101 10:10:46.785046 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:46.869355 systemd-networkd[1515]: cni0: Link UP Nov 1 10:10:46.869364 systemd-networkd[1515]: cni0: Gained carrier Nov 1 10:10:46.869921 systemd-networkd[1515]: cni0: Lost carrier Nov 1 10:10:46.881299 kernel: cni0: port 1(veth5d286076) entered blocking state Nov 1 10:10:46.881472 kernel: cni0: port 1(veth5d286076) entered disabled state Nov 1 10:10:46.880529 systemd-networkd[1515]: veth5d286076: Link UP Nov 1 10:10:46.884679 kernel: veth5d286076: entered allmulticast mode Nov 1 10:10:46.884735 kernel: veth5d286076: entered promiscuous mode Nov 1 10:10:46.894108 kernel: cni0: port 1(veth5d286076) entered blocking state Nov 1 10:10:46.894206 kernel: cni0: port 1(veth5d286076) entered forwarding state Nov 1 10:10:46.894237 systemd-networkd[1515]: veth5d286076: Gained carrier Nov 1 10:10:46.895670 systemd-networkd[1515]: cni0: Gained carrier Nov 1 10:10:46.980284 containerd[1633]: 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)(0xc000022938), "name":"cbr0", "type":"bridge"} Nov 1 10:10:46.980284 containerd[1633]: delegateAdd: netconf sent to delegate plugin: Nov 1 10:10:47.410640 systemd-networkd[1515]: flannel.1: Gained IPv6LL Nov 1 10:10:47.785752 kubelet[1923]: E1101 10:10:47.785530 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:47.949147 containerd[1633]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-01T10:10:47.949081209Z" level=info msg="connecting to shim f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a" address="unix:///run/containerd/s/92d3443ae9d2a17b553ba9ebd2ab39864898444e9e2f656f3366aaad9d551ade" namespace=k8s.io protocol=ttrpc version=3 Nov 1 10:10:47.974562 systemd[1]: Started cri-containerd-f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a.scope - libcontainer container f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a. Nov 1 10:10:47.987903 systemd-resolved[1309]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 10:10:48.029476 containerd[1633]: time="2025-11-01T10:10:48.027921119Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-xhjfg,Uid:885960f4-b56f-4724-a8ae-2198bcd51587,Namespace:default,Attempt:0,} returns sandbox id \"f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a\"" Nov 1 10:10:48.031225 containerd[1633]: time="2025-11-01T10:10:48.031183468Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 1 10:10:48.434625 systemd-networkd[1515]: veth5d286076: Gained IPv6LL Nov 1 10:10:48.691126 systemd-networkd[1515]: cni0: Gained IPv6LL Nov 1 10:10:48.773280 kubelet[1923]: E1101 10:10:48.773186 1923 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:48.785968 kubelet[1923]: E1101 10:10:48.785924 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:49.786825 kubelet[1923]: E1101 10:10:49.786755 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:50.787139 kubelet[1923]: E1101 10:10:50.787068 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:51.788262 kubelet[1923]: E1101 10:10:51.788199 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:52.116682 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2128232115.mount: Deactivated successfully. Nov 1 10:10:52.815330 kubelet[1923]: E1101 10:10:52.815270 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:53.689507 containerd[1633]: time="2025-11-01T10:10:53.689408075Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:53.690259 containerd[1633]: time="2025-11-01T10:10:53.690213325Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73300222" Nov 1 10:10:53.691400 containerd[1633]: time="2025-11-01T10:10:53.691358763Z" level=info msg="ImageCreate event name:\"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:53.693769 containerd[1633]: time="2025-11-01T10:10:53.693704923Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:10:53.694507 containerd[1633]: time="2025-11-01T10:10:53.694466273Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 5.663235456s" Nov 1 10:10:53.694507 containerd[1633]: time="2025-11-01T10:10:53.694500953Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 1 10:10:53.696469 containerd[1633]: time="2025-11-01T10:10:53.696432696Z" level=info msg="CreateContainer within sandbox \"f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 1 10:10:53.705388 containerd[1633]: time="2025-11-01T10:10:53.705337305Z" level=info msg="Container 5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:10:53.712303 containerd[1633]: time="2025-11-01T10:10:53.712262058Z" level=info msg="CreateContainer within sandbox \"f57c531ae234a1db71dcb1d1eb0c1b9416dde3dbd746b3bd75322de2aae5944a\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f\"" Nov 1 10:10:53.712987 containerd[1633]: time="2025-11-01T10:10:53.712958920Z" level=info msg="StartContainer for \"5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f\"" Nov 1 10:10:53.713823 containerd[1633]: time="2025-11-01T10:10:53.713796554Z" level=info msg="connecting to shim 5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f" address="unix:///run/containerd/s/92d3443ae9d2a17b553ba9ebd2ab39864898444e9e2f656f3366aaad9d551ade" protocol=ttrpc version=3 Nov 1 10:10:53.746567 systemd[1]: Started cri-containerd-5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f.scope - libcontainer container 5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f. Nov 1 10:10:53.789020 containerd[1633]: time="2025-11-01T10:10:53.788973270Z" level=info msg="StartContainer for \"5554433f003bbb24c6d86e5126ba9b091fc4e0ff61ddb5ea7a6b71fd6d57252f\" returns successfully" Nov 1 10:10:53.815544 kubelet[1923]: E1101 10:10:53.815477 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:54.138230 kubelet[1923]: I1101 10:10:54.138116 1923 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-xhjfg" podStartSLOduration=2.473655155 podStartE2EDuration="8.138093752s" podCreationTimestamp="2025-11-01 10:10:46 +0000 UTC" firstStartedPulling="2025-11-01 10:10:48.030834981 +0000 UTC m=+20.150721840" lastFinishedPulling="2025-11-01 10:10:53.695273578 +0000 UTC m=+25.815160437" observedRunningTime="2025-11-01 10:10:54.137912202 +0000 UTC m=+26.257799051" watchObservedRunningTime="2025-11-01 10:10:54.138093752 +0000 UTC m=+26.257980611" Nov 1 10:10:54.816553 kubelet[1923]: E1101 10:10:54.816481 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:55.816899 kubelet[1923]: E1101 10:10:55.816832 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:56.818066 kubelet[1923]: E1101 10:10:56.817980 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:57.798775 systemd[1]: Created slice kubepods-besteffort-podc210820b_5f5d_4743_ab44_134145a63474.slice - libcontainer container kubepods-besteffort-podc210820b_5f5d_4743_ab44_134145a63474.slice. Nov 1 10:10:57.818947 kubelet[1923]: E1101 10:10:57.818911 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:57.978999 kubelet[1923]: I1101 10:10:57.978965 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-kgtr4\" (UniqueName: \"kubernetes.io/projected/c210820b-5f5d-4743-ab44-134145a63474-kube-api-access-kgtr4\") pod \"nfs-server-provisioner-0\" (UID: \"c210820b-5f5d-4743-ab44-134145a63474\") " pod="default/nfs-server-provisioner-0" Nov 1 10:10:57.979059 kubelet[1923]: I1101 10:10:57.979000 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/c210820b-5f5d-4743-ab44-134145a63474-data\") pod \"nfs-server-provisioner-0\" (UID: \"c210820b-5f5d-4743-ab44-134145a63474\") " pod="default/nfs-server-provisioner-0" Nov 1 10:10:58.102126 containerd[1633]: time="2025-11-01T10:10:58.102080411Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:c210820b-5f5d-4743-ab44-134145a63474,Namespace:default,Attempt:0,}" Nov 1 10:10:58.142248 kernel: cni0: port 2(veth609316f0) entered blocking state Nov 1 10:10:58.142436 kernel: cni0: port 2(veth609316f0) entered disabled state Nov 1 10:10:58.145581 kernel: veth609316f0: entered allmulticast mode Nov 1 10:10:58.145641 kernel: veth609316f0: entered promiscuous mode Nov 1 10:10:58.146359 systemd-networkd[1515]: veth609316f0: Link UP Nov 1 10:10:58.163031 kernel: cni0: port 2(veth609316f0) entered blocking state Nov 1 10:10:58.163157 kernel: cni0: port 2(veth609316f0) entered forwarding state Nov 1 10:10:58.163398 systemd-networkd[1515]: veth609316f0: Gained carrier Nov 1 10:10:58.168614 containerd[1633]: 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"} Nov 1 10:10:58.168614 containerd[1633]: delegateAdd: netconf sent to delegate plugin: Nov 1 10:10:58.332195 containerd[1633]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-01T10:10:58.332152897Z" level=info msg="connecting to shim e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0" address="unix:///run/containerd/s/70ae6ef54a2c20a2942b1b12810ed8a503037417b16b8540a8a0aadc21128c80" namespace=k8s.io protocol=ttrpc version=3 Nov 1 10:10:58.377628 systemd[1]: Started cri-containerd-e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0.scope - libcontainer container e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0. Nov 1 10:10:58.394397 systemd-resolved[1309]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 10:10:58.430983 containerd[1633]: time="2025-11-01T10:10:58.430943922Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:c210820b-5f5d-4743-ab44-134145a63474,Namespace:default,Attempt:0,} returns sandbox id \"e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0\"" Nov 1 10:10:58.432796 containerd[1633]: time="2025-11-01T10:10:58.432764881Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 1 10:10:58.819685 kubelet[1923]: E1101 10:10:58.819542 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:59.820538 kubelet[1923]: E1101 10:10:59.820488 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:10:59.826573 systemd-networkd[1515]: veth609316f0: Gained IPv6LL Nov 1 10:11:00.821596 kubelet[1923]: E1101 10:11:00.821520 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:01.687775 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount755626733.mount: Deactivated successfully. Nov 1 10:11:01.822078 kubelet[1923]: E1101 10:11:01.822016 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:02.822935 kubelet[1923]: E1101 10:11:02.822861 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:03.823824 kubelet[1923]: E1101 10:11:03.823763 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:04.824124 kubelet[1923]: E1101 10:11:04.824053 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:05.343049 containerd[1633]: time="2025-11-01T10:11:05.342951840Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:11:05.344195 containerd[1633]: time="2025-11-01T10:11:05.344145907Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=89929426" Nov 1 10:11:05.345432 containerd[1633]: time="2025-11-01T10:11:05.345364115Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:11:05.347678 containerd[1633]: time="2025-11-01T10:11:05.347640860Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:11:05.348592 containerd[1633]: time="2025-11-01T10:11:05.348552186Z" 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.915748964s" Nov 1 10:11:05.348592 containerd[1633]: time="2025-11-01T10:11:05.348586046Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Nov 1 10:11:05.350919 containerd[1633]: time="2025-11-01T10:11:05.350887202Z" level=info msg="CreateContainer within sandbox \"e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 1 10:11:05.364641 containerd[1633]: time="2025-11-01T10:11:05.364597329Z" level=info msg="Container e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:11:05.372568 containerd[1633]: time="2025-11-01T10:11:05.372532580Z" level=info msg="CreateContainer within sandbox \"e1dd13a8f7121c7e8adbb4d2f64231ba5dc50e0b512ebf4ab9210380aacee0a0\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff\"" Nov 1 10:11:05.373855 containerd[1633]: time="2025-11-01T10:11:05.372947063Z" level=info msg="StartContainer for \"e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff\"" Nov 1 10:11:05.373855 containerd[1633]: time="2025-11-01T10:11:05.373823517Z" level=info msg="connecting to shim e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff" address="unix:///run/containerd/s/70ae6ef54a2c20a2942b1b12810ed8a503037417b16b8540a8a0aadc21128c80" protocol=ttrpc version=3 Nov 1 10:11:05.396557 systemd[1]: Started cri-containerd-e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff.scope - libcontainer container e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff. Nov 1 10:11:05.427792 containerd[1633]: time="2025-11-01T10:11:05.427721503Z" level=info msg="StartContainer for \"e30c7c6a099d44b994735a573b0cc646c9f7facfbaa48284fceea67e869221ff\" returns successfully" Nov 1 10:11:05.825081 kubelet[1923]: E1101 10:11:05.825004 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:06.274524 kubelet[1923]: I1101 10:11:06.274468 1923 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.357452886 podStartE2EDuration="9.274446108s" podCreationTimestamp="2025-11-01 10:10:57 +0000 UTC" firstStartedPulling="2025-11-01 10:10:58.432469929 +0000 UTC m=+30.552356789" lastFinishedPulling="2025-11-01 10:11:05.349463151 +0000 UTC m=+37.469350011" observedRunningTime="2025-11-01 10:11:06.274430326 +0000 UTC m=+38.394317185" watchObservedRunningTime="2025-11-01 10:11:06.274446108 +0000 UTC m=+38.394332967" Nov 1 10:11:06.825850 kubelet[1923]: E1101 10:11:06.825766 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:07.430660 update_engine[1620]: I20251101 10:11:07.430542 1620 update_attempter.cc:509] Updating boot flags... Nov 1 10:11:07.826169 kubelet[1923]: E1101 10:11:07.826031 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:08.773858 kubelet[1923]: E1101 10:11:08.773791 1923 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:08.826865 kubelet[1923]: E1101 10:11:08.826755 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:09.827915 kubelet[1923]: E1101 10:11:09.827829 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:10.828963 kubelet[1923]: E1101 10:11:10.828896 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:11.829122 kubelet[1923]: E1101 10:11:11.829053 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:12.830117 kubelet[1923]: E1101 10:11:12.830034 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:13.830668 kubelet[1923]: E1101 10:11:13.830573 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:14.831738 kubelet[1923]: E1101 10:11:14.831638 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:15.047776 systemd[1]: Created slice kubepods-besteffort-pod7e9f0cce_3b53_42e1_b518_fff42c847099.slice - libcontainer container kubepods-besteffort-pod7e9f0cce_3b53_42e1_b518_fff42c847099.slice. Nov 1 10:11:15.241856 kubelet[1923]: I1101 10:11:15.241816 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qnmzh\" (UniqueName: \"kubernetes.io/projected/7e9f0cce-3b53-42e1-b518-fff42c847099-kube-api-access-qnmzh\") pod \"test-pod-1\" (UID: \"7e9f0cce-3b53-42e1-b518-fff42c847099\") " pod="default/test-pod-1" Nov 1 10:11:15.241979 kubelet[1923]: I1101 10:11:15.241867 1923 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-a8354519-a774-4f61-a7b4-e4464873b14a\" (UniqueName: \"kubernetes.io/nfs/7e9f0cce-3b53-42e1-b518-fff42c847099-pvc-a8354519-a774-4f61-a7b4-e4464873b14a\") pod \"test-pod-1\" (UID: \"7e9f0cce-3b53-42e1-b518-fff42c847099\") " pod="default/test-pod-1" Nov 1 10:11:15.376451 kernel: netfs: FS-Cache loaded Nov 1 10:11:15.441554 kernel: RPC: Registered named UNIX socket transport module. Nov 1 10:11:15.441658 kernel: RPC: Registered udp transport module. Nov 1 10:11:15.441695 kernel: RPC: Registered tcp transport module. Nov 1 10:11:15.443727 kernel: RPC: Registered tcp-with-tls transport module. Nov 1 10:11:15.443766 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 1 10:11:15.708776 kernel: NFS: Registering the id_resolver key type Nov 1 10:11:15.708919 kernel: Key type id_resolver registered Nov 1 10:11:15.708952 kernel: Key type id_legacy registered Nov 1 10:11:15.735444 nfsidmap[3003]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 1 10:11:15.736086 nfsidmap[3003]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 1 10:11:15.740591 nfsidmap[3006]: libnfsidmap: Unable to determine the NFSv4 domain; Using 'localdomain' as the NFSv4 domain which means UIDs will be mapped to the 'Nobody-User' user defined in /etc/idmapd.conf Nov 1 10:11:15.740790 nfsidmap[3006]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 1 10:11:15.750490 nfsrahead[3010]: setting /var/lib/kubelet/pods/7e9f0cce-3b53-42e1-b518-fff42c847099/volumes/kubernetes.io~nfs/pvc-a8354519-a774-4f61-a7b4-e4464873b14a readahead to 128 Nov 1 10:11:15.832514 kubelet[1923]: E1101 10:11:15.832472 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:15.951285 containerd[1633]: time="2025-11-01T10:11:15.951236893Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:7e9f0cce-3b53-42e1-b518-fff42c847099,Namespace:default,Attempt:0,}" Nov 1 10:11:15.969738 systemd-networkd[1515]: vethbcec07a8: Link UP Nov 1 10:11:15.973341 kernel: cni0: port 3(vethbcec07a8) entered blocking state Nov 1 10:11:15.973442 kernel: cni0: port 3(vethbcec07a8) entered disabled state Nov 1 10:11:15.976557 kernel: vethbcec07a8: entered allmulticast mode Nov 1 10:11:15.976605 kernel: vethbcec07a8: entered promiscuous mode Nov 1 10:11:15.983556 kernel: cni0: port 3(vethbcec07a8) entered blocking state Nov 1 10:11:15.983638 kernel: cni0: port 3(vethbcec07a8) entered forwarding state Nov 1 10:11:15.983719 systemd-networkd[1515]: vethbcec07a8: Gained carrier Nov 1 10:11:15.985856 containerd[1633]: 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)(0xc000018938), "name":"cbr0", "type":"bridge"} Nov 1 10:11:15.985856 containerd[1633]: delegateAdd: netconf sent to delegate plugin: Nov 1 10:11:16.010092 containerd[1633]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-11-01T10:11:16.010023676Z" level=info msg="connecting to shim 30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34" address="unix:///run/containerd/s/fddbc35459fa78d38bb1793d5544ea5a9f05e6f92017149829ebc8195a758bb4" namespace=k8s.io protocol=ttrpc version=3 Nov 1 10:11:16.048575 systemd[1]: Started cri-containerd-30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34.scope - libcontainer container 30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34. Nov 1 10:11:16.066695 systemd-resolved[1309]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 10:11:16.102985 containerd[1633]: time="2025-11-01T10:11:16.102937967Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:7e9f0cce-3b53-42e1-b518-fff42c847099,Namespace:default,Attempt:0,} returns sandbox id \"30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34\"" Nov 1 10:11:16.104298 containerd[1633]: time="2025-11-01T10:11:16.104268356Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 1 10:11:16.485100 containerd[1633]: time="2025-11-01T10:11:16.485051390Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 1 10:11:16.485956 containerd[1633]: time="2025-11-01T10:11:16.485936285Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=0" Nov 1 10:11:16.488192 containerd[1633]: time="2025-11-01T10:11:16.488140769Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"73311824\" in 383.83159ms" Nov 1 10:11:16.488192 containerd[1633]: time="2025-11-01T10:11:16.488175186Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:8d14817f00613fe76ef7459f977ad93e7b71a3948346b7ac4d50e35f3dd518e9\"" Nov 1 10:11:16.489799 containerd[1633]: time="2025-11-01T10:11:16.489761152Z" level=info msg="CreateContainer within sandbox \"30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 1 10:11:16.498521 containerd[1633]: time="2025-11-01T10:11:16.498475912Z" level=info msg="Container 862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440: CDI devices from CRI Config.CDIDevices: []" Nov 1 10:11:16.504924 containerd[1633]: time="2025-11-01T10:11:16.504875027Z" level=info msg="CreateContainer within sandbox \"30e4c91c7821899a87e72263827b02292d6b1c1ea2f537fa3b23acbd7bb10c34\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440\"" Nov 1 10:11:16.505285 containerd[1633]: time="2025-11-01T10:11:16.505251003Z" level=info msg="StartContainer for \"862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440\"" Nov 1 10:11:16.506188 containerd[1633]: time="2025-11-01T10:11:16.506145127Z" level=info msg="connecting to shim 862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440" address="unix:///run/containerd/s/fddbc35459fa78d38bb1793d5544ea5a9f05e6f92017149829ebc8195a758bb4" protocol=ttrpc version=3 Nov 1 10:11:16.529587 systemd[1]: Started cri-containerd-862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440.scope - libcontainer container 862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440. Nov 1 10:11:16.570582 containerd[1633]: time="2025-11-01T10:11:16.570540039Z" level=info msg="StartContainer for \"862ac81dbdd859eac9bb80d65429225d5f6ac0dc5d0dba9805c7c24e1b318440\" returns successfully" Nov 1 10:11:16.832998 kubelet[1923]: E1101 10:11:16.832873 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:17.292327 kubelet[1923]: I1101 10:11:17.292268 1923 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=18.907375032 podStartE2EDuration="19.292254491s" podCreationTimestamp="2025-11-01 10:10:58 +0000 UTC" firstStartedPulling="2025-11-01 10:11:16.10381114 +0000 UTC m=+48.223697999" lastFinishedPulling="2025-11-01 10:11:16.488690599 +0000 UTC m=+48.608577458" observedRunningTime="2025-11-01 10:11:17.291993635 +0000 UTC m=+49.411880494" watchObservedRunningTime="2025-11-01 10:11:17.292254491 +0000 UTC m=+49.412141350" Nov 1 10:11:17.833306 kubelet[1923]: E1101 10:11:17.833230 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:18.002628 systemd-networkd[1515]: vethbcec07a8: Gained IPv6LL Nov 1 10:11:18.834486 kubelet[1923]: E1101 10:11:18.834390 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:19.835323 kubelet[1923]: E1101 10:11:19.835238 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 10:11:20.835594 kubelet[1923]: E1101 10:11:20.835515 1923 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"