Dec 16 12:32:25.310646 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 16 12:32:25.310671 kernel: Linux version 6.12.61-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-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 Tue Dec 16 00:05:24 -00 2025 Dec 16 12:32:25.310679 kernel: KASLR enabled Dec 16 12:32:25.310685 kernel: efi: EFI v2.7 by EDK II Dec 16 12:32:25.310714 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Dec 16 12:32:25.310721 kernel: random: crng init done Dec 16 12:32:25.310729 kernel: secureboot: Secure boot disabled Dec 16 12:32:25.310735 kernel: ACPI: Early table checksum verification disabled Dec 16 12:32:25.310744 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Dec 16 12:32:25.310750 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 16 12:32:25.310756 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310763 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310769 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310775 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310784 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310791 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310797 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310804 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310810 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:32:25.310817 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 16 12:32:25.310823 kernel: ACPI: Use ACPI SPCR as default console: Yes Dec 16 12:32:25.310831 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:32:25.310839 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Dec 16 12:32:25.310845 kernel: Zone ranges: Dec 16 12:32:25.310852 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:32:25.310858 kernel: DMA32 empty Dec 16 12:32:25.310865 kernel: Normal empty Dec 16 12:32:25.310871 kernel: Device empty Dec 16 12:32:25.310877 kernel: Movable zone start for each node Dec 16 12:32:25.310884 kernel: Early memory node ranges Dec 16 12:32:25.310890 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Dec 16 12:32:25.310897 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Dec 16 12:32:25.310904 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Dec 16 12:32:25.310910 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Dec 16 12:32:25.310918 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Dec 16 12:32:25.310924 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Dec 16 12:32:25.310930 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Dec 16 12:32:25.310936 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Dec 16 12:32:25.310943 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Dec 16 12:32:25.310949 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Dec 16 12:32:25.310959 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Dec 16 12:32:25.310966 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Dec 16 12:32:25.310973 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 16 12:32:25.310980 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:32:25.310986 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 16 12:32:25.310993 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Dec 16 12:32:25.311000 kernel: psci: probing for conduit method from ACPI. Dec 16 12:32:25.311007 kernel: psci: PSCIv1.1 detected in firmware. Dec 16 12:32:25.311015 kernel: psci: Using standard PSCI v0.2 function IDs Dec 16 12:32:25.311021 kernel: psci: Trusted OS migration not required Dec 16 12:32:25.311028 kernel: psci: SMC Calling Convention v1.1 Dec 16 12:32:25.311035 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 16 12:32:25.311042 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Dec 16 12:32:25.311049 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Dec 16 12:32:25.311056 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 16 12:32:25.311062 kernel: Detected PIPT I-cache on CPU0 Dec 16 12:32:25.311069 kernel: CPU features: detected: GIC system register CPU interface Dec 16 12:32:25.311076 kernel: CPU features: detected: Spectre-v4 Dec 16 12:32:25.311083 kernel: CPU features: detected: Spectre-BHB Dec 16 12:32:25.311091 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 16 12:32:25.311098 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 16 12:32:25.311104 kernel: CPU features: detected: ARM erratum 1418040 Dec 16 12:32:25.311111 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 16 12:32:25.311118 kernel: alternatives: applying boot alternatives Dec 16 12:32:25.311125 kernel: 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 acpi=force verity.usrhash=756b815c2fd7ac2947efceb2a88878d1ea9723ec85037c2b4d1a09bd798bb749 Dec 16 12:32:25.311133 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 16 12:32:25.311140 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 16 12:32:25.311146 kernel: Fallback order for Node 0: 0 Dec 16 12:32:25.311153 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Dec 16 12:32:25.311161 kernel: Policy zone: DMA Dec 16 12:32:25.311168 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 16 12:32:25.311175 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Dec 16 12:32:25.311183 kernel: software IO TLB: area num 4. Dec 16 12:32:25.311190 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Dec 16 12:32:25.311198 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Dec 16 12:32:25.311205 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 16 12:32:25.311212 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 16 12:32:25.311220 kernel: rcu: RCU event tracing is enabled. Dec 16 12:32:25.311227 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 16 12:32:25.311234 kernel: Trampoline variant of Tasks RCU enabled. Dec 16 12:32:25.311242 kernel: Tracing variant of Tasks RCU enabled. Dec 16 12:32:25.311249 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 16 12:32:25.311256 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 16 12:32:25.311263 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 16 12:32:25.311270 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 16 12:32:25.311277 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 16 12:32:25.311284 kernel: GICv3: 256 SPIs implemented Dec 16 12:32:25.311291 kernel: GICv3: 0 Extended SPIs implemented Dec 16 12:32:25.311297 kernel: Root IRQ handler: gic_handle_irq Dec 16 12:32:25.311304 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 16 12:32:25.311311 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Dec 16 12:32:25.311319 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 16 12:32:25.311326 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 16 12:32:25.311333 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Dec 16 12:32:25.311340 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Dec 16 12:32:25.311347 kernel: GICv3: using LPI property table @0x0000000040130000 Dec 16 12:32:25.311354 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Dec 16 12:32:25.311360 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 16 12:32:25.311367 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:32:25.311374 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 16 12:32:25.311382 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 16 12:32:25.311389 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 16 12:32:25.311397 kernel: arm-pv: using stolen time PV Dec 16 12:32:25.311405 kernel: Console: colour dummy device 80x25 Dec 16 12:32:25.311413 kernel: ACPI: Core revision 20240827 Dec 16 12:32:25.311428 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 16 12:32:25.311436 kernel: pid_max: default: 32768 minimum: 301 Dec 16 12:32:25.311444 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Dec 16 12:32:25.311451 kernel: landlock: Up and running. Dec 16 12:32:25.311459 kernel: SELinux: Initializing. Dec 16 12:32:25.311469 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:32:25.311477 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:32:25.311484 kernel: rcu: Hierarchical SRCU implementation. Dec 16 12:32:25.311491 kernel: rcu: Max phase no-delay instances is 400. Dec 16 12:32:25.311499 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Dec 16 12:32:25.311506 kernel: Remapping and enabling EFI services. Dec 16 12:32:25.311513 kernel: smp: Bringing up secondary CPUs ... Dec 16 12:32:25.311522 kernel: Detected PIPT I-cache on CPU1 Dec 16 12:32:25.311534 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 16 12:32:25.311544 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Dec 16 12:32:25.311552 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:32:25.311559 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 16 12:32:25.311567 kernel: Detected PIPT I-cache on CPU2 Dec 16 12:32:25.311576 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 16 12:32:25.311584 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Dec 16 12:32:25.311592 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:32:25.311600 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 16 12:32:25.311608 kernel: Detected PIPT I-cache on CPU3 Dec 16 12:32:25.311616 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 16 12:32:25.311623 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Dec 16 12:32:25.311631 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:32:25.311640 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 16 12:32:25.311648 kernel: smp: Brought up 1 node, 4 CPUs Dec 16 12:32:25.311656 kernel: SMP: Total of 4 processors activated. Dec 16 12:32:25.311663 kernel: CPU: All CPU(s) started at EL1 Dec 16 12:32:25.311671 kernel: CPU features: detected: 32-bit EL0 Support Dec 16 12:32:25.311679 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 16 12:32:25.311687 kernel: CPU features: detected: Common not Private translations Dec 16 12:32:25.311705 kernel: CPU features: detected: CRC32 instructions Dec 16 12:32:25.311712 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 16 12:32:25.311720 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 16 12:32:25.311727 kernel: CPU features: detected: LSE atomic instructions Dec 16 12:32:25.311734 kernel: CPU features: detected: Privileged Access Never Dec 16 12:32:25.311742 kernel: CPU features: detected: RAS Extension Support Dec 16 12:32:25.311753 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 16 12:32:25.311761 kernel: alternatives: applying system-wide alternatives Dec 16 12:32:25.311771 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Dec 16 12:32:25.311779 kernel: Memory: 2450848K/2572288K available (11200K kernel code, 2456K rwdata, 9084K rodata, 12480K init, 1038K bss, 99104K reserved, 16384K cma-reserved) Dec 16 12:32:25.311787 kernel: devtmpfs: initialized Dec 16 12:32:25.311795 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 16 12:32:25.311803 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 16 12:32:25.311811 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 16 12:32:25.311819 kernel: 0 pages in range for non-PLT usage Dec 16 12:32:25.311829 kernel: 515168 pages in range for PLT usage Dec 16 12:32:25.311836 kernel: pinctrl core: initialized pinctrl subsystem Dec 16 12:32:25.311844 kernel: SMBIOS 3.0.0 present. Dec 16 12:32:25.311852 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 16 12:32:25.311861 kernel: DMI: Memory slots populated: 1/1 Dec 16 12:32:25.311868 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 16 12:32:25.311876 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 16 12:32:25.311886 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 16 12:32:25.311894 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 16 12:32:25.311902 kernel: audit: initializing netlink subsys (disabled) Dec 16 12:32:25.311909 kernel: audit: type=2000 audit(0.017:1): state=initialized audit_enabled=0 res=1 Dec 16 12:32:25.311923 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 16 12:32:25.311945 kernel: cpuidle: using governor menu Dec 16 12:32:25.311953 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 16 12:32:25.311963 kernel: ASID allocator initialised with 32768 entries Dec 16 12:32:25.311971 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 16 12:32:25.311979 kernel: Serial: AMBA PL011 UART driver Dec 16 12:32:25.311987 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 16 12:32:25.311995 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 16 12:32:25.312002 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 16 12:32:25.312010 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 16 12:32:25.312018 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 16 12:32:25.312027 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 16 12:32:25.312035 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 16 12:32:25.312042 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 16 12:32:25.312050 kernel: ACPI: Added _OSI(Module Device) Dec 16 12:32:25.312058 kernel: ACPI: Added _OSI(Processor Device) Dec 16 12:32:25.312066 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 16 12:32:25.312073 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 16 12:32:25.312083 kernel: ACPI: Interpreter enabled Dec 16 12:32:25.312090 kernel: ACPI: Using GIC for interrupt routing Dec 16 12:32:25.312098 kernel: ACPI: MCFG table detected, 1 entries Dec 16 12:32:25.312106 kernel: ACPI: CPU0 has been hot-added Dec 16 12:32:25.312113 kernel: ACPI: CPU1 has been hot-added Dec 16 12:32:25.312121 kernel: ACPI: CPU2 has been hot-added Dec 16 12:32:25.312129 kernel: ACPI: CPU3 has been hot-added Dec 16 12:32:25.312138 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 16 12:32:25.312147 kernel: printk: legacy console [ttyAMA0] enabled Dec 16 12:32:25.312154 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 16 12:32:25.312336 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 16 12:32:25.312435 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 16 12:32:25.312524 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 16 12:32:25.312606 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 16 12:32:25.312719 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 16 12:32:25.312730 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 16 12:32:25.312738 kernel: PCI host bridge to bus 0000:00 Dec 16 12:32:25.312829 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 16 12:32:25.312902 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 16 12:32:25.312978 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 16 12:32:25.313055 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 16 12:32:25.313152 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Dec 16 12:32:25.313245 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Dec 16 12:32:25.313347 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Dec 16 12:32:25.313442 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Dec 16 12:32:25.313531 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Dec 16 12:32:25.313611 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Dec 16 12:32:25.313713 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Dec 16 12:32:25.313807 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Dec 16 12:32:25.313880 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 16 12:32:25.313953 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 16 12:32:25.314035 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 16 12:32:25.314045 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 16 12:32:25.314053 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 16 12:32:25.314061 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 16 12:32:25.314068 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 16 12:32:25.314076 kernel: iommu: Default domain type: Translated Dec 16 12:32:25.314085 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 16 12:32:25.314093 kernel: efivars: Registered efivars operations Dec 16 12:32:25.314101 kernel: vgaarb: loaded Dec 16 12:32:25.314108 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 16 12:32:25.314116 kernel: VFS: Disk quotas dquot_6.6.0 Dec 16 12:32:25.314124 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 16 12:32:25.314131 kernel: pnp: PnP ACPI init Dec 16 12:32:25.314221 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 16 12:32:25.314232 kernel: pnp: PnP ACPI: found 1 devices Dec 16 12:32:25.314240 kernel: NET: Registered PF_INET protocol family Dec 16 12:32:25.314247 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 16 12:32:25.314255 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 16 12:32:25.314263 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 16 12:32:25.314271 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 16 12:32:25.314281 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 16 12:32:25.314288 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 16 12:32:25.314296 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:32:25.314304 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:32:25.314311 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 16 12:32:25.314319 kernel: PCI: CLS 0 bytes, default 64 Dec 16 12:32:25.314326 kernel: kvm [1]: HYP mode not available Dec 16 12:32:25.314336 kernel: Initialise system trusted keyrings Dec 16 12:32:25.314343 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 16 12:32:25.314351 kernel: Key type asymmetric registered Dec 16 12:32:25.314358 kernel: Asymmetric key parser 'x509' registered Dec 16 12:32:25.314366 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 16 12:32:25.314374 kernel: io scheduler mq-deadline registered Dec 16 12:32:25.314381 kernel: io scheduler kyber registered Dec 16 12:32:25.314391 kernel: io scheduler bfq registered Dec 16 12:32:25.314398 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 16 12:32:25.314406 kernel: ACPI: button: Power Button [PWRB] Dec 16 12:32:25.314414 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 16 12:32:25.314539 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 16 12:32:25.314551 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 16 12:32:25.314559 kernel: thunder_xcv, ver 1.0 Dec 16 12:32:25.314569 kernel: thunder_bgx, ver 1.0 Dec 16 12:32:25.314577 kernel: nicpf, ver 1.0 Dec 16 12:32:25.314585 kernel: nicvf, ver 1.0 Dec 16 12:32:25.314682 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 16 12:32:25.314782 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-16T12:32:24 UTC (1765888344) Dec 16 12:32:25.314793 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 16 12:32:25.314804 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Dec 16 12:32:25.314812 kernel: watchdog: NMI not fully supported Dec 16 12:32:25.314820 kernel: watchdog: Hard watchdog permanently disabled Dec 16 12:32:25.314828 kernel: NET: Registered PF_INET6 protocol family Dec 16 12:32:25.314835 kernel: Segment Routing with IPv6 Dec 16 12:32:25.314843 kernel: In-situ OAM (IOAM) with IPv6 Dec 16 12:32:25.314851 kernel: NET: Registered PF_PACKET protocol family Dec 16 12:32:25.314859 kernel: Key type dns_resolver registered Dec 16 12:32:25.314868 kernel: registered taskstats version 1 Dec 16 12:32:25.314876 kernel: Loading compiled-in X.509 certificates Dec 16 12:32:25.314884 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.61-flatcar: 545838337a91b65b763486e536766b3eec3ef99d' Dec 16 12:32:25.314892 kernel: Demotion targets for Node 0: null Dec 16 12:32:25.314900 kernel: Key type .fscrypt registered Dec 16 12:32:25.314908 kernel: Key type fscrypt-provisioning registered Dec 16 12:32:25.314916 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 16 12:32:25.314926 kernel: ima: Allocated hash algorithm: sha1 Dec 16 12:32:25.314934 kernel: ima: No architecture policies found Dec 16 12:32:25.314942 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 16 12:32:25.314949 kernel: clk: Disabling unused clocks Dec 16 12:32:25.314957 kernel: PM: genpd: Disabling unused power domains Dec 16 12:32:25.314965 kernel: Freeing unused kernel memory: 12480K Dec 16 12:32:25.314972 kernel: Run /init as init process Dec 16 12:32:25.314995 kernel: with arguments: Dec 16 12:32:25.315003 kernel: /init Dec 16 12:32:25.315010 kernel: with environment: Dec 16 12:32:25.315018 kernel: HOME=/ Dec 16 12:32:25.315026 kernel: TERM=linux Dec 16 12:32:25.315125 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 16 12:32:25.315210 kernel: virtio_blk virtio1: [vda] 27000832 512-byte logical blocks (13.8 GB/12.9 GiB) Dec 16 12:32:25.315223 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Dec 16 12:32:25.315231 kernel: GPT:16515071 != 27000831 Dec 16 12:32:25.315239 kernel: GPT:Alternate GPT header not at the end of the disk. Dec 16 12:32:25.315246 kernel: GPT:16515071 != 27000831 Dec 16 12:32:25.315253 kernel: GPT: Use GNU Parted to correct GPT errors. Dec 16 12:32:25.315260 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:32:25.315286 kernel: SCSI subsystem initialized Dec 16 12:32:25.315295 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 16 12:32:25.315303 kernel: device-mapper: uevent: version 1.0.3 Dec 16 12:32:25.315312 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Dec 16 12:32:25.315319 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Dec 16 12:32:25.315327 kernel: raid6: neonx8 gen() 15621 MB/s Dec 16 12:32:25.315335 kernel: raid6: neonx4 gen() 15410 MB/s Dec 16 12:32:25.315344 kernel: raid6: neonx2 gen() 10410 MB/s Dec 16 12:32:25.315352 kernel: raid6: neonx1 gen() 8929 MB/s Dec 16 12:32:25.315359 kernel: raid6: int64x8 gen() 6818 MB/s Dec 16 12:32:25.315367 kernel: raid6: int64x4 gen() 7193 MB/s Dec 16 12:32:25.315375 kernel: raid6: int64x2 gen() 5750 MB/s Dec 16 12:32:25.315382 kernel: raid6: int64x1 gen() 5020 MB/s Dec 16 12:32:25.315390 kernel: raid6: using algorithm neonx8 gen() 15621 MB/s Dec 16 12:32:25.315399 kernel: raid6: .... xor() 12040 MB/s, rmw enabled Dec 16 12:32:25.315407 kernel: raid6: using neon recovery algorithm Dec 16 12:32:25.315415 kernel: xor: measuring software checksum speed Dec 16 12:32:25.315430 kernel: 8regs : 14921 MB/sec Dec 16 12:32:25.315438 kernel: 32regs : 21676 MB/sec Dec 16 12:32:25.315446 kernel: arm64_neon : 25083 MB/sec Dec 16 12:32:25.315454 kernel: xor: using function: arm64_neon (25083 MB/sec) Dec 16 12:32:25.315462 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 16 12:32:25.315472 kernel: BTRFS: device fsid d00a2bc5-1c68-4957-aa37-d070193fcf05 devid 1 transid 36 /dev/mapper/usr (253:0) scanned by mount (207) Dec 16 12:32:25.315480 kernel: BTRFS info (device dm-0): first mount of filesystem d00a2bc5-1c68-4957-aa37-d070193fcf05 Dec 16 12:32:25.315488 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:32:25.315496 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 16 12:32:25.315504 kernel: BTRFS info (device dm-0): enabling free space tree Dec 16 12:32:25.315511 kernel: loop: module loaded Dec 16 12:32:25.315519 kernel: loop0: detected capacity change from 0 to 91832 Dec 16 12:32:25.315528 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 16 12:32:25.315536 systemd[1]: Successfully made /usr/ read-only. Dec 16 12:32:25.315547 systemd[1]: systemd 257.9 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) Dec 16 12:32:25.315556 systemd[1]: Detected virtualization kvm. Dec 16 12:32:25.315564 systemd[1]: Detected architecture arm64. Dec 16 12:32:25.315574 systemd[1]: Running in initrd. Dec 16 12:32:25.315581 systemd[1]: No hostname configured, using default hostname. Dec 16 12:32:25.315590 systemd[1]: Hostname set to . Dec 16 12:32:25.315598 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Dec 16 12:32:25.315606 systemd[1]: Queued start job for default target initrd.target. Dec 16 12:32:25.315614 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Dec 16 12:32:25.315622 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:32:25.315632 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:32:25.315641 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 16 12:32:25.315649 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:32:25.315658 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 16 12:32:25.315666 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 16 12:32:25.315677 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:32:25.315685 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:32:25.315703 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:32:25.315712 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:32:25.315720 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:32:25.315729 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:32:25.315737 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:32:25.315748 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:32:25.315756 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:32:25.315765 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Dec 16 12:32:25.315773 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 16 12:32:25.315788 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Dec 16 12:32:25.315800 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:32:25.315809 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:32:25.315819 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:32:25.315827 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:32:25.315836 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 16 12:32:25.315844 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 16 12:32:25.315853 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:32:25.315863 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 16 12:32:25.315871 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). Dec 16 12:32:25.315880 systemd[1]: Starting systemd-fsck-usr.service... Dec 16 12:32:25.315888 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:32:25.315896 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:32:25.315907 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:32:25.315916 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 16 12:32:25.315924 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:32:25.315933 systemd[1]: Finished systemd-fsck-usr.service. Dec 16 12:32:25.315941 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:32:25.315951 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Dec 16 12:32:25.315981 systemd-journald[347]: Collecting audit messages is enabled. Dec 16 12:32:25.316003 kernel: Bridge firewalling registered Dec 16 12:32:25.316013 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:32:25.316023 kernel: audit: type=1130 audit(1765888345.312:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.316031 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:32:25.316041 systemd-journald[347]: Journal started Dec 16 12:32:25.316060 systemd-journald[347]: Runtime Journal (/run/log/journal/125c2ce77f7447a7be58dbb8df6d6e76) is 6M, max 48.5M, 42.4M free. Dec 16 12:32:25.312000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.310249 systemd-modules-load[348]: Inserted module 'br_netfilter' Dec 16 12:32:25.320737 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:32:25.320000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.323724 kernel: audit: type=1130 audit(1765888345.320:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.326792 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:32:25.327000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.331169 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:32:25.336690 kernel: audit: type=1130 audit(1765888345.327:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.336730 kernel: audit: type=1130 audit(1765888345.332:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.332000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.336275 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 16 12:32:25.338854 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:32:25.340765 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:32:25.348119 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:32:25.348000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.353715 kernel: audit: type=1130 audit(1765888345.348:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.353762 kernel: audit: type=1334 audit(1765888345.349:7): prog-id=6 op=LOAD Dec 16 12:32:25.349000 audit: BPF prog-id=6 op=LOAD Dec 16 12:32:25.351015 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:32:25.353015 systemd-tmpfiles[370]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Dec 16 12:32:25.360769 kernel: audit: type=1130 audit(1765888345.356:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.356000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.355772 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:32:25.360874 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:32:25.362000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.366715 kernel: audit: type=1130 audit(1765888345.362:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.373438 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:32:25.373000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.376095 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 16 12:32:25.380061 kernel: audit: type=1130 audit(1765888345.373:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.400369 systemd-resolved[375]: Positive Trust Anchors: Dec 16 12:32:25.400391 systemd-resolved[375]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:32:25.402747 dracut-cmdline[389]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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 acpi=force verity.usrhash=756b815c2fd7ac2947efceb2a88878d1ea9723ec85037c2b4d1a09bd798bb749 Dec 16 12:32:25.400395 systemd-resolved[375]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Dec 16 12:32:25.400434 systemd-resolved[375]: 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 Dec 16 12:32:25.425428 systemd-resolved[375]: Defaulting to hostname 'linux'. Dec 16 12:32:25.426342 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:32:25.426000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.427446 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:32:25.484732 kernel: Loading iSCSI transport class v2.0-870. Dec 16 12:32:25.493740 kernel: iscsi: registered transport (tcp) Dec 16 12:32:25.507981 kernel: iscsi: registered transport (qla4xxx) Dec 16 12:32:25.508045 kernel: QLogic iSCSI HBA Driver Dec 16 12:32:25.530470 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:32:25.555030 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:32:25.555000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.557281 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:32:25.608804 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 16 12:32:25.609000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.611030 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 16 12:32:25.612788 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 16 12:32:25.653638 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:32:25.654000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.655000 audit: BPF prog-id=7 op=LOAD Dec 16 12:32:25.655000 audit: BPF prog-id=8 op=LOAD Dec 16 12:32:25.656750 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:32:25.688630 systemd-udevd[623]: Using default interface naming scheme 'v257'. Dec 16 12:32:25.697586 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:32:25.698000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.700498 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 16 12:32:25.726068 dracut-pre-trigger[695]: rd.md=0: removing MD RAID activation Dec 16 12:32:25.732473 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:32:25.733000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.734000 audit: BPF prog-id=9 op=LOAD Dec 16 12:32:25.735398 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:32:25.759230 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:32:25.759000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.761706 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:32:25.782982 systemd-networkd[743]: lo: Link UP Dec 16 12:32:25.782991 systemd-networkd[743]: lo: Gained carrier Dec 16 12:32:25.783000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.783497 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:32:25.784775 systemd[1]: Reached target network.target - Network. Dec 16 12:32:25.824741 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:32:25.825000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.829503 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 16 12:32:25.861076 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Dec 16 12:32:25.870763 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 16 12:32:25.871000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.888617 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 16 12:32:25.896996 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:32:25.903758 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 16 12:32:25.905112 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:32:25.907343 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:32:25.910828 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:32:25.913778 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 16 12:32:25.917906 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 16 12:32:25.925887 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:32:25.927000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.926027 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:32:25.928232 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:32:25.930556 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:32:25.936721 disk-uuid[809]: Primary Header is updated. Dec 16 12:32:25.936721 disk-uuid[809]: Secondary Entries is updated. Dec 16 12:32:25.936721 disk-uuid[809]: Secondary Header is updated. Dec 16 12:32:25.942388 systemd-networkd[743]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Dec 16 12:32:25.942401 systemd-networkd[743]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:32:25.944887 systemd-networkd[743]: eth0: Link UP Dec 16 12:32:25.945040 systemd-networkd[743]: eth0: Gained carrier Dec 16 12:32:25.945053 systemd-networkd[743]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Dec 16 12:32:25.950000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:25.946963 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:32:25.959789 systemd-networkd[743]: eth0: DHCPv4 address 10.0.0.133/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:32:25.962385 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:32:25.962000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:26.970417 disk-uuid[815]: Warning: The kernel is still using the old partition table. Dec 16 12:32:26.970417 disk-uuid[815]: The new table will be used at the next reboot or after you Dec 16 12:32:26.970417 disk-uuid[815]: run partprobe(8) or kpartx(8) Dec 16 12:32:26.970417 disk-uuid[815]: The operation has completed successfully. Dec 16 12:32:26.975289 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 16 12:32:26.975000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:26.975000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:26.975402 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 16 12:32:26.977662 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 16 12:32:27.007719 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (830) Dec 16 12:32:27.009997 kernel: BTRFS info (device vda6): first mount of filesystem eb4bb268-dde2-45a9-b660-8899d8790a47 Dec 16 12:32:27.010031 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:32:27.013719 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:32:27.013750 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:32:27.021742 kernel: BTRFS info (device vda6): last unmount of filesystem eb4bb268-dde2-45a9-b660-8899d8790a47 Dec 16 12:32:27.022244 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 16 12:32:27.022000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.024325 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 16 12:32:27.125408 ignition[849]: Ignition 2.24.0 Dec 16 12:32:27.125434 ignition[849]: Stage: fetch-offline Dec 16 12:32:27.125480 ignition[849]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:27.125490 ignition[849]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:27.125644 ignition[849]: parsed url from cmdline: "" Dec 16 12:32:27.125647 ignition[849]: no config URL provided Dec 16 12:32:27.125652 ignition[849]: reading system config file "/usr/lib/ignition/user.ign" Dec 16 12:32:27.125661 ignition[849]: no config at "/usr/lib/ignition/user.ign" Dec 16 12:32:27.125721 ignition[849]: op(1): [started] loading QEMU firmware config module Dec 16 12:32:27.125725 ignition[849]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 16 12:32:27.131443 ignition[849]: op(1): [finished] loading QEMU firmware config module Dec 16 12:32:27.138601 ignition[849]: parsing config with SHA512: 64b233a2d51e8c6ce654b1eed73cfd11a08a8b6582c5f516aceedb1d1dc327192481d14d96cd78b55640626b7077e5d78c82e2111a86d352e4dc0562b4dde224 Dec 16 12:32:27.143771 unknown[849]: fetched base config from "system" Dec 16 12:32:27.143787 unknown[849]: fetched user config from "qemu" Dec 16 12:32:27.144138 ignition[849]: fetch-offline: fetch-offline passed Dec 16 12:32:27.144220 ignition[849]: Ignition finished successfully Dec 16 12:32:27.147000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.146502 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:32:27.148125 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Dec 16 12:32:27.148996 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 16 12:32:27.177353 ignition[862]: Ignition 2.24.0 Dec 16 12:32:27.177371 ignition[862]: Stage: kargs Dec 16 12:32:27.177531 ignition[862]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:27.177542 ignition[862]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:27.178163 ignition[862]: kargs: kargs passed Dec 16 12:32:27.178208 ignition[862]: Ignition finished successfully Dec 16 12:32:27.181551 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 16 12:32:27.184000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.186623 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 16 12:32:27.219544 ignition[869]: Ignition 2.24.0 Dec 16 12:32:27.219560 ignition[869]: Stage: disks Dec 16 12:32:27.219735 ignition[869]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:27.219745 ignition[869]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:27.220329 ignition[869]: disks: disks passed Dec 16 12:32:27.220371 ignition[869]: Ignition finished successfully Dec 16 12:32:27.224171 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 16 12:32:27.224000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.225675 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 16 12:32:27.227096 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 16 12:32:27.228781 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:32:27.230399 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:32:27.231838 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:32:27.234101 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 16 12:32:27.266881 systemd-fsck[878]: ROOT: clean, 15/456736 files, 38230/456704 blocks Dec 16 12:32:27.288129 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 16 12:32:27.290000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.293727 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 16 12:32:27.363725 kernel: EXT4-fs (vda9): mounted filesystem 0e69f709-36a9-4e15-b0c9-c7e150185653 r/w with ordered data mode. Quota mode: none. Dec 16 12:32:27.363838 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 16 12:32:27.364976 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 16 12:32:27.367255 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:32:27.368769 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 16 12:32:27.369651 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Dec 16 12:32:27.369688 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Dec 16 12:32:27.369731 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:32:27.383531 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 16 12:32:27.385729 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 16 12:32:27.390183 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (886) Dec 16 12:32:27.390215 kernel: BTRFS info (device vda6): first mount of filesystem eb4bb268-dde2-45a9-b660-8899d8790a47 Dec 16 12:32:27.390228 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:32:27.393806 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:32:27.393848 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:32:27.394872 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:32:27.506003 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 16 12:32:27.506000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.508218 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 16 12:32:27.509788 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 16 12:32:27.524869 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 16 12:32:27.526477 kernel: BTRFS info (device vda6): last unmount of filesystem eb4bb268-dde2-45a9-b660-8899d8790a47 Dec 16 12:32:27.537878 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 16 12:32:27.537000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.549568 ignition[985]: INFO : Ignition 2.24.0 Dec 16 12:32:27.549568 ignition[985]: INFO : Stage: mount Dec 16 12:32:27.551066 ignition[985]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:27.551066 ignition[985]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:27.551066 ignition[985]: INFO : mount: mount passed Dec 16 12:32:27.551066 ignition[985]: INFO : Ignition finished successfully Dec 16 12:32:27.552000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:27.551924 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 16 12:32:27.554522 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 16 12:32:27.974884 systemd-networkd[743]: eth0: Gained IPv6LL Dec 16 12:32:28.365373 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:32:28.394730 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (996) Dec 16 12:32:28.396995 kernel: BTRFS info (device vda6): first mount of filesystem eb4bb268-dde2-45a9-b660-8899d8790a47 Dec 16 12:32:28.397012 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:32:28.399719 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:32:28.399740 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:32:28.401097 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:32:28.429379 ignition[1014]: INFO : Ignition 2.24.0 Dec 16 12:32:28.429379 ignition[1014]: INFO : Stage: files Dec 16 12:32:28.431069 ignition[1014]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:28.431069 ignition[1014]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:28.431069 ignition[1014]: DEBUG : files: compiled without relabeling support, skipping Dec 16 12:32:28.434307 ignition[1014]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 16 12:32:28.434307 ignition[1014]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 16 12:32:28.437192 ignition[1014]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 16 12:32:28.437192 ignition[1014]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 16 12:32:28.437192 ignition[1014]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 16 12:32:28.437192 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Dec 16 12:32:28.437192 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Dec 16 12:32:28.434901 unknown[1014]: wrote ssh authorized keys file for user: core Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Dec 16 12:32:28.445585 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.1-arm64.raw: attempt #1 Dec 16 12:32:29.075541 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Dec 16 12:32:29.269779 ignition[1014]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Dec 16 12:32:29.269779 ignition[1014]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Dec 16 12:32:29.273532 ignition[1014]: INFO : files: op(7): op(8): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:32:29.273532 ignition[1014]: INFO : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:32:29.273532 ignition[1014]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Dec 16 12:32:29.273532 ignition[1014]: INFO : files: op(9): [started] setting preset to disabled for "coreos-metadata.service" Dec 16 12:32:29.287302 ignition[1014]: INFO : files: op(9): op(a): [started] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:32:29.290901 ignition[1014]: INFO : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:32:29.293553 ignition[1014]: INFO : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service" Dec 16 12:32:29.293553 ignition[1014]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:32:29.293553 ignition[1014]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:32:29.293553 ignition[1014]: INFO : files: files passed Dec 16 12:32:29.293553 ignition[1014]: INFO : Ignition finished successfully Dec 16 12:32:29.303492 kernel: kauditd_printk_skb: 26 callbacks suppressed Dec 16 12:32:29.303525 kernel: audit: type=1130 audit(1765888349.295:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.295000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.294647 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 16 12:32:29.300101 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 16 12:32:29.303052 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 16 12:32:29.319629 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 16 12:32:29.319756 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 16 12:32:29.322000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.324673 initrd-setup-root-after-ignition[1044]: grep: /sysroot/oem/oem-release: No such file or directory Dec 16 12:32:29.329101 kernel: audit: type=1130 audit(1765888349.322:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.329132 kernel: audit: type=1131 audit(1765888349.322:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.322000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.329199 initrd-setup-root-after-ignition[1046]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:32:29.329199 initrd-setup-root-after-ignition[1046]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:32:29.332014 initrd-setup-root-after-ignition[1050]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:32:29.331280 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:32:29.338804 kernel: audit: type=1130 audit(1765888349.332:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.332000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.333302 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 16 12:32:29.338595 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 16 12:32:29.375681 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 16 12:32:29.376771 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 16 12:32:29.383183 kernel: audit: type=1130 audit(1765888349.377:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.383210 kernel: audit: type=1131 audit(1765888349.377:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.377000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.377000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.378039 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 16 12:32:29.384045 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 16 12:32:29.385843 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 16 12:32:29.386767 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 16 12:32:29.414271 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:32:29.415000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.416556 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 16 12:32:29.419953 kernel: audit: type=1130 audit(1765888349.415:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.440261 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Dec 16 12:32:29.440479 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:32:29.442273 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:32:29.443905 systemd[1]: Stopped target timers.target - Timer Units. Dec 16 12:32:29.445342 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 16 12:32:29.446000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.445484 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:32:29.450476 kernel: audit: type=1131 audit(1765888349.446:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.449599 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 16 12:32:29.451368 systemd[1]: Stopped target basic.target - Basic System. Dec 16 12:32:29.452722 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 16 12:32:29.454191 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:32:29.455814 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 16 12:32:29.457546 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:32:29.459188 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 16 12:32:29.460655 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:32:29.462330 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 16 12:32:29.463941 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 16 12:32:29.465387 systemd[1]: Stopped target swap.target - Swaps. Dec 16 12:32:29.466642 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 16 12:32:29.470743 kernel: audit: type=1131 audit(1765888349.467:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.467000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.466855 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:32:29.470859 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:32:29.472548 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:32:29.474206 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 16 12:32:29.477792 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:32:29.478824 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 16 12:32:29.480000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.483733 kernel: audit: type=1131 audit(1765888349.480:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.478944 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 16 12:32:29.483774 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 16 12:32:29.485000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.483902 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:32:29.485639 systemd[1]: Stopped target paths.target - Path Units. Dec 16 12:32:29.486972 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 16 12:32:29.487070 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:32:29.488907 systemd[1]: Stopped target slices.target - Slice Units. Dec 16 12:32:29.490298 systemd[1]: Stopped target sockets.target - Socket Units. Dec 16 12:32:29.491883 systemd[1]: iscsid.socket: Deactivated successfully. Dec 16 12:32:29.491966 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:32:29.498000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.493825 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 16 12:32:29.500000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.493904 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:32:29.495279 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Dec 16 12:32:29.495352 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Dec 16 12:32:29.496942 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 16 12:32:29.505000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.497065 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:32:29.507000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.498678 systemd[1]: ignition-files.service: Deactivated successfully. Dec 16 12:32:29.509000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.498808 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 16 12:32:29.501202 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 16 12:32:29.503258 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 16 12:32:29.504044 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 16 12:32:29.504162 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:32:29.505838 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 16 12:32:29.505942 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:32:29.507622 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 16 12:32:29.507735 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:32:29.513197 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 16 12:32:29.518907 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 16 12:32:29.519000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.519000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.529463 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 16 12:32:29.532040 ignition[1070]: INFO : Ignition 2.24.0 Dec 16 12:32:29.532040 ignition[1070]: INFO : Stage: umount Dec 16 12:32:29.533514 ignition[1070]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:32:29.533514 ignition[1070]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:32:29.533514 ignition[1070]: INFO : umount: umount passed Dec 16 12:32:29.533514 ignition[1070]: INFO : Ignition finished successfully Dec 16 12:32:29.536000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.534517 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 16 12:32:29.538000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.534618 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 16 12:32:29.539000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.536359 systemd[1]: Stopped target network.target - Network. Dec 16 12:32:29.541000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.537477 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 16 12:32:29.543000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.537535 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 16 12:32:29.539113 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 16 12:32:29.539161 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 16 12:32:29.540567 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 16 12:32:29.555000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.540617 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 16 12:32:29.557000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.542109 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 16 12:32:29.542152 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 16 12:32:29.543938 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 16 12:32:29.552435 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 16 12:32:29.555255 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 16 12:32:29.563000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.564000 audit: BPF prog-id=6 op=UNLOAD Dec 16 12:32:29.555335 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 16 12:32:29.556888 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 16 12:32:29.556973 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 16 12:32:29.566000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.561357 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 16 12:32:29.561509 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 16 12:32:29.565683 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 16 12:32:29.565814 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 16 12:32:29.570000 audit: BPF prog-id=9 op=UNLOAD Dec 16 12:32:29.570722 systemd[1]: Stopped target network-pre.target - Preparation for Network. Dec 16 12:32:29.572559 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 16 12:32:29.572599 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:32:29.574910 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 16 12:32:29.576376 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 16 12:32:29.577000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.576457 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:32:29.579000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.578271 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 16 12:32:29.580000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.578325 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:32:29.579793 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 16 12:32:29.579840 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 16 12:32:29.581613 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:32:29.591146 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 16 12:32:29.591295 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:32:29.592000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.593588 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 16 12:32:29.593631 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 16 12:32:29.595275 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 16 12:32:29.597000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.595303 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:32:29.596757 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 16 12:32:29.600000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.596808 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:32:29.599427 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 16 12:32:29.602000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.599480 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 16 12:32:29.601722 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 16 12:32:29.601774 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:32:29.605021 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 16 12:32:29.608000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.606664 systemd[1]: systemd-network-generator.service: Deactivated successfully. Dec 16 12:32:29.609000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.606742 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:32:29.611000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.608892 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 16 12:32:29.614000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.608946 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:32:29.616000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.610742 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Dec 16 12:32:29.610788 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:32:29.612591 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 16 12:32:29.612634 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:32:29.614724 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:32:29.614778 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:32:29.623640 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 16 12:32:29.623780 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 16 12:32:29.625000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.625000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.626038 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 16 12:32:29.627000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:29.626154 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 16 12:32:29.627946 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 16 12:32:29.629837 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 16 12:32:29.647467 systemd[1]: Switching root. Dec 16 12:32:29.675684 systemd-journald[347]: Journal stopped Dec 16 12:32:30.467497 systemd-journald[347]: Received SIGTERM from PID 1 (systemd). Dec 16 12:32:30.467552 kernel: SELinux: policy capability network_peer_controls=1 Dec 16 12:32:30.467571 kernel: SELinux: policy capability open_perms=1 Dec 16 12:32:30.467581 kernel: SELinux: policy capability extended_socket_class=1 Dec 16 12:32:30.467591 kernel: SELinux: policy capability always_check_network=0 Dec 16 12:32:30.467601 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 16 12:32:30.467611 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 16 12:32:30.467633 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 16 12:32:30.467643 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 16 12:32:30.467656 kernel: SELinux: policy capability userspace_initial_context=0 Dec 16 12:32:30.467666 systemd[1]: Successfully loaded SELinux policy in 60.551ms. Dec 16 12:32:30.467680 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.484ms. Dec 16 12:32:30.467703 systemd[1]: systemd 257.9 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) Dec 16 12:32:30.467720 systemd[1]: Detected virtualization kvm. Dec 16 12:32:30.467732 systemd[1]: Detected architecture arm64. Dec 16 12:32:30.467742 systemd[1]: Detected first boot. Dec 16 12:32:30.467757 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Dec 16 12:32:30.467768 zram_generator::config[1115]: No configuration found. Dec 16 12:32:30.467780 kernel: NET: Registered PF_VSOCK protocol family Dec 16 12:32:30.467791 systemd[1]: Populated /etc with preset unit settings. Dec 16 12:32:30.467802 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 16 12:32:30.467815 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 16 12:32:30.467829 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 16 12:32:30.467842 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 16 12:32:30.467853 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 16 12:32:30.467864 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 16 12:32:30.467877 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 16 12:32:30.467888 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 16 12:32:30.467900 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 16 12:32:30.467912 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 16 12:32:30.467923 systemd[1]: Created slice user.slice - User and Session Slice. Dec 16 12:32:30.467934 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:32:30.467947 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:32:30.467959 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 16 12:32:30.467971 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 16 12:32:30.467983 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 16 12:32:30.467994 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:32:30.468005 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 16 12:32:30.468016 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:32:30.468027 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:32:30.468040 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 16 12:32:30.468051 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 16 12:32:30.468062 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 16 12:32:30.468081 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 16 12:32:30.468096 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:32:30.468107 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:32:30.468120 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Dec 16 12:32:30.468131 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:32:30.468142 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:32:30.468153 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 16 12:32:30.468164 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 16 12:32:30.468182 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Dec 16 12:32:30.468194 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Dec 16 12:32:30.468207 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Dec 16 12:32:30.468218 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:32:30.468229 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Dec 16 12:32:30.468241 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Dec 16 12:32:30.468253 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:32:30.468282 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:32:30.468295 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 16 12:32:30.468307 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 16 12:32:30.468323 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 16 12:32:30.468335 systemd[1]: Mounting media.mount - External Media Directory... Dec 16 12:32:30.468346 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 16 12:32:30.468357 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 16 12:32:30.468368 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 16 12:32:30.468380 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). Dec 16 12:32:30.468393 systemd[1]: Reached target machines.target - Containers. Dec 16 12:32:30.468414 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 16 12:32:30.468427 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:32:30.468443 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:32:30.468454 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 16 12:32:30.468465 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:32:30.468476 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:32:30.468489 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:32:30.468499 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 16 12:32:30.468511 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:32:30.468522 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 16 12:32:30.468533 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 16 12:32:30.468546 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 16 12:32:30.468557 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 16 12:32:30.468568 systemd[1]: Stopped systemd-fsck-usr.service. Dec 16 12:32:30.468580 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). Dec 16 12:32:30.468591 kernel: fuse: init (API version 7.41) Dec 16 12:32:30.468603 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:32:30.468615 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:32:30.468626 kernel: ACPI: bus type drm_connector registered Dec 16 12:32:30.468637 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:32:30.468648 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 16 12:32:30.468659 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Dec 16 12:32:30.468671 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:32:30.468684 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 16 12:32:30.468734 systemd-journald[1182]: Collecting audit messages is enabled. Dec 16 12:32:30.468758 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 16 12:32:30.468769 systemd-journald[1182]: Journal started Dec 16 12:32:30.468791 systemd-journald[1182]: Runtime Journal (/run/log/journal/125c2ce77f7447a7be58dbb8df6d6e76) is 6M, max 48.5M, 42.4M free. Dec 16 12:32:30.325000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Dec 16 12:32:30.422000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.425000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.427000 audit: BPF prog-id=14 op=UNLOAD Dec 16 12:32:30.427000 audit: BPF prog-id=13 op=UNLOAD Dec 16 12:32:30.428000 audit: BPF prog-id=15 op=LOAD Dec 16 12:32:30.429000 audit: BPF prog-id=16 op=LOAD Dec 16 12:32:30.429000 audit: BPF prog-id=17 op=LOAD Dec 16 12:32:30.465000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Dec 16 12:32:30.465000 audit[1182]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=fffff46f85f0 a2=4000 a3=0 items=0 ppid=1 pid=1182 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 16 12:32:30.465000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Dec 16 12:32:30.235077 systemd[1]: Queued start job for default target multi-user.target. Dec 16 12:32:30.255823 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Dec 16 12:32:30.256294 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 16 12:32:30.472268 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:32:30.471000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.473357 systemd[1]: Mounted media.mount - External Media Directory. Dec 16 12:32:30.474443 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 16 12:32:30.475572 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 16 12:32:30.476928 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 16 12:32:30.481876 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 16 12:32:30.482000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.483477 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:32:30.485000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.486116 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 16 12:32:30.486301 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 16 12:32:30.486000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.486000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.489755 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:32:30.489965 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:32:30.490000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.490000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.491309 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:32:30.491495 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:32:30.491000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.491000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.492831 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:32:30.493005 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:32:30.493000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.493000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.494324 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 16 12:32:30.494513 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 16 12:32:30.496000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.496000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.497095 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:32:30.497254 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:32:30.497000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.497000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.498620 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:32:30.499000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.500267 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:32:30.500000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.502451 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 16 12:32:30.503000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.504411 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Dec 16 12:32:30.506000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.518586 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:32:30.520066 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Dec 16 12:32:30.522380 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 16 12:32:30.524384 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 16 12:32:30.525480 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 16 12:32:30.525514 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:32:30.527302 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Dec 16 12:32:30.529040 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:32:30.529163 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Dec 16 12:32:30.541679 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 16 12:32:30.544921 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 16 12:32:30.545986 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:32:30.547241 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 16 12:32:30.548637 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:32:30.552037 systemd-journald[1182]: Time spent on flushing to /var/log/journal/125c2ce77f7447a7be58dbb8df6d6e76 is 13.884ms for 986 entries. Dec 16 12:32:30.552037 systemd-journald[1182]: System Journal (/var/log/journal/125c2ce77f7447a7be58dbb8df6d6e76) is 8M, max 163.5M, 155.5M free. Dec 16 12:32:30.573433 systemd-journald[1182]: Received client request to flush runtime journal. Dec 16 12:32:30.561000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.550838 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:32:30.552788 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 16 12:32:30.556503 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:32:30.560266 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:32:30.561553 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 16 12:32:30.562706 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 16 12:32:30.576784 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 16 12:32:30.577000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.578336 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 16 12:32:30.578000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.583038 kernel: loop1: detected capacity change from 0 to 45344 Dec 16 12:32:30.582384 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 16 12:32:30.587855 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Dec 16 12:32:30.592313 systemd-tmpfiles[1233]: ACLs are not supported, ignoring. Dec 16 12:32:30.592332 systemd-tmpfiles[1233]: ACLs are not supported, ignoring. Dec 16 12:32:30.595894 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:32:30.596000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.603042 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:32:30.606967 kernel: loop2: detected capacity change from 0 to 200800 Dec 16 12:32:30.604000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.607857 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 16 12:32:30.620883 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Dec 16 12:32:30.621000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.631726 kernel: loop3: detected capacity change from 0 to 100192 Dec 16 12:32:30.640076 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 16 12:32:30.640000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.641000 audit: BPF prog-id=18 op=LOAD Dec 16 12:32:30.641000 audit: BPF prog-id=19 op=LOAD Dec 16 12:32:30.641000 audit: BPF prog-id=20 op=LOAD Dec 16 12:32:30.643081 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Dec 16 12:32:30.644000 audit: BPF prog-id=21 op=LOAD Dec 16 12:32:30.645565 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:32:30.647472 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:32:30.650000 audit: BPF prog-id=22 op=LOAD Dec 16 12:32:30.651721 kernel: loop4: detected capacity change from 0 to 45344 Dec 16 12:32:30.650000 audit: BPF prog-id=23 op=LOAD Dec 16 12:32:30.650000 audit: BPF prog-id=24 op=LOAD Dec 16 12:32:30.652153 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Dec 16 12:32:30.653000 audit: BPF prog-id=25 op=LOAD Dec 16 12:32:30.653000 audit: BPF prog-id=26 op=LOAD Dec 16 12:32:30.653000 audit: BPF prog-id=27 op=LOAD Dec 16 12:32:30.654389 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 16 12:32:30.661735 kernel: loop5: detected capacity change from 0 to 200800 Dec 16 12:32:30.669717 kernel: loop6: detected capacity change from 0 to 100192 Dec 16 12:32:30.673486 (sd-merge)[1257]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'kubernetes.raw'. Dec 16 12:32:30.676958 (sd-merge)[1257]: Merged extensions into '/usr'. Dec 16 12:32:30.685027 systemd-tmpfiles[1256]: ACLs are not supported, ignoring. Dec 16 12:32:30.685044 systemd-tmpfiles[1256]: ACLs are not supported, ignoring. Dec 16 12:32:30.688114 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:32:30.689000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.689580 systemd[1]: Reload requested from client PID 1232 ('systemd-sysext') (unit systemd-sysext.service)... Dec 16 12:32:30.689592 systemd[1]: Reloading... Dec 16 12:32:30.696251 systemd-nsresourced[1258]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Dec 16 12:32:30.745824 zram_generator::config[1299]: No configuration found. Dec 16 12:32:30.788151 systemd-oomd[1254]: No swap; memory pressure usage will be degraded Dec 16 12:32:30.789487 systemd-resolved[1255]: Positive Trust Anchors: Dec 16 12:32:30.789503 systemd-resolved[1255]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:32:30.789507 systemd-resolved[1255]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Dec 16 12:32:30.789538 systemd-resolved[1255]: 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 Dec 16 12:32:30.796910 systemd-resolved[1255]: Defaulting to hostname 'linux'. Dec 16 12:32:30.906450 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 16 12:32:30.906924 systemd[1]: Reloading finished in 216 ms. Dec 16 12:32:30.941389 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Dec 16 12:32:30.941000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.942674 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 16 12:32:30.942000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.943818 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Dec 16 12:32:30.944000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.944954 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:32:30.945000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.946220 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 16 12:32:30.946000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.951297 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:32:30.971154 systemd[1]: Starting ensure-sysext.service... Dec 16 12:32:30.973348 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:32:30.974000 audit: BPF prog-id=28 op=LOAD Dec 16 12:32:30.974000 audit: BPF prog-id=25 op=UNLOAD Dec 16 12:32:30.974000 audit: BPF prog-id=29 op=LOAD Dec 16 12:32:30.974000 audit: BPF prog-id=30 op=LOAD Dec 16 12:32:30.974000 audit: BPF prog-id=26 op=UNLOAD Dec 16 12:32:30.974000 audit: BPF prog-id=27 op=UNLOAD Dec 16 12:32:30.986000 audit: BPF prog-id=31 op=LOAD Dec 16 12:32:30.986000 audit: BPF prog-id=15 op=UNLOAD Dec 16 12:32:30.986000 audit: BPF prog-id=32 op=LOAD Dec 16 12:32:30.986000 audit: BPF prog-id=33 op=LOAD Dec 16 12:32:30.986000 audit: BPF prog-id=16 op=UNLOAD Dec 16 12:32:30.986000 audit: BPF prog-id=17 op=UNLOAD Dec 16 12:32:30.987000 audit: BPF prog-id=34 op=LOAD Dec 16 12:32:30.987000 audit: BPF prog-id=21 op=UNLOAD Dec 16 12:32:30.988000 audit: BPF prog-id=35 op=LOAD Dec 16 12:32:30.988000 audit: BPF prog-id=18 op=UNLOAD Dec 16 12:32:30.988000 audit: BPF prog-id=36 op=LOAD Dec 16 12:32:30.988000 audit: BPF prog-id=37 op=LOAD Dec 16 12:32:30.988000 audit: BPF prog-id=19 op=UNLOAD Dec 16 12:32:30.988000 audit: BPF prog-id=20 op=UNLOAD Dec 16 12:32:30.989000 audit: BPF prog-id=38 op=LOAD Dec 16 12:32:30.989000 audit: BPF prog-id=22 op=UNLOAD Dec 16 12:32:30.989000 audit: BPF prog-id=39 op=LOAD Dec 16 12:32:30.989000 audit: BPF prog-id=40 op=LOAD Dec 16 12:32:30.989000 audit: BPF prog-id=23 op=UNLOAD Dec 16 12:32:30.989000 audit: BPF prog-id=24 op=UNLOAD Dec 16 12:32:30.994767 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 16 12:32:30.995000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:30.996377 systemd-tmpfiles[1338]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Dec 16 12:32:30.996427 systemd-tmpfiles[1338]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Dec 16 12:32:30.997021 systemd-tmpfiles[1338]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 16 12:32:30.998023 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. Dec 16 12:32:30.998080 systemd-tmpfiles[1338]: ACLs are not supported, ignoring. Dec 16 12:32:30.998000 audit: BPF prog-id=8 op=UNLOAD Dec 16 12:32:30.998000 audit: BPF prog-id=7 op=UNLOAD Dec 16 12:32:30.998000 audit: BPF prog-id=41 op=LOAD Dec 16 12:32:30.998000 audit: BPF prog-id=42 op=LOAD Dec 16 12:32:31.000959 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:32:31.002451 systemd[1]: Reload requested from client PID 1337 ('systemctl') (unit ensure-sysext.service)... Dec 16 12:32:31.002466 systemd[1]: Reloading... Dec 16 12:32:31.002681 systemd-tmpfiles[1338]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:32:31.002707 systemd-tmpfiles[1338]: Skipping /boot Dec 16 12:32:31.009818 systemd-tmpfiles[1338]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:32:31.009833 systemd-tmpfiles[1338]: Skipping /boot Dec 16 12:32:31.035434 systemd-udevd[1341]: Using default interface naming scheme 'v257'. Dec 16 12:32:31.056444 zram_generator::config[1371]: No configuration found. Dec 16 12:32:31.250357 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 16 12:32:31.250450 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:32:31.252123 systemd[1]: Reloading finished in 249 ms. Dec 16 12:32:31.263999 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:32:31.264000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.266000 audit: BPF prog-id=43 op=LOAD Dec 16 12:32:31.266000 audit: BPF prog-id=35 op=UNLOAD Dec 16 12:32:31.266000 audit: BPF prog-id=44 op=LOAD Dec 16 12:32:31.266000 audit: BPF prog-id=45 op=LOAD Dec 16 12:32:31.266000 audit: BPF prog-id=36 op=UNLOAD Dec 16 12:32:31.266000 audit: BPF prog-id=37 op=UNLOAD Dec 16 12:32:31.269000 audit: BPF prog-id=46 op=LOAD Dec 16 12:32:31.269000 audit: BPF prog-id=34 op=UNLOAD Dec 16 12:32:31.270000 audit: BPF prog-id=47 op=LOAD Dec 16 12:32:31.270000 audit: BPF prog-id=28 op=UNLOAD Dec 16 12:32:31.270000 audit: BPF prog-id=48 op=LOAD Dec 16 12:32:31.270000 audit: BPF prog-id=49 op=LOAD Dec 16 12:32:31.270000 audit: BPF prog-id=29 op=UNLOAD Dec 16 12:32:31.270000 audit: BPF prog-id=30 op=UNLOAD Dec 16 12:32:31.271000 audit: BPF prog-id=50 op=LOAD Dec 16 12:32:31.271000 audit: BPF prog-id=31 op=UNLOAD Dec 16 12:32:31.271000 audit: BPF prog-id=51 op=LOAD Dec 16 12:32:31.272000 audit: BPF prog-id=52 op=LOAD Dec 16 12:32:31.272000 audit: BPF prog-id=32 op=UNLOAD Dec 16 12:32:31.272000 audit: BPF prog-id=33 op=UNLOAD Dec 16 12:32:31.273000 audit: BPF prog-id=53 op=LOAD Dec 16 12:32:31.273000 audit: BPF prog-id=38 op=UNLOAD Dec 16 12:32:31.273000 audit: BPF prog-id=54 op=LOAD Dec 16 12:32:31.273000 audit: BPF prog-id=55 op=LOAD Dec 16 12:32:31.273000 audit: BPF prog-id=39 op=UNLOAD Dec 16 12:32:31.273000 audit: BPF prog-id=40 op=UNLOAD Dec 16 12:32:31.273000 audit: BPF prog-id=56 op=LOAD Dec 16 12:32:31.273000 audit: BPF prog-id=57 op=LOAD Dec 16 12:32:31.273000 audit: BPF prog-id=41 op=UNLOAD Dec 16 12:32:31.273000 audit: BPF prog-id=42 op=UNLOAD Dec 16 12:32:31.298452 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:32:31.299000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.319005 systemd[1]: Finished ensure-sysext.service. Dec 16 12:32:31.319000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ensure-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.334854 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:32:31.337357 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 16 12:32:31.338573 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:32:31.357084 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:32:31.361821 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:32:31.367021 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:32:31.371861 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:32:31.375373 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:32:31.375518 systemd[1]: systemd-confext.service - Merge System Configuration Images into /etc/ was skipped because no trigger condition checks were met. Dec 16 12:32:31.378021 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 16 12:32:31.381807 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 16 12:32:31.383526 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). Dec 16 12:32:31.390266 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 16 12:32:31.392000 audit: BPF prog-id=58 op=LOAD Dec 16 12:32:31.395304 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:32:31.397000 audit: BPF prog-id=59 op=LOAD Dec 16 12:32:31.398655 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 16 12:32:31.405051 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 16 12:32:31.409497 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:32:31.413107 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:32:31.422405 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:32:31.423000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.423000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.424857 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:32:31.425128 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:32:31.426000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.426000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Dec 16 12:32:31.427438 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:32:31.427651 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:32:31.427000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Dec 16 12:32:31.427000 audit[1479]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe23839d0 a2=420 a3=0 items=0 ppid=1446 pid=1479 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Dec 16 12:32:31.427000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Dec 16 12:32:31.429014 augenrules[1479]: No rules Dec 16 12:32:31.431329 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:32:31.431620 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:32:31.435221 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:32:31.435523 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:32:31.437244 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 16 12:32:31.439424 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 16 12:32:31.441498 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 16 12:32:31.451596 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:32:31.451822 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:32:31.451911 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). Dec 16 12:32:31.460907 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 16 12:32:31.468969 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:32:31.517650 systemd-networkd[1471]: lo: Link UP Dec 16 12:32:31.517662 systemd-networkd[1471]: lo: Gained carrier Dec 16 12:32:31.518977 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 16 12:32:31.520661 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:32:31.520865 systemd-networkd[1471]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Dec 16 12:32:31.520869 systemd-networkd[1471]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:32:31.521572 systemd-networkd[1471]: eth0: Link UP Dec 16 12:32:31.521744 systemd-networkd[1471]: eth0: Gained carrier Dec 16 12:32:31.521762 systemd-networkd[1471]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Dec 16 12:32:31.521956 systemd[1]: Reached target network.target - Network. Dec 16 12:32:31.522857 systemd[1]: Reached target time-set.target - System Time Set. Dec 16 12:32:31.525259 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Dec 16 12:32:31.527614 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 16 12:32:31.539775 systemd-networkd[1471]: eth0: DHCPv4 address 10.0.0.133/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:32:31.540936 systemd-timesyncd[1473]: Network configuration changed, trying to establish connection. Dec 16 12:32:31.545944 systemd-timesyncd[1473]: Contacted time server 10.0.0.1:123 (10.0.0.1). Dec 16 12:32:31.546012 systemd-timesyncd[1473]: Initial clock synchronization to Tue 2025-12-16 12:32:31.915827 UTC. Dec 16 12:32:31.553202 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Dec 16 12:32:31.716621 ldconfig[1460]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 16 12:32:31.724643 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 16 12:32:31.727360 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 16 12:32:31.758583 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 16 12:32:31.759935 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:32:31.760931 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 16 12:32:31.761961 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Dec 16 12:32:31.763152 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 16 12:32:31.764158 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 16 12:32:31.765219 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Dec 16 12:32:31.766371 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Dec 16 12:32:31.767456 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 16 12:32:31.768587 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 16 12:32:31.768628 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:32:31.769487 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:32:31.770913 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 16 12:32:31.773444 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:32:31.776781 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Dec 16 12:32:31.778106 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Dec 16 12:32:31.779218 systemd[1]: Reached target ssh-access.target - SSH Access Available. Dec 16 12:32:31.782799 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 16 12:32:31.784273 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Dec 16 12:32:31.786027 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:32:31.787036 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:32:31.787837 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:32:31.788629 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:32:31.788663 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:32:31.789866 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:32:31.792103 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 16 12:32:31.794187 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 16 12:32:31.796342 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 16 12:32:31.799063 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 16 12:32:31.800021 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). Dec 16 12:32:31.802874 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 16 12:32:31.804989 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 16 12:32:31.807892 jq[1514]: false Dec 16 12:32:31.807199 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 16 12:32:31.812018 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 16 12:32:31.813678 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 16 12:32:31.814244 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 16 12:32:31.816908 systemd[1]: Starting update-engine.service - Update Engine... Dec 16 12:32:31.820543 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 16 12:32:31.823777 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 16 12:32:31.825293 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 16 12:32:31.825610 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 16 12:32:31.827954 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 16 12:32:31.828186 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 16 12:32:31.831713 extend-filesystems[1515]: Found /dev/vda6 Dec 16 12:32:31.836061 jq[1526]: true Dec 16 12:32:31.836917 systemd[1]: motdgen.service: Deactivated successfully. Dec 16 12:32:31.839109 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 16 12:32:31.843785 extend-filesystems[1515]: Found /dev/vda9 Dec 16 12:32:31.849945 extend-filesystems[1515]: Checking size of /dev/vda9 Dec 16 12:32:31.862360 update_engine[1524]: I20251216 12:32:31.861934 1524 main.cc:92] Flatcar Update Engine starting Dec 16 12:32:31.863223 jq[1546]: true Dec 16 12:32:31.867161 extend-filesystems[1515]: Resized partition /dev/vda9 Dec 16 12:32:31.872344 extend-filesystems[1557]: resize2fs 1.47.3 (8-Jul-2025) Dec 16 12:32:31.872041 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 16 12:32:31.871667 dbus-daemon[1512]: [system] SELinux support is enabled Dec 16 12:32:31.879354 update_engine[1524]: I20251216 12:32:31.875883 1524 update_check_scheduler.cc:74] Next update check in 10m30s Dec 16 12:32:31.878753 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). Dec 16 12:32:31.878782 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 16 12:32:31.880770 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). Dec 16 12:32:31.880799 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 16 12:32:31.884060 systemd[1]: Started update-engine.service - Update Engine. Dec 16 12:32:31.885727 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 1784827 blocks Dec 16 12:32:31.892250 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 16 12:32:31.916029 systemd-logind[1522]: Watching system buttons on /dev/input/event0 (Power Button) Dec 16 12:32:31.918912 systemd-logind[1522]: New seat seat0. Dec 16 12:32:31.921198 systemd[1]: Started systemd-logind.service - User Login Management. Dec 16 12:32:31.936723 kernel: EXT4-fs (vda9): resized filesystem to 1784827 Dec 16 12:32:31.953253 extend-filesystems[1557]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Dec 16 12:32:31.953253 extend-filesystems[1557]: old_desc_blocks = 1, new_desc_blocks = 1 Dec 16 12:32:31.953253 extend-filesystems[1557]: The filesystem on /dev/vda9 is now 1784827 (4k) blocks long. Dec 16 12:32:31.956848 extend-filesystems[1515]: Resized filesystem in /dev/vda9 Dec 16 12:32:31.954194 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 16 12:32:31.957623 bash[1574]: Updated "/home/core/.ssh/authorized_keys" Dec 16 12:32:31.955748 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 16 12:32:31.960526 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 16 12:32:31.965325 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 16 12:32:31.981980 locksmithd[1559]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 16 12:32:32.018340 containerd[1547]: time="2025-12-16T12:32:32Z" 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 Dec 16 12:32:32.019080 containerd[1547]: time="2025-12-16T12:32:32.018976263Z" level=info msg="starting containerd" revision=fcd43222d6b07379a4be9786bda52438f0dd16a1 version=v2.1.5 Dec 16 12:32:32.030573 containerd[1547]: time="2025-12-16T12:32:32.030510064Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.759µs" Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.030695460Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.030775603Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.030791297Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.030959785Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.030978995Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031032312Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031043946Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031354013Z" 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 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031370502Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031381467Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031389879Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Dec 16 12:32:32.031787 containerd[1547]: time="2025-12-16T12:32:32.031687391Z" 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 Dec 16 12:32:32.032059 containerd[1547]: time="2025-12-16T12:32:32.031712878Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:32:32.032212 containerd[1547]: time="2025-12-16T12:32:32.032180762Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:32:32.032496 containerd[1547]: time="2025-12-16T12:32:32.032471578Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:32:32.032861 containerd[1547]: time="2025-12-16T12:32:32.032574111Z" 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 Dec 16 12:32:32.032907 containerd[1547]: time="2025-12-16T12:32:32.032863546Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:32:32.032907 containerd[1547]: time="2025-12-16T12:32:32.032899956Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:32:32.033254 containerd[1547]: time="2025-12-16T12:32:32.033221030Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:32:32.033332 containerd[1547]: time="2025-12-16T12:32:32.033314523Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:32:32.037435 containerd[1547]: time="2025-12-16T12:32:32.037386285Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:32:32.037477 containerd[1547]: time="2025-12-16T12:32:32.037455296Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Dec 16 12:32:32.037573 containerd[1547]: time="2025-12-16T12:32:32.037552012Z" 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 Dec 16 12:32:32.037573 containerd[1547]: time="2025-12-16T12:32:32.037570970Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:32:32.037641 containerd[1547]: time="2025-12-16T12:32:32.037585325Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:32:32.037641 containerd[1547]: time="2025-12-16T12:32:32.037597210Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:32:32.037641 containerd[1547]: time="2025-12-16T12:32:32.037610351Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:32:32.037641 containerd[1547]: time="2025-12-16T12:32:32.037620353Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:32:32.037641 containerd[1547]: time="2025-12-16T12:32:32.037632113Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:32:32.037725 containerd[1547]: time="2025-12-16T12:32:32.037644542Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:32:32.037725 containerd[1547]: time="2025-12-16T12:32:32.037668188Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:32:32.037725 containerd[1547]: time="2025-12-16T12:32:32.037681036Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:32:32.037725 containerd[1547]: time="2025-12-16T12:32:32.037691122Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:32:32.037725 containerd[1547]: time="2025-12-16T12:32:32.037704262Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:32:32.037922 containerd[1547]: time="2025-12-16T12:32:32.037880954Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:32:32.037922 containerd[1547]: time="2025-12-16T12:32:32.037916275Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:32:32.037968 containerd[1547]: time="2025-12-16T12:32:32.037933057Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:32:32.037968 containerd[1547]: time="2025-12-16T12:32:32.037944356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:32:32.037968 containerd[1547]: time="2025-12-16T12:32:32.037955865Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:32:32.038027 containerd[1547]: time="2025-12-16T12:32:32.037965616Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:32:32.038027 containerd[1547]: time="2025-12-16T12:32:32.037981185Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:32:32.038027 containerd[1547]: time="2025-12-16T12:32:32.037992400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:32:32.038027 containerd[1547]: time="2025-12-16T12:32:32.038004369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:32:32.038027 containerd[1547]: time="2025-12-16T12:32:32.038023997Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:32:32.038129 containerd[1547]: time="2025-12-16T12:32:32.038034878Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:32:32.038129 containerd[1547]: time="2025-12-16T12:32:32.038075598Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:32:32.038129 containerd[1547]: time="2025-12-16T12:32:32.038125818Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:32:32.038186 containerd[1547]: time="2025-12-16T12:32:32.038141973Z" level=info msg="Start snapshots syncer" Dec 16 12:32:32.038186 containerd[1547]: time="2025-12-16T12:32:32.038175997Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:32:32.038496 containerd[1547]: time="2025-12-16T12:32:32.038450784Z" 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\"}" Dec 16 12:32:32.038632 containerd[1547]: time="2025-12-16T12:32:32.038508245Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:32:32.038632 containerd[1547]: time="2025-12-16T12:32:32.038562189Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:32:32.038696 containerd[1547]: time="2025-12-16T12:32:32.038676273Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038702931Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038715654Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038726284Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038755244Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038768720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038780396Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038795880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038807766Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:32:32.038850 containerd[1547]: time="2025-12-16T12:32:32.038848653Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038864807Z" 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 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038874768Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038885774Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038894270Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038904146Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038916241Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.038997556Z" level=info msg="runtime interface created" Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.039002913Z" level=info msg="created NRI interface" Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.039011617Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:32:32.039023 containerd[1547]: time="2025-12-16T12:32:32.039024340Z" level=info msg="Connect containerd service" Dec 16 12:32:32.039205 containerd[1547]: time="2025-12-16T12:32:32.039046018Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:32:32.039954 containerd[1547]: time="2025-12-16T12:32:32.039920016Z" 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" Dec 16 12:32:32.111227 containerd[1547]: time="2025-12-16T12:32:32.111160631Z" level=info msg="Start subscribing containerd event" Dec 16 12:32:32.111351 containerd[1547]: time="2025-12-16T12:32:32.111247428Z" level=info msg="Start recovering state" Dec 16 12:32:32.111373 containerd[1547]: time="2025-12-16T12:32:32.111353811Z" level=info msg="Start event monitor" Dec 16 12:32:32.111373 containerd[1547]: time="2025-12-16T12:32:32.111367370Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:32:32.111408 containerd[1547]: time="2025-12-16T12:32:32.111378126Z" level=info msg="Start streaming server" Dec 16 12:32:32.111408 containerd[1547]: time="2025-12-16T12:32:32.111388295Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:32:32.111408 containerd[1547]: time="2025-12-16T12:32:32.111396581Z" level=info msg="runtime interface starting up..." Dec 16 12:32:32.111408 containerd[1547]: time="2025-12-16T12:32:32.111403236Z" level=info msg="starting plugins..." Dec 16 12:32:32.111505 containerd[1547]: time="2025-12-16T12:32:32.111416921Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:32:32.111820 containerd[1547]: time="2025-12-16T12:32:32.111798091Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:32:32.111857 containerd[1547]: time="2025-12-16T12:32:32.111846721Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:32:32.111918 containerd[1547]: time="2025-12-16T12:32:32.111904139Z" level=info msg="containerd successfully booted in 0.094120s" Dec 16 12:32:32.112142 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:32:32.862396 sshd_keygen[1549]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 16 12:32:32.884885 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 16 12:32:32.888720 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 16 12:32:32.902870 systemd-networkd[1471]: eth0: Gained IPv6LL Dec 16 12:32:32.907206 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 16 12:32:32.909119 systemd[1]: issuegen.service: Deactivated successfully. Dec 16 12:32:32.909384 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 16 12:32:32.912212 systemd[1]: Reached target network-online.target - Network is Online. Dec 16 12:32:32.915763 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 16 12:32:32.918366 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Dec 16 12:32:32.929048 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 16 12:32:32.931943 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 16 12:32:32.957079 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 16 12:32:32.960326 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 16 12:32:32.961956 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 16 12:32:32.962229 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 16 12:32:32.967370 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 16 12:32:32.968693 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 16 12:32:32.970372 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 16 12:32:32.971885 systemd[1]: Reached target getty.target - Login Prompts. Dec 16 12:32:33.609812 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Dec 16 12:32:33.611745 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 16 12:32:33.613048 systemd[1]: Startup finished in 1.474s (kernel) + 4.790s (initrd) + 3.820s (userspace) = 10.085s. Dec 16 12:32:33.614659 (kubelet)[1640]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Dec 16 12:32:33.947429 kubelet[1640]: E1216 12:32:33.947290 1640 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" Dec 16 12:32:33.949804 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:32:33.949956 systemd[1]: kubelet.service: Failed with result 'exit-code'. Dec 16 12:32:33.956109 systemd[1]: kubelet.service: Consumed 713ms CPU time, 247.9M memory peak. Dec 16 12:32:37.132854 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 16 12:32:37.135648 systemd[1]: Started sshd@0-10.0.0.133:22-10.0.0.1:57624.service - OpenSSH per-connection server daemon (10.0.0.1:57624). Dec 16 12:32:37.244509 sshd[1655]: Accepted publickey for core from 10.0.0.1 port 57624 ssh2: RSA SHA256:/XyDWm2N9JZWGT3GjtC51FjWxFfjvfz9iEVjVrokVAY Dec 16 12:32:37.250064 sshd-session[1655]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.259861 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 16 12:32:37.260884 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 16 12:32:37.265790 systemd-logind[1522]: New session 1 of user core. Dec 16 12:32:37.295423 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 16 12:32:37.299169 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 16 12:32:37.324006 (systemd)[1661]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.327258 systemd-logind[1522]: New session 2 of user core. Dec 16 12:32:37.448863 systemd[1661]: Queued start job for default target default.target. Dec 16 12:32:37.469938 systemd[1661]: Created slice app.slice - User Application Slice. Dec 16 12:32:37.469986 systemd[1661]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Dec 16 12:32:37.469999 systemd[1661]: Reached target paths.target - Paths. Dec 16 12:32:37.470059 systemd[1661]: Reached target timers.target - Timers. Dec 16 12:32:37.471536 systemd[1661]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 16 12:32:37.472460 systemd[1661]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Dec 16 12:32:37.483291 systemd[1661]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 16 12:32:37.483393 systemd[1661]: Reached target sockets.target - Sockets. Dec 16 12:32:37.486458 systemd[1661]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Dec 16 12:32:37.486616 systemd[1661]: Reached target basic.target - Basic System. Dec 16 12:32:37.486691 systemd[1661]: Reached target default.target - Main User Target. Dec 16 12:32:37.486745 systemd[1661]: Startup finished in 153ms. Dec 16 12:32:37.487025 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 16 12:32:37.496990 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 16 12:32:37.522627 systemd[1]: Started sshd@1-10.0.0.133:22-10.0.0.1:57626.service - OpenSSH per-connection server daemon (10.0.0.1:57626). Dec 16 12:32:37.591052 sshd[1675]: Accepted publickey for core from 10.0.0.1 port 57626 ssh2: RSA SHA256:/XyDWm2N9JZWGT3GjtC51FjWxFfjvfz9iEVjVrokVAY Dec 16 12:32:37.593348 sshd-session[1675]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.599094 systemd-logind[1522]: New session 3 of user core. Dec 16 12:32:37.609959 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 16 12:32:37.622873 sshd[1679]: Connection closed by 10.0.0.1 port 57626 Dec 16 12:32:37.623381 sshd-session[1675]: pam_unix(sshd:session): session closed for user core Dec 16 12:32:37.634949 systemd[1]: sshd@1-10.0.0.133:22-10.0.0.1:57626.service: Deactivated successfully. Dec 16 12:32:37.637052 systemd[1]: session-3.scope: Deactivated successfully. Dec 16 12:32:37.640268 systemd-logind[1522]: Session 3 logged out. Waiting for processes to exit. Dec 16 12:32:37.643098 systemd[1]: Started sshd@2-10.0.0.133:22-10.0.0.1:57632.service - OpenSSH per-connection server daemon (10.0.0.1:57632). Dec 16 12:32:37.645228 systemd-logind[1522]: Removed session 3. Dec 16 12:32:37.712165 sshd[1685]: Accepted publickey for core from 10.0.0.1 port 57632 ssh2: RSA SHA256:/XyDWm2N9JZWGT3GjtC51FjWxFfjvfz9iEVjVrokVAY Dec 16 12:32:37.713658 sshd-session[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.718816 systemd-logind[1522]: New session 4 of user core. Dec 16 12:32:37.735008 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 16 12:32:37.744483 sshd[1689]: Connection closed by 10.0.0.1 port 57632 Dec 16 12:32:37.744803 sshd-session[1685]: pam_unix(sshd:session): session closed for user core Dec 16 12:32:37.760296 systemd[1]: sshd@2-10.0.0.133:22-10.0.0.1:57632.service: Deactivated successfully. Dec 16 12:32:37.763349 systemd[1]: session-4.scope: Deactivated successfully. Dec 16 12:32:37.766798 systemd-logind[1522]: Session 4 logged out. Waiting for processes to exit. Dec 16 12:32:37.771252 systemd[1]: Started sshd@3-10.0.0.133:22-10.0.0.1:57646.service - OpenSSH per-connection server daemon (10.0.0.1:57646). Dec 16 12:32:37.772361 systemd-logind[1522]: Removed session 4. Dec 16 12:32:37.848209 sshd[1695]: Accepted publickey for core from 10.0.0.1 port 57646 ssh2: RSA SHA256:/XyDWm2N9JZWGT3GjtC51FjWxFfjvfz9iEVjVrokVAY Dec 16 12:32:37.849932 sshd-session[1695]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.855650 systemd-logind[1522]: New session 5 of user core. Dec 16 12:32:37.866008 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 16 12:32:37.881877 sshd[1699]: Connection closed by 10.0.0.1 port 57646 Dec 16 12:32:37.882401 sshd-session[1695]: pam_unix(sshd:session): session closed for user core Dec 16 12:32:37.895422 systemd[1]: sshd@3-10.0.0.133:22-10.0.0.1:57646.service: Deactivated successfully. Dec 16 12:32:37.898500 systemd[1]: session-5.scope: Deactivated successfully. Dec 16 12:32:37.899491 systemd-logind[1522]: Session 5 logged out. Waiting for processes to exit. Dec 16 12:32:37.902909 systemd[1]: Started sshd@4-10.0.0.133:22-10.0.0.1:57658.service - OpenSSH per-connection server daemon (10.0.0.1:57658). Dec 16 12:32:37.903501 systemd-logind[1522]: Removed session 5. Dec 16 12:32:37.970526 sshd[1705]: Accepted publickey for core from 10.0.0.1 port 57658 ssh2: RSA SHA256:/XyDWm2N9JZWGT3GjtC51FjWxFfjvfz9iEVjVrokVAY Dec 16 12:32:37.972057 sshd-session[1705]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:32:37.976695 systemd-logind[1522]: New session 6 of user core. Dec 16 12:32:37.984927 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 16 12:32:38.006248 sudo[1711]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Dec 16 12:32:38.006535 sudo[1711]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:32:38.016876 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 16 12:32:38.066938 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 16 12:32:38.067262 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 16 12:32:38.559067 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Dec 16 12:32:38.559332 systemd[1]: kubelet.service: Consumed 713ms CPU time, 247.9M memory peak. Dec 16 12:32:38.565338 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Dec 16 12:32:38.589963 systemd[1]: Reload requested from client PID 1751 ('systemctl') (unit session-6.scope)... Dec 16 12:32:38.589986 systemd[1]: Reloading... Dec 16 12:32:38.682755 zram_generator::config[1803]: No configuration found. Dec 16 12:32:38.948109 systemd[1]: Reloading finished in 357 ms. Dec 16 12:32:39.021448 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Dec 16 12:32:39.021540 systemd[1]: kubelet.service: Failed with result 'signal'. Dec 16 12:32:39.021919 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Dec 16 12:32:39.021979 systemd[1]: kubelet.service: Consumed 113ms CPU time, 95.1M memory peak. Dec 16 12:32:39.025866 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Dec 16 12:32:39.190465 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Dec 16 12:32:39.195795 (kubelet)[1842]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Dec 16 12:32:39.238413 kubelet[1842]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Dec 16 12:32:39.238413 kubelet[1842]: 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. Dec 16 12:32:39.239107 kubelet[1842]: I1216 12:32:39.238990 1842 server.go:213] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Dec 16 12:32:39.691819 kubelet[1842]: I1216 12:32:39.691680 1842 server.go:529] "Kubelet version" kubeletVersion="v1.34.1" Dec 16 12:32:39.691819 kubelet[1842]: I1216 12:32:39.691732 1842 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Dec 16 12:32:39.693876 kubelet[1842]: I1216 12:32:39.692963 1842 watchdog_linux.go:95] "Systemd watchdog is not enabled" Dec 16 12:32:39.693876 kubelet[1842]: I1216 12:32:39.692992 1842 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Dec 16 12:32:39.693876 kubelet[1842]: I1216 12:32:39.693360 1842 server.go:956] "Client rotation is on, will bootstrap in background" Dec 16 12:32:39.698164 kubelet[1842]: I1216 12:32:39.698080 1842 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Dec 16 12:32:39.705877 kubelet[1842]: I1216 12:32:39.705756 1842 server.go:1423] "Using cgroup driver setting received from the CRI runtime" cgroupDriver="systemd" Dec 16 12:32:39.709934 kubelet[1842]: I1216 12:32:39.709685 1842 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Dec 16 12:32:39.709934 kubelet[1842]: I1216 12:32:39.709905 1842 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Dec 16 12:32:39.710171 kubelet[1842]: I1216 12:32:39.709927 1842 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.133","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Dec 16 12:32:39.710171 kubelet[1842]: I1216 12:32:39.710129 1842 topology_manager.go:138] "Creating topology manager with none policy" Dec 16 12:32:39.710171 kubelet[1842]: I1216 12:32:39.710139 1842 container_manager_linux.go:306] "Creating device plugin manager" Dec 16 12:32:39.710334 kubelet[1842]: I1216 12:32:39.710249 1842 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Dec 16 12:32:39.900352 kubelet[1842]: I1216 12:32:39.900272 1842 state_mem.go:36] "Initialized new in-memory state store" Dec 16 12:32:39.902897 kubelet[1842]: I1216 12:32:39.902854 1842 kubelet.go:475] "Attempting to sync node with API server" Dec 16 12:32:39.902897 kubelet[1842]: I1216 12:32:39.902887 1842 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Dec 16 12:32:39.904522 kubelet[1842]: I1216 12:32:39.904487 1842 kubelet.go:387] "Adding apiserver pod source" Dec 16 12:32:39.904522 kubelet[1842]: I1216 12:32:39.904522 1842 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Dec 16 12:32:39.905051 kubelet[1842]: E1216 12:32:39.904823 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:39.905051 kubelet[1842]: E1216 12:32:39.904865 1842 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:39.905751 kubelet[1842]: I1216 12:32:39.905731 1842 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v2.1.5" apiVersion="v1" Dec 16 12:32:39.906712 kubelet[1842]: I1216 12:32:39.906658 1842 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Dec 16 12:32:39.906712 kubelet[1842]: I1216 12:32:39.906702 1842 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Dec 16 12:32:39.906810 kubelet[1842]: W1216 12:32:39.906773 1842 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Dec 16 12:32:39.910525 kubelet[1842]: I1216 12:32:39.910485 1842 server.go:1262] "Started kubelet" Dec 16 12:32:39.910991 kubelet[1842]: I1216 12:32:39.910932 1842 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Dec 16 12:32:39.911024 kubelet[1842]: I1216 12:32:39.911004 1842 server_v1.go:49] "podresources" method="list" useActivePods=true Dec 16 12:32:39.911953 kubelet[1842]: I1216 12:32:39.911916 1842 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Dec 16 12:32:39.912086 kubelet[1842]: I1216 12:32:39.912063 1842 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Dec 16 12:32:39.914153 kubelet[1842]: I1216 12:32:39.913275 1842 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Dec 16 12:32:39.914153 kubelet[1842]: I1216 12:32:39.914094 1842 server.go:310] "Adding debug handlers to kubelet server" Dec 16 12:32:39.914578 kubelet[1842]: E1216 12:32:39.914502 1842 reflector.go:205] "Failed to watch" err="failed to list *v1.Node: nodes \"10.0.0.133\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Node" Dec 16 12:32:39.914691 kubelet[1842]: E1216 12:32:39.914669 1842 reflector.go:205] "Failed to watch" err="failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" Dec 16 12:32:39.917057 kubelet[1842]: I1216 12:32:39.915158 1842 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Dec 16 12:32:39.918598 kubelet[1842]: E1216 12:32:39.918554 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:39.918598 kubelet[1842]: I1216 12:32:39.918608 1842 volume_manager.go:313] "Starting Kubelet Volume Manager" Dec 16 12:32:39.918971 kubelet[1842]: E1216 12:32:39.918780 1842 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Dec 16 12:32:39.918971 kubelet[1842]: I1216 12:32:39.918825 1842 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Dec 16 12:32:39.918971 kubelet[1842]: I1216 12:32:39.918893 1842 reconciler.go:29] "Reconciler: start to sync state" Dec 16 12:32:39.919548 kubelet[1842]: I1216 12:32:39.919476 1842 factory.go:223] Registration of the systemd container factory successfully Dec 16 12:32:39.919612 kubelet[1842]: I1216 12:32:39.919593 1842 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Dec 16 12:32:39.921019 kubelet[1842]: I1216 12:32:39.920973 1842 factory.go:223] Registration of the containerd container factory successfully Dec 16 12:32:39.932776 kubelet[1842]: E1216 12:32:39.930856 1842 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.133\" not found" node="10.0.0.133" Dec 16 12:32:39.935013 kubelet[1842]: I1216 12:32:39.934985 1842 cpu_manager.go:221] "Starting CPU manager" policy="none" Dec 16 12:32:39.935013 kubelet[1842]: I1216 12:32:39.935003 1842 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Dec 16 12:32:39.935150 kubelet[1842]: I1216 12:32:39.935029 1842 state_mem.go:36] "Initialized new in-memory state store" Dec 16 12:32:39.936949 kubelet[1842]: I1216 12:32:39.936911 1842 policy_none.go:49] "None policy: Start" Dec 16 12:32:39.936949 kubelet[1842]: I1216 12:32:39.936943 1842 memory_manager.go:187] "Starting memorymanager" policy="None" Dec 16 12:32:39.936949 kubelet[1842]: I1216 12:32:39.936956 1842 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Dec 16 12:32:39.938169 kubelet[1842]: I1216 12:32:39.938151 1842 policy_none.go:47] "Start" Dec 16 12:32:39.948036 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Dec 16 12:32:39.964980 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Dec 16 12:32:39.969681 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Dec 16 12:32:39.981948 kubelet[1842]: E1216 12:32:39.981900 1842 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Dec 16 12:32:39.982163 kubelet[1842]: I1216 12:32:39.982120 1842 eviction_manager.go:189] "Eviction manager: starting control loop" Dec 16 12:32:39.982163 kubelet[1842]: I1216 12:32:39.982141 1842 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Dec 16 12:32:39.982163 kubelet[1842]: I1216 12:32:39.982457 1842 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Dec 16 12:32:39.983705 kubelet[1842]: E1216 12:32:39.983595 1842 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Dec 16 12:32:39.983905 kubelet[1842]: E1216 12:32:39.983760 1842 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.133\" not found" Dec 16 12:32:39.992268 kubelet[1842]: I1216 12:32:39.992136 1842 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Dec 16 12:32:39.993459 kubelet[1842]: I1216 12:32:39.993428 1842 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Dec 16 12:32:39.993459 kubelet[1842]: I1216 12:32:39.993459 1842 status_manager.go:244] "Starting to sync pod status with apiserver" Dec 16 12:32:39.994391 kubelet[1842]: I1216 12:32:39.993496 1842 kubelet.go:2427] "Starting kubelet main sync loop" Dec 16 12:32:39.994391 kubelet[1842]: E1216 12:32:39.993553 1842 kubelet.go:2451] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Dec 16 12:32:40.083887 kubelet[1842]: I1216 12:32:40.083853 1842 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.133" Dec 16 12:32:40.090223 kubelet[1842]: I1216 12:32:40.090174 1842 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.133" Dec 16 12:32:40.090223 kubelet[1842]: E1216 12:32:40.090210 1842 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"10.0.0.133\": node \"10.0.0.133\" not found" Dec 16 12:32:40.096577 kubelet[1842]: I1216 12:32:40.096547 1842 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Dec 16 12:32:40.097067 containerd[1547]: time="2025-12-16T12:32:40.097010922Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Dec 16 12:32:40.097368 kubelet[1842]: I1216 12:32:40.097210 1842 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Dec 16 12:32:40.104869 kubelet[1842]: E1216 12:32:40.104794 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.205956 kubelet[1842]: E1216 12:32:40.205834 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.205925 sudo[1711]: pam_unix(sudo:session): session closed for user root Dec 16 12:32:40.207761 sshd[1710]: Connection closed by 10.0.0.1 port 57658 Dec 16 12:32:40.208116 sshd-session[1705]: pam_unix(sshd:session): session closed for user core Dec 16 12:32:40.212342 systemd[1]: sshd@4-10.0.0.133:22-10.0.0.1:57658.service: Deactivated successfully. Dec 16 12:32:40.214367 systemd[1]: session-6.scope: Deactivated successfully. Dec 16 12:32:40.214610 systemd[1]: session-6.scope: Consumed 436ms CPU time, 76.4M memory peak. Dec 16 12:32:40.215634 systemd-logind[1522]: Session 6 logged out. Waiting for processes to exit. Dec 16 12:32:40.216591 systemd-logind[1522]: Removed session 6. Dec 16 12:32:40.306972 kubelet[1842]: E1216 12:32:40.306892 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.407718 kubelet[1842]: E1216 12:32:40.407643 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.508180 kubelet[1842]: E1216 12:32:40.507993 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.608750 kubelet[1842]: E1216 12:32:40.608685 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.696140 kubelet[1842]: I1216 12:32:40.696058 1842 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Dec 16 12:32:40.696342 kubelet[1842]: I1216 12:32:40.696267 1842 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Dec 16 12:32:40.696342 kubelet[1842]: I1216 12:32:40.696299 1842 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Dec 16 12:32:40.709676 kubelet[1842]: E1216 12:32:40.709600 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.810094 kubelet[1842]: E1216 12:32:40.809931 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:40.905899 kubelet[1842]: E1216 12:32:40.905843 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:40.910606 kubelet[1842]: E1216 12:32:40.910535 1842 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"10.0.0.133\" not found" Dec 16 12:32:41.905938 kubelet[1842]: I1216 12:32:41.905859 1842 apiserver.go:52] "Watching apiserver" Dec 16 12:32:41.906296 kubelet[1842]: E1216 12:32:41.905954 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:41.929250 kubelet[1842]: I1216 12:32:41.929212 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/68a3dc4d-fd83-40cb-b2bf-446aede8573e-cni-plugin\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.929250 kubelet[1842]: I1216 12:32:41.929250 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/68a3dc4d-fd83-40cb-b2bf-446aede8573e-cni\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.929409 kubelet[1842]: I1216 12:32:41.929269 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/68a3dc4d-fd83-40cb-b2bf-446aede8573e-flannel-cfg\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.929409 kubelet[1842]: I1216 12:32:41.929283 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/68a3dc4d-fd83-40cb-b2bf-446aede8573e-xtables-lock\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.929409 kubelet[1842]: I1216 12:32:41.929299 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hfwvj\" (UniqueName: \"kubernetes.io/projected/68a3dc4d-fd83-40cb-b2bf-446aede8573e-kube-api-access-hfwvj\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.929409 kubelet[1842]: I1216 12:32:41.929314 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/68a3dc4d-fd83-40cb-b2bf-446aede8573e-run\") pod \"kube-flannel-ds-5bknw\" (UID: \"68a3dc4d-fd83-40cb-b2bf-446aede8573e\") " pod="kube-flannel/kube-flannel-ds-5bknw" Dec 16 12:32:41.935809 systemd[1]: Created slice kubepods-burstable-pod68a3dc4d_fd83_40cb_b2bf_446aede8573e.slice - libcontainer container kubepods-burstable-pod68a3dc4d_fd83_40cb_b2bf_446aede8573e.slice. Dec 16 12:32:41.956890 systemd[1]: Created slice kubepods-besteffort-podcee62632_e5a3_4601_9ab3_61b1607d6c04.slice - libcontainer container kubepods-besteffort-podcee62632_e5a3_4601_9ab3_61b1607d6c04.slice. Dec 16 12:32:42.019837 kubelet[1842]: I1216 12:32:42.019798 1842 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Dec 16 12:32:42.030792 kubelet[1842]: I1216 12:32:42.030556 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/cee62632-e5a3-4601-9ab3-61b1607d6c04-kube-proxy\") pod \"kube-proxy-8qdnv\" (UID: \"cee62632-e5a3-4601-9ab3-61b1607d6c04\") " pod="kube-system/kube-proxy-8qdnv" Dec 16 12:32:42.030792 kubelet[1842]: I1216 12:32:42.030606 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/cee62632-e5a3-4601-9ab3-61b1607d6c04-lib-modules\") pod \"kube-proxy-8qdnv\" (UID: \"cee62632-e5a3-4601-9ab3-61b1607d6c04\") " pod="kube-system/kube-proxy-8qdnv" Dec 16 12:32:42.030792 kubelet[1842]: I1216 12:32:42.030655 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/cee62632-e5a3-4601-9ab3-61b1607d6c04-xtables-lock\") pod \"kube-proxy-8qdnv\" (UID: \"cee62632-e5a3-4601-9ab3-61b1607d6c04\") " pod="kube-system/kube-proxy-8qdnv" Dec 16 12:32:42.030792 kubelet[1842]: I1216 12:32:42.030747 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-grsc8\" (UniqueName: \"kubernetes.io/projected/cee62632-e5a3-4601-9ab3-61b1607d6c04-kube-api-access-grsc8\") pod \"kube-proxy-8qdnv\" (UID: \"cee62632-e5a3-4601-9ab3-61b1607d6c04\") " pod="kube-system/kube-proxy-8qdnv" Dec 16 12:32:42.256808 kubelet[1842]: E1216 12:32:42.256684 1842 dns.go:154] "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" Dec 16 12:32:42.258221 containerd[1547]: time="2025-12-16T12:32:42.258164031Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5bknw,Uid:68a3dc4d-fd83-40cb-b2bf-446aede8573e,Namespace:kube-flannel,Attempt:0,}" Dec 16 12:32:42.281838 kubelet[1842]: E1216 12:32:42.281796 1842 dns.go:154] "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" Dec 16 12:32:42.284160 containerd[1547]: time="2025-12-16T12:32:42.284113464Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-8qdnv,Uid:cee62632-e5a3-4601-9ab3-61b1607d6c04,Namespace:kube-system,Attempt:0,}" Dec 16 12:32:42.906225 kubelet[1842]: E1216 12:32:42.906165 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:43.043241 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2380746493.mount: Deactivated successfully. Dec 16 12:32:43.053729 containerd[1547]: time="2025-12-16T12:32:43.053503367Z" 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\"}" Dec 16 12:32:43.054931 containerd[1547]: time="2025-12-16T12:32:43.054852338Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=886" Dec 16 12:32:43.056787 containerd[1547]: time="2025-12-16T12:32:43.056509192Z" 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\"}" Dec 16 12:32:43.057947 containerd[1547]: time="2025-12-16T12:32:43.057535807Z" level=info msg="ImageCreate event name:\"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Dec 16 12:32:43.058633 containerd[1547]: time="2025-12-16T12:32:43.058562342Z" level=info msg="stop pulling image registry.k8s.io/pause:3.10: active requests=0, bytes read=0" Dec 16 12:32:43.061205 containerd[1547]: time="2025-12-16T12:32:43.061129991Z" 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\"}" Dec 16 12:32:43.062095 containerd[1547]: time="2025-12-16T12:32:43.061752267Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 796.281774ms" Dec 16 12:32:43.062542 containerd[1547]: time="2025-12-16T12:32:43.062512758Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.10\" with image id \"sha256:afb61768ce381961ca0beff95337601f29dc70ff3ed14e5e4b3e5699057e6aa8\", repo tag \"registry.k8s.io/pause:3.10\", repo digest \"registry.k8s.io/pause@sha256:ee6521f290b2168b6e0935a181d4cff9be1ac3f505666ef0e3c98fae8199917a\", size \"267933\" in 771.712279ms" Dec 16 12:32:43.092334 containerd[1547]: time="2025-12-16T12:32:43.092293489Z" level=info msg="connecting to shim 6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2" address="unix:///run/containerd/s/cb365b2e6e6d66605949bb2989ad9828a5b1c4ce35b6943ac890fd3f772fc2ae" namespace=k8s.io protocol=ttrpc version=3 Dec 16 12:32:43.097747 containerd[1547]: time="2025-12-16T12:32:43.097619396Z" level=info msg="connecting to shim ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58" address="unix:///run/containerd/s/0b53e457e224d31cf7845b1b2149e84972fdcce9ce97f33070e52273b862e0cf" namespace=k8s.io protocol=ttrpc version=3 Dec 16 12:32:43.121031 systemd[1]: Started cri-containerd-ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58.scope - libcontainer container ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58. Dec 16 12:32:43.130100 systemd[1]: Started cri-containerd-6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2.scope - libcontainer container 6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2. Dec 16 12:32:43.164994 containerd[1547]: time="2025-12-16T12:32:43.164870062Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5bknw,Uid:68a3dc4d-fd83-40cb-b2bf-446aede8573e,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\"" Dec 16 12:32:43.167124 kubelet[1842]: E1216 12:32:43.166670 1842 dns.go:154] "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" Dec 16 12:32:43.170349 containerd[1547]: time="2025-12-16T12:32:43.170281267Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-8qdnv,Uid:cee62632-e5a3-4601-9ab3-61b1607d6c04,Namespace:kube-system,Attempt:0,} returns sandbox id \"6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2\"" Dec 16 12:32:43.170947 kubelet[1842]: E1216 12:32:43.170902 1842 dns.go:154] "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" Dec 16 12:32:43.171283 containerd[1547]: time="2025-12-16T12:32:43.171250033Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Dec 16 12:32:43.907837 kubelet[1842]: E1216 12:32:43.906873 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:44.121662 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount834883695.mount: Deactivated successfully. Dec 16 12:32:44.197819 containerd[1547]: time="2025-12-16T12:32:44.197486046Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:44.208940 containerd[1547]: time="2025-12-16T12:32:44.208875208Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=0" Dec 16 12:32:44.220897 containerd[1547]: time="2025-12-16T12:32:44.220824661Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:44.269253 containerd[1547]: time="2025-12-16T12:32:44.269174088Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:44.270334 containerd[1547]: time="2025-12-16T12:32:44.270292935Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"5125394\" in 1.099000873s" Dec 16 12:32:44.270334 containerd[1547]: time="2025-12-16T12:32:44.270330320Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Dec 16 12:32:44.271755 containerd[1547]: time="2025-12-16T12:32:44.271642309Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.3\"" Dec 16 12:32:44.302892 containerd[1547]: time="2025-12-16T12:32:44.302829367Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Dec 16 12:32:44.362305 containerd[1547]: time="2025-12-16T12:32:44.362250141Z" level=info msg="Container cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:32:44.382044 containerd[1547]: time="2025-12-16T12:32:44.381944481Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766\"" Dec 16 12:32:44.383090 containerd[1547]: time="2025-12-16T12:32:44.382998328Z" level=info msg="StartContainer for \"cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766\"" Dec 16 12:32:44.384784 containerd[1547]: time="2025-12-16T12:32:44.384752317Z" level=info msg="connecting to shim cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766" address="unix:///run/containerd/s/0b53e457e224d31cf7845b1b2149e84972fdcce9ce97f33070e52273b862e0cf" protocol=ttrpc version=3 Dec 16 12:32:44.406974 systemd[1]: Started cri-containerd-cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766.scope - libcontainer container cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766. Dec 16 12:32:44.434454 systemd[1]: cri-containerd-cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766.scope: Deactivated successfully. Dec 16 12:32:44.436044 containerd[1547]: time="2025-12-16T12:32:44.435948095Z" level=info msg="received container exit event container_id:\"cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766\" id:\"cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766\" pid:2009 exited_at:{seconds:1765888364 nanos:435531490}" Dec 16 12:32:44.436836 containerd[1547]: time="2025-12-16T12:32:44.436803753Z" level=info msg="StartContainer for \"cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766\" returns successfully" Dec 16 12:32:44.456143 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-cccc1ea5a2d10744267b974f93346985062e0d8169376dd44a0410316acb0766-rootfs.mount: Deactivated successfully. Dec 16 12:32:44.907542 kubelet[1842]: E1216 12:32:44.907416 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:45.009009 kubelet[1842]: E1216 12:32:45.008977 1842 dns.go:154] "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" Dec 16 12:32:45.259375 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1911971577.mount: Deactivated successfully. Dec 16 12:32:45.428310 containerd[1547]: time="2025-12-16T12:32:45.428234601Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.3\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:45.429914 containerd[1547]: time="2025-12-16T12:32:45.429602542Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.3: active requests=0, bytes read=22801532" Dec 16 12:32:45.430785 containerd[1547]: time="2025-12-16T12:32:45.430757803Z" level=info msg="ImageCreate event name:\"sha256:4461daf6b6af87cf200fc22cecc9a2120959aabaf5712ba54ef5b4a6361d1162\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:45.432899 containerd[1547]: time="2025-12-16T12:32:45.432851855Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:7298ab89a103523d02ff4f49bedf9359710af61df92efdc07bac873064f03ed6\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:45.433603 containerd[1547]: time="2025-12-16T12:32:45.433573489Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.3\" with image id \"sha256:4461daf6b6af87cf200fc22cecc9a2120959aabaf5712ba54ef5b4a6361d1162\", repo tag \"registry.k8s.io/kube-proxy:v1.34.3\", repo digest \"registry.k8s.io/kube-proxy@sha256:7298ab89a103523d02ff4f49bedf9359710af61df92efdc07bac873064f03ed6\", size \"22804272\" in 1.161898048s" Dec 16 12:32:45.433695 containerd[1547]: time="2025-12-16T12:32:45.433679224Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.3\" returns image reference \"sha256:4461daf6b6af87cf200fc22cecc9a2120959aabaf5712ba54ef5b4a6361d1162\"" Dec 16 12:32:45.434566 containerd[1547]: time="2025-12-16T12:32:45.434542928Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Dec 16 12:32:45.438230 containerd[1547]: time="2025-12-16T12:32:45.437662391Z" level=info msg="CreateContainer within sandbox \"6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Dec 16 12:32:45.446326 containerd[1547]: time="2025-12-16T12:32:45.446274948Z" level=info msg="Container f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:32:45.454852 containerd[1547]: time="2025-12-16T12:32:45.454805281Z" level=info msg="CreateContainer within sandbox \"6a5f47f62955bdcbedea20b51157391e0bab2f93585bfc9357b3dbf416f88ab2\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b\"" Dec 16 12:32:45.455569 containerd[1547]: time="2025-12-16T12:32:45.455534538Z" level=info msg="StartContainer for \"f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b\"" Dec 16 12:32:45.457372 containerd[1547]: time="2025-12-16T12:32:45.457344613Z" level=info msg="connecting to shim f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b" address="unix:///run/containerd/s/cb365b2e6e6d66605949bb2989ad9828a5b1c4ce35b6943ac890fd3f772fc2ae" protocol=ttrpc version=3 Dec 16 12:32:45.477946 systemd[1]: Started cri-containerd-f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b.scope - libcontainer container f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b. Dec 16 12:32:45.581370 containerd[1547]: time="2025-12-16T12:32:45.581175500Z" level=info msg="StartContainer for \"f017e89844e3e1e1409e2ee596cdfd5f4f3fb76cc48af78fd060fb34376a767b\" returns successfully" Dec 16 12:32:45.908558 kubelet[1842]: E1216 12:32:45.908425 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:46.012451 kubelet[1842]: E1216 12:32:46.012410 1842 dns.go:154] "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" Dec 16 12:32:46.189605 kubelet[1842]: I1216 12:32:46.189439 1842 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-8qdnv" podStartSLOduration=3.926682712 podStartE2EDuration="6.189423401s" podCreationTimestamp="2025-12-16 12:32:40 +0000 UTC" firstStartedPulling="2025-12-16 12:32:43.171634038 +0000 UTC m=+3.972560695" lastFinishedPulling="2025-12-16 12:32:45.434374728 +0000 UTC m=+6.235301384" observedRunningTime="2025-12-16 12:32:46.189058819 +0000 UTC m=+6.989985476" watchObservedRunningTime="2025-12-16 12:32:46.189423401 +0000 UTC m=+6.990350058" Dec 16 12:32:46.909190 kubelet[1842]: E1216 12:32:46.909140 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:47.013750 kubelet[1842]: E1216 12:32:47.013532 1842 dns.go:154] "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" Dec 16 12:32:47.084271 containerd[1547]: time="2025-12-16T12:32:47.084220560Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:47.085521 containerd[1547]: time="2025-12-16T12:32:47.085475865Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=12447072" Dec 16 12:32:47.086630 containerd[1547]: time="2025-12-16T12:32:47.086051798Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:47.114978 containerd[1547]: time="2025-12-16T12:32:47.114936952Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:47.116047 containerd[1547]: time="2025-12-16T12:32:47.116009685Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32412118\" in 1.681435202s" Dec 16 12:32:47.116161 containerd[1547]: time="2025-12-16T12:32:47.116143797Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Dec 16 12:32:47.120096 containerd[1547]: time="2025-12-16T12:32:47.120044148Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Dec 16 12:32:47.128746 containerd[1547]: time="2025-12-16T12:32:47.127958958Z" level=info msg="Container 7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:32:47.135512 containerd[1547]: time="2025-12-16T12:32:47.135469098Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392\"" Dec 16 12:32:47.136451 containerd[1547]: time="2025-12-16T12:32:47.136421767Z" level=info msg="StartContainer for \"7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392\"" Dec 16 12:32:47.137516 containerd[1547]: time="2025-12-16T12:32:47.137429698Z" level=info msg="connecting to shim 7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392" address="unix:///run/containerd/s/0b53e457e224d31cf7845b1b2149e84972fdcce9ce97f33070e52273b862e0cf" protocol=ttrpc version=3 Dec 16 12:32:47.159963 systemd[1]: Started cri-containerd-7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392.scope - libcontainer container 7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392. Dec 16 12:32:47.185745 systemd[1]: cri-containerd-7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392.scope: Deactivated successfully. Dec 16 12:32:47.187675 containerd[1547]: time="2025-12-16T12:32:47.187606147Z" level=info msg="received container exit event container_id:\"7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392\" id:\"7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392\" pid:2257 exited_at:{seconds:1765888367 nanos:187108541}" Dec 16 12:32:47.195408 containerd[1547]: time="2025-12-16T12:32:47.195299061Z" level=info msg="StartContainer for \"7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392\" returns successfully" Dec 16 12:32:47.206908 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-7eb390f20b9a303507001b5c52ac4b2cdddf94a8a54d7f6207d172e130613392-rootfs.mount: Deactivated successfully. Dec 16 12:32:47.239342 kubelet[1842]: I1216 12:32:47.239307 1842 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Dec 16 12:32:47.909631 kubelet[1842]: E1216 12:32:47.909569 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:48.017071 kubelet[1842]: E1216 12:32:48.017025 1842 dns.go:154] "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" Dec 16 12:32:48.071308 containerd[1547]: time="2025-12-16T12:32:48.071258528Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Dec 16 12:32:48.137458 containerd[1547]: time="2025-12-16T12:32:48.136856162Z" level=info msg="Container 2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:32:48.193243 containerd[1547]: time="2025-12-16T12:32:48.193119340Z" level=info msg="CreateContainer within sandbox \"ca2bba49df3a2cdd93b49dc76b6f2c55871e9a9a0a533ee83b4d33fc62a93e58\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35\"" Dec 16 12:32:48.193788 containerd[1547]: time="2025-12-16T12:32:48.193747310Z" level=info msg="StartContainer for \"2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35\"" Dec 16 12:32:48.194635 containerd[1547]: time="2025-12-16T12:32:48.194606577Z" level=info msg="connecting to shim 2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35" address="unix:///run/containerd/s/0b53e457e224d31cf7845b1b2149e84972fdcce9ce97f33070e52273b862e0cf" protocol=ttrpc version=3 Dec 16 12:32:48.217954 systemd[1]: Started cri-containerd-2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35.scope - libcontainer container 2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35. Dec 16 12:32:48.246333 containerd[1547]: time="2025-12-16T12:32:48.246280549Z" level=info msg="StartContainer for \"2b50b815a1bf3c972753ca454bb7f12037a2469846ceb9a6317a52c5094b7c35\" returns successfully" Dec 16 12:32:48.910009 kubelet[1842]: E1216 12:32:48.909960 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:49.021218 kubelet[1842]: E1216 12:32:49.021142 1842 dns.go:154] "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" Dec 16 12:32:49.033092 kubelet[1842]: I1216 12:32:49.033033 1842 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-5bknw" podStartSLOduration=5.08644909 podStartE2EDuration="9.033016222s" podCreationTimestamp="2025-12-16 12:32:40 +0000 UTC" firstStartedPulling="2025-12-16 12:32:43.170310697 +0000 UTC m=+3.971237354" lastFinishedPulling="2025-12-16 12:32:47.11687783 +0000 UTC m=+7.917804486" observedRunningTime="2025-12-16 12:32:49.032964617 +0000 UTC m=+9.833891233" watchObservedRunningTime="2025-12-16 12:32:49.033016222 +0000 UTC m=+9.833942878" Dec 16 12:32:49.330529 systemd-networkd[1471]: flannel.1: Link UP Dec 16 12:32:49.330540 systemd-networkd[1471]: flannel.1: Gained carrier Dec 16 12:32:49.910313 kubelet[1842]: E1216 12:32:49.910265 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:50.023595 kubelet[1842]: E1216 12:32:50.023400 1842 dns.go:154] "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" Dec 16 12:32:50.502960 systemd-networkd[1471]: flannel.1: Gained IPv6LL Dec 16 12:32:50.910896 kubelet[1842]: E1216 12:32:50.910758 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:51.163169 systemd[1]: Created slice kubepods-besteffort-pod37af405e_d887_4857_ae9d_a28cfed411fb.slice - libcontainer container kubepods-besteffort-pod37af405e_d887_4857_ae9d_a28cfed411fb.slice. Dec 16 12:32:51.188527 kubelet[1842]: I1216 12:32:51.188469 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2p8nv\" (UniqueName: \"kubernetes.io/projected/37af405e-d887-4857-ae9d-a28cfed411fb-kube-api-access-2p8nv\") pod \"nginx-deployment-bb8f74bfb-484r6\" (UID: \"37af405e-d887-4857-ae9d-a28cfed411fb\") " pod="default/nginx-deployment-bb8f74bfb-484r6" Dec 16 12:32:51.468301 containerd[1547]: time="2025-12-16T12:32:51.468195622Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-484r6,Uid:37af405e-d887-4857-ae9d-a28cfed411fb,Namespace:default,Attempt:0,}" Dec 16 12:32:51.486072 systemd-networkd[1471]: cni0: Link UP Dec 16 12:32:51.486077 systemd-networkd[1471]: cni0: Gained carrier Dec 16 12:32:51.486914 systemd-networkd[1471]: cni0: Lost carrier Dec 16 12:32:51.490939 systemd-networkd[1471]: vetheae6be98: Link UP Dec 16 12:32:51.491721 kernel: cni0: port 1(vetheae6be98) entered blocking state Dec 16 12:32:51.493849 kernel: cni0: port 1(vetheae6be98) entered disabled state Dec 16 12:32:51.493894 kernel: vetheae6be98: entered allmulticast mode Dec 16 12:32:51.493919 kernel: vetheae6be98: entered promiscuous mode Dec 16 12:32:51.503400 kernel: cni0: port 1(vetheae6be98) entered blocking state Dec 16 12:32:51.503554 kernel: cni0: port 1(vetheae6be98) entered forwarding state Dec 16 12:32:51.504829 systemd-networkd[1471]: vetheae6be98: Gained carrier Dec 16 12:32:51.505263 systemd-networkd[1471]: cni0: Gained carrier Dec 16 12:32:51.507208 containerd[1547]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Dec 16 12:32:51.507208 containerd[1547]: delegateAdd: netconf sent to delegate plugin: Dec 16 12:32:51.530838 containerd[1547]: {"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-12-16T12:32:51.530789137Z" level=info msg="connecting to shim f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b" address="unix:///run/containerd/s/13eeef65d7bb609bd5b65ea1051dc96975272193d156b094f4893cb21881f45e" namespace=k8s.io protocol=ttrpc version=3 Dec 16 12:32:51.556919 systemd[1]: Started cri-containerd-f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b.scope - libcontainer container f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b. Dec 16 12:32:51.568567 systemd-resolved[1255]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:32:51.591216 containerd[1547]: time="2025-12-16T12:32:51.591164888Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-484r6,Uid:37af405e-d887-4857-ae9d-a28cfed411fb,Namespace:default,Attempt:0,} returns sandbox id \"f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b\"" Dec 16 12:32:51.592401 containerd[1547]: time="2025-12-16T12:32:51.592370844Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Dec 16 12:32:51.911408 kubelet[1842]: E1216 12:32:51.911291 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:52.616798 systemd-networkd[1471]: cni0: Gained IPv6LL Dec 16 12:32:52.912330 kubelet[1842]: E1216 12:32:52.912187 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:53.254833 systemd-networkd[1471]: vetheae6be98: Gained IPv6LL Dec 16 12:32:53.461981 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount374073271.mount: Deactivated successfully. Dec 16 12:32:53.913089 kubelet[1842]: E1216 12:32:53.913056 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:54.237647 containerd[1547]: time="2025-12-16T12:32:54.237353451Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:54.238390 containerd[1547]: time="2025-12-16T12:32:54.238289259Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=29209710" Dec 16 12:32:54.239197 containerd[1547]: time="2025-12-16T12:32:54.239114036Z" level=info msg="ImageCreate event name:\"sha256:7adf3298f4d8758381db6c085c4dc9963183b33da22b2baf25a0d1f94da4a918\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:54.243439 containerd[1547]: time="2025-12-16T12:32:54.242868615Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:73a15a021433343835d9908f25bf01b8d42a2113a41e9c9e28b6a89b82b54f96\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:32:54.243525 containerd[1547]: time="2025-12-16T12:32:54.243410941Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:7adf3298f4d8758381db6c085c4dc9963183b33da22b2baf25a0d1f94da4a918\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:73a15a021433343835d9908f25bf01b8d42a2113a41e9c9e28b6a89b82b54f96\", size \"70017485\" in 2.651004822s" Dec 16 12:32:54.243525 containerd[1547]: time="2025-12-16T12:32:54.243519927Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:7adf3298f4d8758381db6c085c4dc9963183b33da22b2baf25a0d1f94da4a918\"" Dec 16 12:32:54.248500 containerd[1547]: time="2025-12-16T12:32:54.248411647Z" level=info msg="CreateContainer within sandbox \"f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Dec 16 12:32:54.258045 containerd[1547]: time="2025-12-16T12:32:54.257996199Z" level=info msg="Container 0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:32:54.264717 containerd[1547]: time="2025-12-16T12:32:54.264553270Z" level=info msg="CreateContainer within sandbox \"f4b4f0a8be06dedfaa829d72a34db0fecbbed69706502f7cbb1e481fc15cca2b\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d\"" Dec 16 12:32:54.265714 containerd[1547]: time="2025-12-16T12:32:54.265243919Z" level=info msg="StartContainer for \"0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d\"" Dec 16 12:32:54.266160 containerd[1547]: time="2025-12-16T12:32:54.266133012Z" level=info msg="connecting to shim 0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d" address="unix:///run/containerd/s/13eeef65d7bb609bd5b65ea1051dc96975272193d156b094f4893cb21881f45e" protocol=ttrpc version=3 Dec 16 12:32:54.293438 systemd[1]: Started cri-containerd-0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d.scope - libcontainer container 0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d. Dec 16 12:32:54.325831 containerd[1547]: time="2025-12-16T12:32:54.325793993Z" level=info msg="StartContainer for \"0a89157707250e093d73c3d31903353e331880e5313938268ea8693e3cd9910d\" returns successfully" Dec 16 12:32:54.914482 kubelet[1842]: E1216 12:32:54.914414 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:55.060497 kubelet[1842]: I1216 12:32:55.060390 1842 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-484r6" podStartSLOduration=1.407485541 podStartE2EDuration="4.060373746s" podCreationTimestamp="2025-12-16 12:32:51 +0000 UTC" firstStartedPulling="2025-12-16 12:32:51.592046622 +0000 UTC m=+12.392973238" lastFinishedPulling="2025-12-16 12:32:54.244934786 +0000 UTC m=+15.045861443" observedRunningTime="2025-12-16 12:32:55.060320432 +0000 UTC m=+15.861247088" watchObservedRunningTime="2025-12-16 12:32:55.060373746 +0000 UTC m=+15.861300442" Dec 16 12:32:55.915540 kubelet[1842]: E1216 12:32:55.915490 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:56.915947 kubelet[1842]: E1216 12:32:56.915906 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:57.465411 systemd[1]: Created slice kubepods-besteffort-pod1a99cfe4_de23_4128_b37a_adaa52598d04.slice - libcontainer container kubepods-besteffort-pod1a99cfe4_de23_4128_b37a_adaa52598d04.slice. Dec 16 12:32:57.530579 kubelet[1842]: I1216 12:32:57.530494 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/1a99cfe4-de23-4128-b37a-adaa52598d04-data\") pod \"nfs-server-provisioner-0\" (UID: \"1a99cfe4-de23-4128-b37a-adaa52598d04\") " pod="default/nfs-server-provisioner-0" Dec 16 12:32:57.530752 kubelet[1842]: I1216 12:32:57.530601 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-k499m\" (UniqueName: \"kubernetes.io/projected/1a99cfe4-de23-4128-b37a-adaa52598d04-kube-api-access-k499m\") pod \"nfs-server-provisioner-0\" (UID: \"1a99cfe4-de23-4128-b37a-adaa52598d04\") " pod="default/nfs-server-provisioner-0" Dec 16 12:32:57.773515 containerd[1547]: time="2025-12-16T12:32:57.773258703Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:1a99cfe4-de23-4128-b37a-adaa52598d04,Namespace:default,Attempt:0,}" Dec 16 12:32:57.787815 systemd-networkd[1471]: veth6958a540: Link UP Dec 16 12:32:57.792016 kernel: cni0: port 2(veth6958a540) entered blocking state Dec 16 12:32:57.792097 kernel: cni0: port 2(veth6958a540) entered disabled state Dec 16 12:32:57.792894 kernel: veth6958a540: entered allmulticast mode Dec 16 12:32:57.793711 kernel: veth6958a540: entered promiscuous mode Dec 16 12:32:57.800287 kernel: cni0: port 2(veth6958a540) entered blocking state Dec 16 12:32:57.800602 kernel: cni0: port 2(veth6958a540) entered forwarding state Dec 16 12:32:57.800494 systemd-networkd[1471]: veth6958a540: Gained carrier Dec 16 12:32:57.802978 containerd[1547]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Dec 16 12:32:57.802978 containerd[1547]: delegateAdd: netconf sent to delegate plugin: Dec 16 12:32:57.839643 containerd[1547]: {"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-12-16T12:32:57.839163652Z" level=info msg="connecting to shim acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1" address="unix:///run/containerd/s/669922cae10dd76b67a8e879d0cc6cac1dd0b364ee943d1a2812258ad1ecb945" namespace=k8s.io protocol=ttrpc version=3 Dec 16 12:32:57.861949 systemd[1]: Started cri-containerd-acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1.scope - libcontainer container acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1. Dec 16 12:32:57.873479 systemd-resolved[1255]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:32:57.901649 containerd[1547]: time="2025-12-16T12:32:57.901597591Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:1a99cfe4-de23-4128-b37a-adaa52598d04,Namespace:default,Attempt:0,} returns sandbox id \"acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1\"" Dec 16 12:32:57.903142 containerd[1547]: time="2025-12-16T12:32:57.903040437Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Dec 16 12:32:57.916826 kubelet[1842]: E1216 12:32:57.916768 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:58.917969 kubelet[1842]: E1216 12:32:58.917886 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:59.270875 systemd-networkd[1471]: veth6958a540: Gained IPv6LL Dec 16 12:32:59.778506 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2263867604.mount: Deactivated successfully. Dec 16 12:32:59.904633 kubelet[1842]: E1216 12:32:59.904547 1842 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:32:59.918959 kubelet[1842]: E1216 12:32:59.918872 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:00.919654 kubelet[1842]: E1216 12:33:00.919603 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:01.250796 containerd[1547]: time="2025-12-16T12:33:01.250620016Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:33:01.263262 containerd[1547]: time="2025-12-16T12:33:01.263185177Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=86370731" Dec 16 12:33:01.277579 containerd[1547]: time="2025-12-16T12:33:01.277524204Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:33:01.333043 containerd[1547]: time="2025-12-16T12:33:01.332950216Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:33:01.334095 containerd[1547]: time="2025-12-16T12:33:01.333934162Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 3.43086096s" Dec 16 12:33:01.334095 containerd[1547]: time="2025-12-16T12:33:01.333976844Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Dec 16 12:33:01.338947 containerd[1547]: time="2025-12-16T12:33:01.338899176Z" level=info msg="CreateContainer within sandbox \"acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Dec 16 12:33:01.349437 containerd[1547]: time="2025-12-16T12:33:01.349063990Z" level=info msg="Container 5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:33:01.355745 containerd[1547]: time="2025-12-16T12:33:01.355681593Z" level=info msg="CreateContainer within sandbox \"acecc5a5f75ad58d5936f00844ee6a5ba21998bd0d8c72b7e79ac10c425ee1f1\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800\"" Dec 16 12:33:01.356379 containerd[1547]: time="2025-12-16T12:33:01.356344750Z" level=info msg="StartContainer for \"5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800\"" Dec 16 12:33:01.357319 containerd[1547]: time="2025-12-16T12:33:01.357294584Z" level=info msg="connecting to shim 5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800" address="unix:///run/containerd/s/669922cae10dd76b67a8e879d0cc6cac1dd0b364ee943d1a2812258ad1ecb945" protocol=ttrpc version=3 Dec 16 12:33:01.379925 systemd[1]: Started cri-containerd-5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800.scope - libcontainer container 5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800. Dec 16 12:33:01.408430 containerd[1547]: time="2025-12-16T12:33:01.408395077Z" level=info msg="StartContainer for \"5d9a59e650eec3a76653d336a608d8042da755dc386a05919a18b2133d48b800\" returns successfully" Dec 16 12:33:01.920320 kubelet[1842]: E1216 12:33:01.920270 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:02.066691 kubelet[1842]: I1216 12:33:02.066471 1842 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.634401999 podStartE2EDuration="5.06645646s" podCreationTimestamp="2025-12-16 12:32:57 +0000 UTC" firstStartedPulling="2025-12-16 12:32:57.902775122 +0000 UTC m=+18.703701778" lastFinishedPulling="2025-12-16 12:33:01.334829583 +0000 UTC m=+22.135756239" observedRunningTime="2025-12-16 12:33:02.065549977 +0000 UTC m=+22.866476633" watchObservedRunningTime="2025-12-16 12:33:02.06645646 +0000 UTC m=+22.867383116" Dec 16 12:33:02.920810 kubelet[1842]: E1216 12:33:02.920765 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:03.921494 kubelet[1842]: E1216 12:33:03.921426 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:04.921867 kubelet[1842]: E1216 12:33:04.921812 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:05.922390 kubelet[1842]: E1216 12:33:05.922321 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:06.866826 systemd[1]: Created slice kubepods-besteffort-pod91eb385f_c17f_45cd_b6bc_8c49e188071d.slice - libcontainer container kubepods-besteffort-pod91eb385f_c17f_45cd_b6bc_8c49e188071d.slice. Dec 16 12:33:06.923373 kubelet[1842]: E1216 12:33:06.923267 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:06.987769 kubelet[1842]: I1216 12:33:06.987669 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-tb9tv\" (UniqueName: \"kubernetes.io/projected/91eb385f-c17f-45cd-b6bc-8c49e188071d-kube-api-access-tb9tv\") pod \"test-pod-1\" (UID: \"91eb385f-c17f-45cd-b6bc-8c49e188071d\") " pod="default/test-pod-1" Dec 16 12:33:06.987913 kubelet[1842]: I1216 12:33:06.987804 1842 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-820c44d4-f3d4-4492-8e42-63b64a8d817a\" (UniqueName: \"kubernetes.io/nfs/91eb385f-c17f-45cd-b6bc-8c49e188071d-pvc-820c44d4-f3d4-4492-8e42-63b64a8d817a\") pod \"test-pod-1\" (UID: \"91eb385f-c17f-45cd-b6bc-8c49e188071d\") " pod="default/test-pod-1" Dec 16 12:33:07.109851 kernel: netfs: FS-Cache loaded Dec 16 12:33:07.134987 kernel: RPC: Registered named UNIX socket transport module. Dec 16 12:33:07.135098 kernel: RPC: Registered udp transport module. Dec 16 12:33:07.135128 kernel: RPC: Registered tcp transport module. Dec 16 12:33:07.136267 kernel: RPC: Registered tcp-with-tls transport module. Dec 16 12:33:07.136337 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Dec 16 12:33:07.321883 kernel: NFS: Registering the id_resolver key type Dec 16 12:33:07.321983 kernel: Key type id_resolver registered Dec 16 12:33:07.322001 kernel: Key type id_legacy registered Dec 16 12:33:07.340713 nfsidmap[2817]: 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 Dec 16 12:33:07.341750 nfsidmap[2817]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Dec 16 12:33:07.345108 nfsidmap[2820]: 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 Dec 16 12:33:07.345279 nfsidmap[2820]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Dec 16 12:33:07.352884 nfsrahead[2824]: setting /var/lib/kubelet/pods/91eb385f-c17f-45cd-b6bc-8c49e188071d/volumes/kubernetes.io~nfs/pvc-820c44d4-f3d4-4492-8e42-63b64a8d817a readahead to 128 Dec 16 12:33:07.474673 containerd[1547]: time="2025-12-16T12:33:07.474553772Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:91eb385f-c17f-45cd-b6bc-8c49e188071d,Namespace:default,Attempt:0,}" Dec 16 12:33:07.494324 systemd-networkd[1471]: veth9c870e47: Link UP Dec 16 12:33:07.497139 kernel: cni0: port 3(veth9c870e47) entered blocking state Dec 16 12:33:07.497214 kernel: cni0: port 3(veth9c870e47) entered disabled state Dec 16 12:33:07.497818 kernel: veth9c870e47: entered allmulticast mode Dec 16 12:33:07.498715 kernel: veth9c870e47: entered promiscuous mode Dec 16 12:33:07.505684 systemd-networkd[1471]: veth9c870e47: Gained carrier Dec 16 12:33:07.505829 kernel: cni0: port 3(veth9c870e47) entered blocking state Dec 16 12:33:07.505871 kernel: cni0: port 3(veth9c870e47) entered forwarding state Dec 16 12:33:07.510805 containerd[1547]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Dec 16 12:33:07.510805 containerd[1547]: delegateAdd: netconf sent to delegate plugin: Dec 16 12:33:07.542966 containerd[1547]: {"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-12-16T12:33:07.542910858Z" level=info msg="connecting to shim 34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919" address="unix:///run/containerd/s/737efa131a5db7bd0f8fcfa4e8bd2ce0a1182f77052b5161782a15a96bebf2ad" namespace=k8s.io protocol=ttrpc version=3 Dec 16 12:33:07.579001 systemd[1]: Started cri-containerd-34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919.scope - libcontainer container 34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919. Dec 16 12:33:07.591716 systemd-resolved[1255]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:33:07.613959 containerd[1547]: time="2025-12-16T12:33:07.613918004Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:91eb385f-c17f-45cd-b6bc-8c49e188071d,Namespace:default,Attempt:0,} returns sandbox id \"34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919\"" Dec 16 12:33:07.615328 containerd[1547]: time="2025-12-16T12:33:07.615293475Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Dec 16 12:33:07.865186 containerd[1547]: time="2025-12-16T12:33:07.864753381Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Dec 16 12:33:07.866669 containerd[1547]: time="2025-12-16T12:33:07.866589504Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=0" Dec 16 12:33:07.870557 containerd[1547]: time="2025-12-16T12:33:07.870506907Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:7adf3298f4d8758381db6c085c4dc9963183b33da22b2baf25a0d1f94da4a918\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:73a15a021433343835d9908f25bf01b8d42a2113a41e9c9e28b6a89b82b54f96\", size \"70017485\" in 255.158468ms" Dec 16 12:33:07.870557 containerd[1547]: time="2025-12-16T12:33:07.870554346Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:7adf3298f4d8758381db6c085c4dc9963183b33da22b2baf25a0d1f94da4a918\"" Dec 16 12:33:07.875472 containerd[1547]: time="2025-12-16T12:33:07.875430604Z" level=info msg="CreateContainer within sandbox \"34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919\" for container &ContainerMetadata{Name:test,Attempt:0,}" Dec 16 12:33:07.884728 containerd[1547]: time="2025-12-16T12:33:07.884657536Z" level=info msg="Container 6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db: CDI devices from CRI Config.CDIDevices: []" Dec 16 12:33:07.892199 containerd[1547]: time="2025-12-16T12:33:07.892130050Z" level=info msg="CreateContainer within sandbox \"34c56e3e0b418d2f27e671430de73c542e32a6aa7f8de3cbda48b894e1bbd919\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db\"" Dec 16 12:33:07.892997 containerd[1547]: time="2025-12-16T12:33:07.892963924Z" level=info msg="StartContainer for \"6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db\"" Dec 16 12:33:07.894243 containerd[1547]: time="2025-12-16T12:33:07.894211652Z" level=info msg="connecting to shim 6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db" address="unix:///run/containerd/s/737efa131a5db7bd0f8fcfa4e8bd2ce0a1182f77052b5161782a15a96bebf2ad" protocol=ttrpc version=3 Dec 16 12:33:07.916964 systemd[1]: Started cri-containerd-6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db.scope - libcontainer container 6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db. Dec 16 12:33:07.924026 kubelet[1842]: E1216 12:33:07.923964 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:07.944399 containerd[1547]: time="2025-12-16T12:33:07.944358431Z" level=info msg="StartContainer for \"6b693e3e6f80a08d01e1b1ae46c9c8ebbe5757891a9b7463fa4b4611bdb0c7db\" returns successfully" Dec 16 12:33:08.079024 kubelet[1842]: I1216 12:33:08.078855 1842 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=10.82235362 podStartE2EDuration="11.078836878s" podCreationTimestamp="2025-12-16 12:32:57 +0000 UTC" firstStartedPulling="2025-12-16 12:33:07.615009446 +0000 UTC m=+28.415936062" lastFinishedPulling="2025-12-16 12:33:07.871492664 +0000 UTC m=+28.672419320" observedRunningTime="2025-12-16 12:33:08.078805734 +0000 UTC m=+28.879732390" watchObservedRunningTime="2025-12-16 12:33:08.078836878 +0000 UTC m=+28.879763494" Dec 16 12:33:08.924148 kubelet[1842]: E1216 12:33:08.924092 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Dec 16 12:33:09.382957 systemd-networkd[1471]: veth9c870e47: Gained IPv6LL Dec 16 12:33:09.924241 kubelet[1842]: E1216 12:33:09.924192 1842 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"