Dec 16 12:40:08.790155 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Dec 16 12:40:08.790178 kernel: Linux version 6.12.61-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Fri Dec 12 15:20:48 -00 2025 Dec 16 12:40:08.790188 kernel: KASLR enabled Dec 16 12:40:08.790194 kernel: efi: EFI v2.7 by EDK II Dec 16 12:40:08.790199 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb21fd18 Dec 16 12:40:08.790205 kernel: random: crng init done Dec 16 12:40:08.790211 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Dec 16 12:40:08.790217 kernel: secureboot: Secure boot enabled Dec 16 12:40:08.790223 kernel: ACPI: Early table checksum verification disabled Dec 16 12:40:08.790230 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Dec 16 12:40:08.790236 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Dec 16 12:40:08.790241 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790247 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790252 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790260 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790267 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790273 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790279 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790285 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790300 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Dec 16 12:40:08.790306 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Dec 16 12:40:08.790312 kernel: ACPI: Use ACPI SPCR as default console: Yes Dec 16 12:40:08.790318 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:40:08.790324 kernel: NODE_DATA(0) allocated [mem 0xdc737a00-0xdc73efff] Dec 16 12:40:08.790330 kernel: Zone ranges: Dec 16 12:40:08.790338 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:40:08.790344 kernel: DMA32 empty Dec 16 12:40:08.790350 kernel: Normal empty Dec 16 12:40:08.790355 kernel: Device empty Dec 16 12:40:08.790361 kernel: Movable zone start for each node Dec 16 12:40:08.790367 kernel: Early memory node ranges Dec 16 12:40:08.790373 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Dec 16 12:40:08.790379 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Dec 16 12:40:08.790385 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Dec 16 12:40:08.790391 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Dec 16 12:40:08.790397 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Dec 16 12:40:08.790403 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Dec 16 12:40:08.790410 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Dec 16 12:40:08.790416 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Dec 16 12:40:08.790458 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Dec 16 12:40:08.790471 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Dec 16 12:40:08.790478 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Dec 16 12:40:08.790484 kernel: cma: Reserved 16 MiB at 0x00000000d7a00000 on node -1 Dec 16 12:40:08.790491 kernel: psci: probing for conduit method from ACPI. Dec 16 12:40:08.790511 kernel: psci: PSCIv1.1 detected in firmware. Dec 16 12:40:08.790521 kernel: psci: Using standard PSCI v0.2 function IDs Dec 16 12:40:08.790528 kernel: psci: Trusted OS migration not required Dec 16 12:40:08.790534 kernel: psci: SMC Calling Convention v1.1 Dec 16 12:40:08.790541 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Dec 16 12:40:08.790547 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Dec 16 12:40:08.790553 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Dec 16 12:40:08.790560 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Dec 16 12:40:08.790566 kernel: Detected PIPT I-cache on CPU0 Dec 16 12:40:08.790575 kernel: CPU features: detected: GIC system register CPU interface Dec 16 12:40:08.790581 kernel: CPU features: detected: Spectre-v4 Dec 16 12:40:08.790587 kernel: CPU features: detected: Spectre-BHB Dec 16 12:40:08.790594 kernel: CPU features: kernel page table isolation forced ON by KASLR Dec 16 12:40:08.790600 kernel: CPU features: detected: Kernel page table isolation (KPTI) Dec 16 12:40:08.790607 kernel: CPU features: detected: ARM erratum 1418040 Dec 16 12:40:08.790613 kernel: CPU features: detected: SSBS not fully self-synchronizing Dec 16 12:40:08.790619 kernel: alternatives: applying boot alternatives Dec 16 12:40:08.790627 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=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:40:08.790633 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Dec 16 12:40:08.790640 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Dec 16 12:40:08.790673 kernel: Fallback order for Node 0: 0 Dec 16 12:40:08.790680 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Dec 16 12:40:08.790686 kernel: Policy zone: DMA Dec 16 12:40:08.790692 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Dec 16 12:40:08.790699 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Dec 16 12:40:08.790705 kernel: software IO TLB: area num 4. Dec 16 12:40:08.790711 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Dec 16 12:40:08.790718 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Dec 16 12:40:08.790724 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Dec 16 12:40:08.790730 kernel: rcu: Preemptible hierarchical RCU implementation. Dec 16 12:40:08.790738 kernel: rcu: RCU event tracing is enabled. Dec 16 12:40:08.790744 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Dec 16 12:40:08.790753 kernel: Trampoline variant of Tasks RCU enabled. Dec 16 12:40:08.790759 kernel: Tracing variant of Tasks RCU enabled. Dec 16 12:40:08.790766 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Dec 16 12:40:08.790772 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Dec 16 12:40:08.790779 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Dec 16 12:40:08.790785 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:40:08.790791 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Dec 16 12:40:08.790798 kernel: GICv3: 256 SPIs implemented Dec 16 12:40:08.790804 kernel: GICv3: 0 Extended SPIs implemented Dec 16 12:40:08.790810 kernel: Root IRQ handler: gic_handle_irq Dec 16 12:40:08.790816 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Dec 16 12:40:08.790823 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Dec 16 12:40:08.790831 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Dec 16 12:40:08.790837 kernel: ITS [mem 0x08080000-0x0809ffff] Dec 16 12:40:08.790843 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Dec 16 12:40:08.790850 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Dec 16 12:40:08.790856 kernel: GICv3: using LPI property table @0x0000000040130000 Dec 16 12:40:08.790863 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Dec 16 12:40:08.790869 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Dec 16 12:40:08.790875 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:40:08.790882 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Dec 16 12:40:08.790888 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Dec 16 12:40:08.790895 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Dec 16 12:40:08.790902 kernel: arm-pv: using stolen time PV Dec 16 12:40:08.790909 kernel: Console: colour dummy device 80x25 Dec 16 12:40:08.790916 kernel: ACPI: Core revision 20240827 Dec 16 12:40:08.790923 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Dec 16 12:40:08.790929 kernel: pid_max: default: 32768 minimum: 301 Dec 16 12:40:08.790936 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Dec 16 12:40:08.790942 kernel: landlock: Up and running. Dec 16 12:40:08.790949 kernel: SELinux: Initializing. Dec 16 12:40:08.790955 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:40:08.790963 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Dec 16 12:40:08.790970 kernel: rcu: Hierarchical SRCU implementation. Dec 16 12:40:08.790977 kernel: rcu: Max phase no-delay instances is 400. Dec 16 12:40:08.790983 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Dec 16 12:40:08.791018 kernel: Remapping and enabling EFI services. Dec 16 12:40:08.791025 kernel: smp: Bringing up secondary CPUs ... Dec 16 12:40:08.791032 kernel: Detected PIPT I-cache on CPU1 Dec 16 12:40:08.791038 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Dec 16 12:40:08.791045 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Dec 16 12:40:08.791055 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:40:08.791081 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Dec 16 12:40:08.791089 kernel: Detected PIPT I-cache on CPU2 Dec 16 12:40:08.791099 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Dec 16 12:40:08.791106 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Dec 16 12:40:08.791113 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:40:08.791120 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Dec 16 12:40:08.791127 kernel: Detected PIPT I-cache on CPU3 Dec 16 12:40:08.791135 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Dec 16 12:40:08.791142 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Dec 16 12:40:08.791149 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Dec 16 12:40:08.791156 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Dec 16 12:40:08.791163 kernel: smp: Brought up 1 node, 4 CPUs Dec 16 12:40:08.791170 kernel: SMP: Total of 4 processors activated. Dec 16 12:40:08.791177 kernel: CPU: All CPU(s) started at EL1 Dec 16 12:40:08.791183 kernel: CPU features: detected: 32-bit EL0 Support Dec 16 12:40:08.791190 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Dec 16 12:40:08.791197 kernel: CPU features: detected: Common not Private translations Dec 16 12:40:08.791205 kernel: CPU features: detected: CRC32 instructions Dec 16 12:40:08.791212 kernel: CPU features: detected: Enhanced Virtualization Traps Dec 16 12:40:08.791219 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Dec 16 12:40:08.791226 kernel: CPU features: detected: LSE atomic instructions Dec 16 12:40:08.791233 kernel: CPU features: detected: Privileged Access Never Dec 16 12:40:08.791240 kernel: CPU features: detected: RAS Extension Support Dec 16 12:40:08.791247 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Dec 16 12:40:08.791253 kernel: alternatives: applying system-wide alternatives Dec 16 12:40:08.791260 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Dec 16 12:40:08.791271 kernel: Memory: 2421668K/2572288K available (11200K kernel code, 2456K rwdata, 9084K rodata, 39552K init, 1038K bss, 128284K reserved, 16384K cma-reserved) Dec 16 12:40:08.791278 kernel: devtmpfs: initialized Dec 16 12:40:08.791286 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Dec 16 12:40:08.791298 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Dec 16 12:40:08.791305 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Dec 16 12:40:08.791312 kernel: 0 pages in range for non-PLT usage Dec 16 12:40:08.791319 kernel: 508400 pages in range for PLT usage Dec 16 12:40:08.791326 kernel: pinctrl core: initialized pinctrl subsystem Dec 16 12:40:08.791332 kernel: SMBIOS 3.0.0 present. Dec 16 12:40:08.791341 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Dec 16 12:40:08.791348 kernel: DMI: Memory slots populated: 1/1 Dec 16 12:40:08.791355 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Dec 16 12:40:08.791362 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Dec 16 12:40:08.791369 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Dec 16 12:40:08.791376 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Dec 16 12:40:08.791383 kernel: audit: initializing netlink subsys (disabled) Dec 16 12:40:08.791390 kernel: audit: type=2000 audit(0.025:1): state=initialized audit_enabled=0 res=1 Dec 16 12:40:08.791397 kernel: thermal_sys: Registered thermal governor 'step_wise' Dec 16 12:40:08.791405 kernel: cpuidle: using governor menu Dec 16 12:40:08.791411 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Dec 16 12:40:08.791418 kernel: ASID allocator initialised with 32768 entries Dec 16 12:40:08.791425 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Dec 16 12:40:08.791432 kernel: Serial: AMBA PL011 UART driver Dec 16 12:40:08.791439 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Dec 16 12:40:08.791446 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Dec 16 12:40:08.791453 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Dec 16 12:40:08.791460 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Dec 16 12:40:08.791468 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Dec 16 12:40:08.791507 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Dec 16 12:40:08.791515 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Dec 16 12:40:08.791522 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Dec 16 12:40:08.791529 kernel: ACPI: Added _OSI(Module Device) Dec 16 12:40:08.791536 kernel: ACPI: Added _OSI(Processor Device) Dec 16 12:40:08.791543 kernel: ACPI: Added _OSI(Processor Aggregator Device) Dec 16 12:40:08.791562 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Dec 16 12:40:08.791570 kernel: ACPI: Interpreter enabled Dec 16 12:40:08.791579 kernel: ACPI: Using GIC for interrupt routing Dec 16 12:40:08.791586 kernel: ACPI: MCFG table detected, 1 entries Dec 16 12:40:08.791593 kernel: ACPI: CPU0 has been hot-added Dec 16 12:40:08.791600 kernel: ACPI: CPU1 has been hot-added Dec 16 12:40:08.791607 kernel: ACPI: CPU2 has been hot-added Dec 16 12:40:08.791614 kernel: ACPI: CPU3 has been hot-added Dec 16 12:40:08.791621 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Dec 16 12:40:08.791628 kernel: printk: legacy console [ttyAMA0] enabled Dec 16 12:40:08.791635 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Dec 16 12:40:08.792852 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Dec 16 12:40:08.792928 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Dec 16 12:40:08.792987 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Dec 16 12:40:08.793044 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Dec 16 12:40:08.793099 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Dec 16 12:40:08.793108 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Dec 16 12:40:08.793116 kernel: PCI host bridge to bus 0000:00 Dec 16 12:40:08.793186 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Dec 16 12:40:08.793240 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Dec 16 12:40:08.793301 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Dec 16 12:40:08.793356 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Dec 16 12:40:08.793433 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Dec 16 12:40:08.793510 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Dec 16 12:40:08.793572 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Dec 16 12:40:08.793631 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Dec 16 12:40:08.793749 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Dec 16 12:40:08.793845 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Dec 16 12:40:08.793909 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Dec 16 12:40:08.793970 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Dec 16 12:40:08.794025 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Dec 16 12:40:08.794081 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Dec 16 12:40:08.794134 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Dec 16 12:40:08.794143 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Dec 16 12:40:08.794150 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Dec 16 12:40:08.794157 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Dec 16 12:40:08.794164 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Dec 16 12:40:08.794171 kernel: iommu: Default domain type: Translated Dec 16 12:40:08.794178 kernel: iommu: DMA domain TLB invalidation policy: strict mode Dec 16 12:40:08.794184 kernel: efivars: Registered efivars operations Dec 16 12:40:08.794193 kernel: vgaarb: loaded Dec 16 12:40:08.794200 kernel: clocksource: Switched to clocksource arch_sys_counter Dec 16 12:40:08.794207 kernel: VFS: Disk quotas dquot_6.6.0 Dec 16 12:40:08.794214 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Dec 16 12:40:08.794221 kernel: pnp: PnP ACPI init Dec 16 12:40:08.794302 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Dec 16 12:40:08.794314 kernel: pnp: PnP ACPI: found 1 devices Dec 16 12:40:08.794321 kernel: NET: Registered PF_INET protocol family Dec 16 12:40:08.794331 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Dec 16 12:40:08.794338 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Dec 16 12:40:08.794345 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Dec 16 12:40:08.794351 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Dec 16 12:40:08.794358 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Dec 16 12:40:08.794398 kernel: TCP: Hash tables configured (established 32768 bind 32768) Dec 16 12:40:08.794406 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:40:08.794413 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Dec 16 12:40:08.794420 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Dec 16 12:40:08.794430 kernel: PCI: CLS 0 bytes, default 64 Dec 16 12:40:08.794437 kernel: kvm [1]: HYP mode not available Dec 16 12:40:08.794444 kernel: Initialise system trusted keyrings Dec 16 12:40:08.794467 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Dec 16 12:40:08.794475 kernel: Key type asymmetric registered Dec 16 12:40:08.794482 kernel: Asymmetric key parser 'x509' registered Dec 16 12:40:08.794489 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Dec 16 12:40:08.794496 kernel: io scheduler mq-deadline registered Dec 16 12:40:08.794503 kernel: io scheduler kyber registered Dec 16 12:40:08.794512 kernel: io scheduler bfq registered Dec 16 12:40:08.794519 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Dec 16 12:40:08.794526 kernel: ACPI: button: Power Button [PWRB] Dec 16 12:40:08.794533 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Dec 16 12:40:08.794611 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Dec 16 12:40:08.794621 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Dec 16 12:40:08.794629 kernel: thunder_xcv, ver 1.0 Dec 16 12:40:08.794636 kernel: thunder_bgx, ver 1.0 Dec 16 12:40:08.794642 kernel: nicpf, ver 1.0 Dec 16 12:40:08.794667 kernel: nicvf, ver 1.0 Dec 16 12:40:08.794742 kernel: rtc-efi rtc-efi.0: registered as rtc0 Dec 16 12:40:08.794801 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-12-16T12:40:08 UTC (1765888808) Dec 16 12:40:08.794810 kernel: hid: raw HID events driver (C) Jiri Kosina Dec 16 12:40:08.794817 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Dec 16 12:40:08.794824 kernel: watchdog: NMI not fully supported Dec 16 12:40:08.794831 kernel: watchdog: Hard watchdog permanently disabled Dec 16 12:40:08.794838 kernel: NET: Registered PF_INET6 protocol family Dec 16 12:40:08.794847 kernel: Segment Routing with IPv6 Dec 16 12:40:08.794854 kernel: In-situ OAM (IOAM) with IPv6 Dec 16 12:40:08.794862 kernel: NET: Registered PF_PACKET protocol family Dec 16 12:40:08.794868 kernel: Key type dns_resolver registered Dec 16 12:40:08.794875 kernel: registered taskstats version 1 Dec 16 12:40:08.794882 kernel: Loading compiled-in X.509 certificates Dec 16 12:40:08.794889 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.61-flatcar: 92f3a94fb747a7ba7cbcfde1535be91b86f9429a' Dec 16 12:40:08.794896 kernel: Demotion targets for Node 0: null Dec 16 12:40:08.794903 kernel: Key type .fscrypt registered Dec 16 12:40:08.794911 kernel: Key type fscrypt-provisioning registered Dec 16 12:40:08.794918 kernel: ima: No TPM chip found, activating TPM-bypass! Dec 16 12:40:08.794925 kernel: ima: Allocated hash algorithm: sha1 Dec 16 12:40:08.794932 kernel: ima: No architecture policies found Dec 16 12:40:08.794939 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Dec 16 12:40:08.794946 kernel: clk: Disabling unused clocks Dec 16 12:40:08.794952 kernel: PM: genpd: Disabling unused power domains Dec 16 12:40:08.794960 kernel: Warning: unable to open an initial console. Dec 16 12:40:08.794967 kernel: Freeing unused kernel memory: 39552K Dec 16 12:40:08.794975 kernel: Run /init as init process Dec 16 12:40:08.795016 kernel: with arguments: Dec 16 12:40:08.795024 kernel: /init Dec 16 12:40:08.795030 kernel: with environment: Dec 16 12:40:08.795037 kernel: HOME=/ Dec 16 12:40:08.795044 kernel: TERM=linux Dec 16 12:40:08.795053 systemd[1]: Successfully made /usr/ read-only. Dec 16 12:40:08.795079 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Dec 16 12:40:08.795091 systemd[1]: Detected virtualization kvm. Dec 16 12:40:08.795099 systemd[1]: Detected architecture arm64. Dec 16 12:40:08.795106 systemd[1]: Running in initrd. Dec 16 12:40:08.795113 systemd[1]: No hostname configured, using default hostname. Dec 16 12:40:08.795120 systemd[1]: Hostname set to . Dec 16 12:40:08.795128 systemd[1]: Initializing machine ID from VM UUID. Dec 16 12:40:08.795135 systemd[1]: Queued start job for default target initrd.target. Dec 16 12:40:08.795142 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:40:08.795151 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:40:08.795159 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Dec 16 12:40:08.795167 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:40:08.795174 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Dec 16 12:40:08.795182 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Dec 16 12:40:08.795191 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Dec 16 12:40:08.795200 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Dec 16 12:40:08.795207 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:40:08.795215 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:40:08.795222 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:40:08.795234 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:40:08.795242 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:40:08.795249 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:40:08.795257 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:40:08.795265 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:40:08.795274 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Dec 16 12:40:08.795281 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Dec 16 12:40:08.795296 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:40:08.795303 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:40:08.795311 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:40:08.795318 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:40:08.795326 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Dec 16 12:40:08.795333 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:40:08.795343 systemd[1]: Finished network-cleanup.service - Network Cleanup. Dec 16 12:40:08.795351 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:40:08.795358 systemd[1]: Starting systemd-fsck-usr.service... Dec 16 12:40:08.795366 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:40:08.795373 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:40:08.795381 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:40:08.795388 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Dec 16 12:40:08.795398 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:40:08.795405 systemd[1]: Finished systemd-fsck-usr.service. Dec 16 12:40:08.795413 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Dec 16 12:40:08.795470 systemd-journald[246]: Collecting audit messages is disabled. Dec 16 12:40:08.795494 systemd-journald[246]: Journal started Dec 16 12:40:08.795512 systemd-journald[246]: Runtime Journal (/run/log/journal/560dc18ec51f428880aeba233adc6b6c) is 6M, max 48.5M, 42.4M free. Dec 16 12:40:08.782618 systemd-modules-load[247]: Inserted module 'overlay' Dec 16 12:40:08.797981 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:40:08.800669 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:40:08.801619 systemd-modules-load[247]: Inserted module 'br_netfilter' Dec 16 12:40:08.802446 kernel: Bridge firewalling registered Dec 16 12:40:08.810980 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:40:08.812188 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:40:08.814638 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:40:08.820901 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Dec 16 12:40:08.827111 systemd-tmpfiles[264]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Dec 16 12:40:08.827398 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Dec 16 12:40:08.830433 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:40:08.847841 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:40:08.849442 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:40:08.857354 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:40:08.860250 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:40:08.864176 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:40:08.865712 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:40:08.869817 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Dec 16 12:40:08.892077 dracut-cmdline[290]: 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=361f5baddf90aee3bc7ee7e9be879bc0cc94314f224faa1e2791d9b44cd3ec52 Dec 16 12:40:08.908764 systemd-resolved[286]: Positive Trust Anchors: Dec 16 12:40:08.908781 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:40:08.908811 systemd-resolved[286]: 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:40:08.913532 systemd-resolved[286]: Defaulting to hostname 'linux'. Dec 16 12:40:08.917493 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:40:08.918544 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:40:08.981762 kernel: SCSI subsystem initialized Dec 16 12:40:08.986664 kernel: Loading iSCSI transport class v2.0-870. Dec 16 12:40:08.997662 kernel: iscsi: registered transport (tcp) Dec 16 12:40:09.010685 kernel: iscsi: registered transport (qla4xxx) Dec 16 12:40:09.010719 kernel: QLogic iSCSI HBA Driver Dec 16 12:40:09.028117 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:40:09.050452 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:40:09.052539 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:40:09.103826 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Dec 16 12:40:09.107134 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Dec 16 12:40:09.177686 kernel: raid6: neonx8 gen() 15234 MB/s Dec 16 12:40:09.194677 kernel: raid6: neonx4 gen() 15325 MB/s Dec 16 12:40:09.211680 kernel: raid6: neonx2 gen() 12011 MB/s Dec 16 12:40:09.228672 kernel: raid6: neonx1 gen() 10204 MB/s Dec 16 12:40:09.245672 kernel: raid6: int64x8 gen() 6477 MB/s Dec 16 12:40:09.262666 kernel: raid6: int64x4 gen() 7334 MB/s Dec 16 12:40:09.279666 kernel: raid6: int64x2 gen() 6098 MB/s Dec 16 12:40:09.296825 kernel: raid6: int64x1 gen() 5036 MB/s Dec 16 12:40:09.296840 kernel: raid6: using algorithm neonx4 gen() 15325 MB/s Dec 16 12:40:09.314670 kernel: raid6: .... xor() 11899 MB/s, rmw enabled Dec 16 12:40:09.314691 kernel: raid6: using neon recovery algorithm Dec 16 12:40:09.319673 kernel: xor: measuring software checksum speed Dec 16 12:40:09.320914 kernel: 8regs : 18030 MB/sec Dec 16 12:40:09.320930 kernel: 32regs : 21156 MB/sec Dec 16 12:40:09.322142 kernel: arm64_neon : 27974 MB/sec Dec 16 12:40:09.322154 kernel: xor: using function: arm64_neon (27974 MB/sec) Dec 16 12:40:09.374696 kernel: Btrfs loaded, zoned=no, fsverity=no Dec 16 12:40:09.381029 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:40:09.383753 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:40:09.414182 systemd-udevd[501]: Using default interface naming scheme 'v255'. Dec 16 12:40:09.418485 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:40:09.421223 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Dec 16 12:40:09.446197 dracut-pre-trigger[510]: rd.md=0: removing MD RAID activation Dec 16 12:40:09.471025 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:40:09.474807 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:40:09.528722 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:40:09.531391 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Dec 16 12:40:09.584221 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Dec 16 12:40:09.584721 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Dec 16 12:40:09.594473 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:40:09.596873 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:40:09.597005 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:40:09.600777 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:40:09.603219 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:40:09.624189 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Dec 16 12:40:09.634507 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Dec 16 12:40:09.635843 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:40:09.645338 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Dec 16 12:40:09.652075 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Dec 16 12:40:09.653235 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Dec 16 12:40:09.662494 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:40:09.663761 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:40:09.665626 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:40:09.667664 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:40:09.670358 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Dec 16 12:40:09.672352 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Dec 16 12:40:09.696731 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:40:09.700667 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:40:10.709685 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Dec 16 12:40:10.709955 disk-uuid[598]: The operation has completed successfully. Dec 16 12:40:10.734531 systemd[1]: disk-uuid.service: Deactivated successfully. Dec 16 12:40:10.734642 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Dec 16 12:40:10.758868 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Dec 16 12:40:10.790412 sh[611]: Success Dec 16 12:40:10.801998 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Dec 16 12:40:10.802043 kernel: device-mapper: uevent: version 1.0.3 Dec 16 12:40:10.803136 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Dec 16 12:40:10.811671 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Dec 16 12:40:10.836542 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Dec 16 12:40:10.839438 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Dec 16 12:40:10.855181 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Dec 16 12:40:10.861173 kernel: BTRFS: device fsid 6d6d314d-b8a1-4727-8a34-8525e276a248 devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (623) Dec 16 12:40:10.861210 kernel: BTRFS info (device dm-0): first mount of filesystem 6d6d314d-b8a1-4727-8a34-8525e276a248 Dec 16 12:40:10.861220 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:40:10.866116 kernel: BTRFS info (device dm-0): disabling log replay at mount time Dec 16 12:40:10.866139 kernel: BTRFS info (device dm-0): enabling free space tree Dec 16 12:40:10.867081 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Dec 16 12:40:10.868263 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:40:10.869432 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Dec 16 12:40:10.870227 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Dec 16 12:40:10.873088 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Dec 16 12:40:10.906687 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (656) Dec 16 12:40:10.908691 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:40:10.908727 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:40:10.913336 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:40:10.913387 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:40:10.917746 kernel: BTRFS info (device vda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:40:10.919982 systemd[1]: Finished ignition-setup.service - Ignition (setup). Dec 16 12:40:10.921789 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Dec 16 12:40:10.997275 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:40:11.000083 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:40:11.036357 ignition[701]: Ignition 2.22.0 Dec 16 12:40:11.036372 ignition[701]: Stage: fetch-offline Dec 16 12:40:11.036410 ignition[701]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:11.036417 ignition[701]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:11.036497 ignition[701]: parsed url from cmdline: "" Dec 16 12:40:11.036501 ignition[701]: no config URL provided Dec 16 12:40:11.036506 ignition[701]: reading system config file "/usr/lib/ignition/user.ign" Dec 16 12:40:11.036512 ignition[701]: no config at "/usr/lib/ignition/user.ign" Dec 16 12:40:11.041130 systemd-networkd[802]: lo: Link UP Dec 16 12:40:11.036532 ignition[701]: op(1): [started] loading QEMU firmware config module Dec 16 12:40:11.041134 systemd-networkd[802]: lo: Gained carrier Dec 16 12:40:11.036538 ignition[701]: op(1): executing: "modprobe" "qemu_fw_cfg" Dec 16 12:40:11.042025 systemd-networkd[802]: Enumeration completed Dec 16 12:40:11.044025 ignition[701]: op(1): [finished] loading QEMU firmware config module Dec 16 12:40:11.042490 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:40:11.042494 systemd-networkd[802]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:40:11.042547 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:40:11.043161 systemd-networkd[802]: eth0: Link UP Dec 16 12:40:11.055210 ignition[701]: parsing config with SHA512: 2262005941a31ba0601fbd2a4d15fc2b4ed1947caa23da6825a300638396176aff6eeef252989f340db0a9722354cd1c39cc2c003218d8394e5662b3dcc3cffb Dec 16 12:40:11.043479 systemd-networkd[802]: eth0: Gained carrier Dec 16 12:40:11.043490 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:40:11.043977 systemd[1]: Reached target network.target - Network. Dec 16 12:40:11.062708 unknown[701]: fetched base config from "system" Dec 16 12:40:11.062724 unknown[701]: fetched user config from "qemu" Dec 16 12:40:11.062984 ignition[701]: fetch-offline: fetch-offline passed Dec 16 12:40:11.063731 systemd-networkd[802]: eth0: DHCPv4 address 10.0.0.106/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:40:11.063073 ignition[701]: Ignition finished successfully Dec 16 12:40:11.065951 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:40:11.067887 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Dec 16 12:40:11.068841 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Dec 16 12:40:11.104519 ignition[813]: Ignition 2.22.0 Dec 16 12:40:11.104535 ignition[813]: Stage: kargs Dec 16 12:40:11.104691 ignition[813]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:11.104700 ignition[813]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:11.105179 ignition[813]: kargs: kargs passed Dec 16 12:40:11.105218 ignition[813]: Ignition finished successfully Dec 16 12:40:11.110431 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Dec 16 12:40:11.112790 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Dec 16 12:40:11.144003 ignition[821]: Ignition 2.22.0 Dec 16 12:40:11.144020 ignition[821]: Stage: disks Dec 16 12:40:11.144157 ignition[821]: no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:11.146504 systemd[1]: Finished ignition-disks.service - Ignition (disks). Dec 16 12:40:11.144166 ignition[821]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:11.148133 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Dec 16 12:40:11.144688 ignition[821]: disks: disks passed Dec 16 12:40:11.149658 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Dec 16 12:40:11.144735 ignition[821]: Ignition finished successfully Dec 16 12:40:11.151719 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:40:11.153375 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:40:11.154743 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:40:11.157510 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Dec 16 12:40:11.185034 systemd-fsck[831]: ROOT: clean, 15/553520 files, 52789/553472 blocks Dec 16 12:40:11.193695 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Dec 16 12:40:11.196099 systemd[1]: Mounting sysroot.mount - /sysroot... Dec 16 12:40:11.268676 kernel: EXT4-fs (vda9): mounted filesystem 895d7845-d0e8-43ae-a778-7804b473b868 r/w with ordered data mode. Quota mode: none. Dec 16 12:40:11.270337 systemd[1]: Mounted sysroot.mount - /sysroot. Dec 16 12:40:11.274369 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Dec 16 12:40:11.279097 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:40:11.283963 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Dec 16 12:40:11.284917 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Dec 16 12:40:11.284974 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:40:11.285001 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:40:11.293762 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Dec 16 12:40:11.296630 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Dec 16 12:40:11.304194 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (839) Dec 16 12:40:11.304229 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:40:11.304240 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:40:11.304249 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:40:11.304259 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:40:11.306126 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:40:11.335158 initrd-setup-root[863]: cut: /sysroot/etc/passwd: No such file or directory Dec 16 12:40:11.339142 initrd-setup-root[870]: cut: /sysroot/etc/group: No such file or directory Dec 16 12:40:11.343714 initrd-setup-root[877]: cut: /sysroot/etc/shadow: No such file or directory Dec 16 12:40:11.347870 initrd-setup-root[884]: cut: /sysroot/etc/gshadow: No such file or directory Dec 16 12:40:11.426171 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Dec 16 12:40:11.428380 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Dec 16 12:40:11.430078 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Dec 16 12:40:11.447691 kernel: BTRFS info (device vda6): last unmount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:40:11.461698 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Dec 16 12:40:11.476074 ignition[953]: INFO : Ignition 2.22.0 Dec 16 12:40:11.476074 ignition[953]: INFO : Stage: mount Dec 16 12:40:11.477574 ignition[953]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:11.477574 ignition[953]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:11.477574 ignition[953]: INFO : mount: mount passed Dec 16 12:40:11.477574 ignition[953]: INFO : Ignition finished successfully Dec 16 12:40:11.478620 systemd[1]: Finished ignition-mount.service - Ignition (mount). Dec 16 12:40:11.484000 systemd[1]: Starting ignition-files.service - Ignition (files)... Dec 16 12:40:11.860023 systemd[1]: sysroot-oem.mount: Deactivated successfully. Dec 16 12:40:11.866466 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Dec 16 12:40:11.897926 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (965) Dec 16 12:40:11.898200 kernel: BTRFS info (device vda6): first mount of filesystem 4b8ce5a5-a2aa-4c44-bc9b-80e30d06d25f Dec 16 12:40:11.900998 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Dec 16 12:40:11.904201 kernel: BTRFS info (device vda6): turning on async discard Dec 16 12:40:11.904238 kernel: BTRFS info (device vda6): enabling free space tree Dec 16 12:40:11.906970 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Dec 16 12:40:11.948332 ignition[982]: INFO : Ignition 2.22.0 Dec 16 12:40:11.948332 ignition[982]: INFO : Stage: files Dec 16 12:40:11.950605 ignition[982]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:11.950605 ignition[982]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:11.950605 ignition[982]: DEBUG : files: compiled without relabeling support, skipping Dec 16 12:40:11.950605 ignition[982]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Dec 16 12:40:11.950605 ignition[982]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Dec 16 12:40:11.957341 ignition[982]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Dec 16 12:40:11.957341 ignition[982]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Dec 16 12:40:11.957341 ignition[982]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Dec 16 12:40:11.953014 unknown[982]: wrote ssh authorized keys file for user: core Dec 16 12:40:11.963004 ignition[982]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:40:11.963004 ignition[982]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(4): [started] processing unit "docker.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(4): [finished] processing unit "docker.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Dec 16 12:40:11.963004 ignition[982]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Dec 16 12:40:11.981119 ignition[982]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:40:11.987612 ignition[982]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Dec 16 12:40:11.990324 ignition[982]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Dec 16 12:40:11.990324 ignition[982]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Dec 16 12:40:11.990324 ignition[982]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Dec 16 12:40:11.990324 ignition[982]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:40:11.990324 ignition[982]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Dec 16 12:40:11.990324 ignition[982]: INFO : files: files passed Dec 16 12:40:11.990324 ignition[982]: INFO : Ignition finished successfully Dec 16 12:40:11.991094 systemd[1]: Finished ignition-files.service - Ignition (files). Dec 16 12:40:11.993501 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Dec 16 12:40:11.997831 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Dec 16 12:40:12.010248 systemd[1]: ignition-quench.service: Deactivated successfully. Dec 16 12:40:12.010368 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Dec 16 12:40:12.017483 initrd-setup-root-after-ignition[1010]: grep: /sysroot/oem/oem-release: No such file or directory Dec 16 12:40:12.019108 initrd-setup-root-after-ignition[1012]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:40:12.019108 initrd-setup-root-after-ignition[1012]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:40:12.022441 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Dec 16 12:40:12.021024 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:40:12.023916 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Dec 16 12:40:12.027038 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Dec 16 12:40:12.076534 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Dec 16 12:40:12.077705 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Dec 16 12:40:12.079341 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Dec 16 12:40:12.080394 systemd[1]: Reached target initrd.target - Initrd Default Target. Dec 16 12:40:12.081410 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Dec 16 12:40:12.082319 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Dec 16 12:40:12.099296 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:40:12.102141 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Dec 16 12:40:12.125282 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:40:12.126638 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:40:12.128969 systemd[1]: Stopped target timers.target - Timer Units. Dec 16 12:40:12.130642 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Dec 16 12:40:12.130791 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Dec 16 12:40:12.133249 systemd[1]: Stopped target initrd.target - Initrd Default Target. Dec 16 12:40:12.135268 systemd[1]: Stopped target basic.target - Basic System. Dec 16 12:40:12.137162 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Dec 16 12:40:12.138804 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Dec 16 12:40:12.140639 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Dec 16 12:40:12.142468 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Dec 16 12:40:12.144126 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Dec 16 12:40:12.145690 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Dec 16 12:40:12.147866 systemd[1]: Stopped target sysinit.target - System Initialization. Dec 16 12:40:12.150019 systemd[1]: Stopped target local-fs.target - Local File Systems. Dec 16 12:40:12.152049 systemd[1]: Stopped target swap.target - Swaps. Dec 16 12:40:12.153517 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Dec 16 12:40:12.153683 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Dec 16 12:40:12.155744 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:40:12.157567 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:40:12.159334 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Dec 16 12:40:12.159477 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:40:12.161365 systemd[1]: dracut-initqueue.service: Deactivated successfully. Dec 16 12:40:12.161500 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Dec 16 12:40:12.164117 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Dec 16 12:40:12.164248 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Dec 16 12:40:12.165981 systemd[1]: Stopped target paths.target - Path Units. Dec 16 12:40:12.167438 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Dec 16 12:40:12.171089 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:40:12.173865 systemd[1]: Stopped target slices.target - Slice Units. Dec 16 12:40:12.174728 systemd[1]: Stopped target sockets.target - Socket Units. Dec 16 12:40:12.176324 systemd[1]: iscsid.socket: Deactivated successfully. Dec 16 12:40:12.176416 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Dec 16 12:40:12.177797 systemd[1]: iscsiuio.socket: Deactivated successfully. Dec 16 12:40:12.177875 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Dec 16 12:40:12.179481 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Dec 16 12:40:12.179605 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Dec 16 12:40:12.181235 systemd[1]: ignition-files.service: Deactivated successfully. Dec 16 12:40:12.181343 systemd[1]: Stopped ignition-files.service - Ignition (files). Dec 16 12:40:12.183527 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Dec 16 12:40:12.185112 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Dec 16 12:40:12.185236 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:40:12.210338 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Dec 16 12:40:12.211227 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Dec 16 12:40:12.211373 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:40:12.213134 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Dec 16 12:40:12.213243 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Dec 16 12:40:12.219119 systemd[1]: initrd-cleanup.service: Deactivated successfully. Dec 16 12:40:12.219214 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Dec 16 12:40:12.228339 systemd[1]: sysroot-boot.mount: Deactivated successfully. Dec 16 12:40:12.230685 ignition[1037]: INFO : Ignition 2.22.0 Dec 16 12:40:12.230685 ignition[1037]: INFO : Stage: umount Dec 16 12:40:12.233389 ignition[1037]: INFO : no configs at "/usr/lib/ignition/base.d" Dec 16 12:40:12.233389 ignition[1037]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Dec 16 12:40:12.233389 ignition[1037]: INFO : umount: umount passed Dec 16 12:40:12.233389 ignition[1037]: INFO : Ignition finished successfully Dec 16 12:40:12.234750 systemd[1]: ignition-mount.service: Deactivated successfully. Dec 16 12:40:12.234893 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Dec 16 12:40:12.236509 systemd[1]: sysroot-boot.service: Deactivated successfully. Dec 16 12:40:12.236589 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Dec 16 12:40:12.238631 systemd[1]: Stopped target network.target - Network. Dec 16 12:40:12.239857 systemd[1]: ignition-disks.service: Deactivated successfully. Dec 16 12:40:12.239917 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Dec 16 12:40:12.241367 systemd[1]: ignition-kargs.service: Deactivated successfully. Dec 16 12:40:12.241411 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Dec 16 12:40:12.242751 systemd[1]: ignition-setup.service: Deactivated successfully. Dec 16 12:40:12.242800 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Dec 16 12:40:12.244142 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Dec 16 12:40:12.244186 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Dec 16 12:40:12.245502 systemd[1]: initrd-setup-root.service: Deactivated successfully. Dec 16 12:40:12.245552 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Dec 16 12:40:12.247125 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Dec 16 12:40:12.248515 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Dec 16 12:40:12.254888 systemd[1]: systemd-resolved.service: Deactivated successfully. Dec 16 12:40:12.256736 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Dec 16 12:40:12.260539 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Dec 16 12:40:12.260835 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Dec 16 12:40:12.260884 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:40:12.263548 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Dec 16 12:40:12.264596 systemd[1]: systemd-networkd.service: Deactivated successfully. Dec 16 12:40:12.264723 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Dec 16 12:40:12.266561 systemd[1]: Stopped target network-pre.target - Preparation for Network. Dec 16 12:40:12.269166 systemd[1]: systemd-networkd.socket: Deactivated successfully. Dec 16 12:40:12.269204 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:40:12.272164 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Dec 16 12:40:12.274250 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Dec 16 12:40:12.274342 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Dec 16 12:40:12.276248 systemd[1]: systemd-sysctl.service: Deactivated successfully. Dec 16 12:40:12.276324 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:40:12.278583 systemd[1]: systemd-modules-load.service: Deactivated successfully. Dec 16 12:40:12.278627 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Dec 16 12:40:12.280388 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:40:12.296413 systemd[1]: systemd-udevd.service: Deactivated successfully. Dec 16 12:40:12.296570 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:40:12.298758 systemd[1]: network-cleanup.service: Deactivated successfully. Dec 16 12:40:12.300476 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Dec 16 12:40:12.301869 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Dec 16 12:40:12.301930 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Dec 16 12:40:12.303421 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Dec 16 12:40:12.303456 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:40:12.304990 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Dec 16 12:40:12.305042 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Dec 16 12:40:12.307237 systemd[1]: dracut-cmdline.service: Deactivated successfully. Dec 16 12:40:12.307290 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Dec 16 12:40:12.308944 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Dec 16 12:40:12.309002 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Dec 16 12:40:12.312368 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Dec 16 12:40:12.314219 systemd[1]: systemd-network-generator.service: Deactivated successfully. Dec 16 12:40:12.314295 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:40:12.317848 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Dec 16 12:40:12.317891 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:40:12.320551 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Dec 16 12:40:12.320594 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:40:12.329695 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Dec 16 12:40:12.330685 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Dec 16 12:40:12.332996 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Dec 16 12:40:12.335463 systemd[1]: Starting initrd-switch-root.service - Switch Root... Dec 16 12:40:12.357312 systemd[1]: Switching root. Dec 16 12:40:12.386206 systemd-journald[246]: Journal stopped Dec 16 12:40:13.096340 systemd-journald[246]: Received SIGTERM from PID 1 (systemd). Dec 16 12:40:13.096393 kernel: SELinux: policy capability network_peer_controls=1 Dec 16 12:40:13.096405 kernel: SELinux: policy capability open_perms=1 Dec 16 12:40:13.096416 kernel: SELinux: policy capability extended_socket_class=1 Dec 16 12:40:13.096434 kernel: SELinux: policy capability always_check_network=0 Dec 16 12:40:13.096448 kernel: SELinux: policy capability cgroup_seclabel=1 Dec 16 12:40:13.096460 kernel: SELinux: policy capability nnp_nosuid_transition=1 Dec 16 12:40:13.096469 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Dec 16 12:40:13.096478 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Dec 16 12:40:13.096487 kernel: SELinux: policy capability userspace_initial_context=0 Dec 16 12:40:13.096496 kernel: audit: type=1403 audit(1765888812.479:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Dec 16 12:40:13.096510 systemd[1]: Successfully loaded SELinux policy in 62.373ms. Dec 16 12:40:13.096526 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.545ms. Dec 16 12:40:13.096537 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Dec 16 12:40:13.096548 systemd[1]: Detected virtualization kvm. Dec 16 12:40:13.096560 systemd[1]: Detected architecture arm64. Dec 16 12:40:13.096570 systemd[1]: Detected first boot. Dec 16 12:40:13.096580 systemd[1]: Initializing machine ID from VM UUID. Dec 16 12:40:13.096591 zram_generator::config[1084]: No configuration found. Dec 16 12:40:13.096602 kernel: NET: Registered PF_VSOCK protocol family Dec 16 12:40:13.096613 systemd[1]: Populated /etc with preset unit settings. Dec 16 12:40:13.096626 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Dec 16 12:40:13.096637 systemd[1]: initrd-switch-root.service: Deactivated successfully. Dec 16 12:40:13.096673 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Dec 16 12:40:13.096686 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Dec 16 12:40:13.096698 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Dec 16 12:40:13.096710 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Dec 16 12:40:13.096721 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Dec 16 12:40:13.096731 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Dec 16 12:40:13.096741 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Dec 16 12:40:13.096753 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Dec 16 12:40:13.096763 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Dec 16 12:40:13.096773 systemd[1]: Created slice user.slice - User and Session Slice. Dec 16 12:40:13.096784 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Dec 16 12:40:13.096795 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Dec 16 12:40:13.096806 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Dec 16 12:40:13.096817 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Dec 16 12:40:13.096827 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Dec 16 12:40:13.096838 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Dec 16 12:40:13.096850 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Dec 16 12:40:13.096860 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Dec 16 12:40:13.096871 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Dec 16 12:40:13.096882 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Dec 16 12:40:13.096892 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Dec 16 12:40:13.096903 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Dec 16 12:40:13.096913 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Dec 16 12:40:13.096923 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Dec 16 12:40:13.096935 systemd[1]: Reached target remote-fs.target - Remote File Systems. Dec 16 12:40:13.096946 systemd[1]: Reached target slices.target - Slice Units. Dec 16 12:40:13.096956 systemd[1]: Reached target swap.target - Swaps. Dec 16 12:40:13.096966 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Dec 16 12:40:13.096976 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Dec 16 12:40:13.096987 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Dec 16 12:40:13.096997 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Dec 16 12:40:13.097007 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Dec 16 12:40:13.097018 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Dec 16 12:40:13.097029 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Dec 16 12:40:13.097040 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Dec 16 12:40:13.097050 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Dec 16 12:40:13.097060 systemd[1]: Mounting media.mount - External Media Directory... Dec 16 12:40:13.097069 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Dec 16 12:40:13.097080 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Dec 16 12:40:13.097090 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Dec 16 12:40:13.097100 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:40:13.097110 systemd[1]: Reached target machines.target - Containers. Dec 16 12:40:13.097123 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Dec 16 12:40:13.097133 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:40:13.097144 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Dec 16 12:40:13.097154 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Dec 16 12:40:13.097165 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:40:13.097175 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:40:13.097186 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:40:13.097196 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Dec 16 12:40:13.097208 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:40:13.097219 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Dec 16 12:40:13.097230 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Dec 16 12:40:13.097245 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Dec 16 12:40:13.097256 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Dec 16 12:40:13.097266 systemd[1]: Stopped systemd-fsck-usr.service. Dec 16 12:40:13.097284 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:40:13.097298 kernel: fuse: init (API version 7.41) Dec 16 12:40:13.097309 systemd[1]: Starting systemd-journald.service - Journal Service... Dec 16 12:40:13.097321 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Dec 16 12:40:13.097331 kernel: loop: module loaded Dec 16 12:40:13.097340 kernel: ACPI: bus type drm_connector registered Dec 16 12:40:13.097349 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Dec 16 12:40:13.097360 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Dec 16 12:40:13.097371 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Dec 16 12:40:13.097381 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Dec 16 12:40:13.097391 systemd[1]: verity-setup.service: Deactivated successfully. Dec 16 12:40:13.097402 systemd[1]: Stopped verity-setup.service. Dec 16 12:40:13.097413 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Dec 16 12:40:13.097424 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Dec 16 12:40:13.097459 systemd-journald[1159]: Collecting audit messages is disabled. Dec 16 12:40:13.097484 systemd[1]: Mounted media.mount - External Media Directory. Dec 16 12:40:13.097495 systemd-journald[1159]: Journal started Dec 16 12:40:13.097515 systemd-journald[1159]: Runtime Journal (/run/log/journal/560dc18ec51f428880aeba233adc6b6c) is 6M, max 48.5M, 42.4M free. Dec 16 12:40:13.099708 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Dec 16 12:40:12.873459 systemd[1]: Queued start job for default target multi-user.target. Dec 16 12:40:12.895772 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Dec 16 12:40:12.896171 systemd[1]: systemd-journald.service: Deactivated successfully. Dec 16 12:40:13.101352 systemd[1]: Started systemd-journald.service - Journal Service. Dec 16 12:40:13.102019 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Dec 16 12:40:13.103114 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Dec 16 12:40:13.105680 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Dec 16 12:40:13.106918 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Dec 16 12:40:13.108253 systemd[1]: modprobe@configfs.service: Deactivated successfully. Dec 16 12:40:13.108432 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Dec 16 12:40:13.109861 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:40:13.110020 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:40:13.111194 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:40:13.111362 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:40:13.112556 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:40:13.112732 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:40:13.114129 systemd[1]: modprobe@fuse.service: Deactivated successfully. Dec 16 12:40:13.114296 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Dec 16 12:40:13.115474 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:40:13.115618 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:40:13.118147 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Dec 16 12:40:13.119412 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Dec 16 12:40:13.121170 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Dec 16 12:40:13.122514 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Dec 16 12:40:13.135989 systemd[1]: Reached target network-pre.target - Preparation for Network. Dec 16 12:40:13.138168 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Dec 16 12:40:13.140108 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Dec 16 12:40:13.141119 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Dec 16 12:40:13.141149 systemd[1]: Reached target local-fs.target - Local File Systems. Dec 16 12:40:13.142824 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Dec 16 12:40:13.154342 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Dec 16 12:40:13.155423 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:40:13.156595 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Dec 16 12:40:13.158559 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Dec 16 12:40:13.159896 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:40:13.161775 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Dec 16 12:40:13.162946 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:40:13.165795 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Dec 16 12:40:13.170020 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Dec 16 12:40:13.170419 systemd-journald[1159]: Time spent on flushing to /var/log/journal/560dc18ec51f428880aeba233adc6b6c is 15.389ms for 848 entries. Dec 16 12:40:13.170419 systemd-journald[1159]: System Journal (/var/log/journal/560dc18ec51f428880aeba233adc6b6c) is 8M, max 195.6M, 187.6M free. Dec 16 12:40:13.197775 systemd-journald[1159]: Received client request to flush runtime journal. Dec 16 12:40:13.197825 kernel: loop0: detected capacity change from 0 to 100632 Dec 16 12:40:13.180823 systemd[1]: Starting systemd-sysusers.service - Create System Users... Dec 16 12:40:13.183540 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Dec 16 12:40:13.185012 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Dec 16 12:40:13.186203 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Dec 16 12:40:13.198883 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Dec 16 12:40:13.201084 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Dec 16 12:40:13.205224 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Dec 16 12:40:13.208121 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Dec 16 12:40:13.209688 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Dec 16 12:40:13.219687 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Dec 16 12:40:13.227581 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Dec 16 12:40:13.246932 kernel: loop1: detected capacity change from 0 to 119840 Dec 16 12:40:13.247039 systemd[1]: Finished systemd-sysusers.service - Create System Users. Dec 16 12:40:13.252209 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Dec 16 12:40:13.277678 kernel: loop2: detected capacity change from 0 to 100632 Dec 16 12:40:13.283675 kernel: loop3: detected capacity change from 0 to 119840 Dec 16 12:40:13.286340 systemd-tmpfiles[1218]: ACLs are not supported, ignoring. Dec 16 12:40:13.286352 systemd-tmpfiles[1218]: ACLs are not supported, ignoring. Dec 16 12:40:13.290053 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Dec 16 12:40:13.297611 (sd-merge)[1221]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Dec 16 12:40:13.297979 (sd-merge)[1221]: Merged extensions into '/usr'. Dec 16 12:40:13.300410 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Dec 16 12:40:13.303206 systemd[1]: Starting ensure-sysext.service... Dec 16 12:40:13.306842 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Dec 16 12:40:13.318813 systemd[1]: Reload requested from client PID 1226 ('systemctl') (unit ensure-sysext.service)... Dec 16 12:40:13.318825 systemd[1]: Reloading... Dec 16 12:40:13.326479 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Dec 16 12:40:13.326520 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Dec 16 12:40:13.327917 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Dec 16 12:40:13.328351 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Dec 16 12:40:13.329370 systemd-tmpfiles[1227]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Dec 16 12:40:13.329808 systemd-tmpfiles[1227]: ACLs are not supported, ignoring. Dec 16 12:40:13.329914 systemd-tmpfiles[1227]: ACLs are not supported, ignoring. Dec 16 12:40:13.333486 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:40:13.333499 systemd-tmpfiles[1227]: Skipping /boot Dec 16 12:40:13.339378 systemd-tmpfiles[1227]: Detected autofs mount point /boot during canonicalization of boot. Dec 16 12:40:13.339392 systemd-tmpfiles[1227]: Skipping /boot Dec 16 12:40:13.371699 zram_generator::config[1254]: No configuration found. Dec 16 12:40:13.490023 ldconfig[1196]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Dec 16 12:40:13.520581 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Dec 16 12:40:13.520750 systemd[1]: Reloading finished in 201 ms. Dec 16 12:40:13.548393 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Dec 16 12:40:13.566512 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Dec 16 12:40:13.576155 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:40:13.578781 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Dec 16 12:40:13.588032 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Dec 16 12:40:13.592667 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Dec 16 12:40:13.597978 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Dec 16 12:40:13.601112 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:40:13.602640 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:40:13.604729 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:40:13.609443 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:40:13.610562 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:40:13.610691 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:40:13.613330 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:40:13.613497 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:40:13.613582 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:40:13.616404 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Dec 16 12:40:13.618756 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:40:13.619058 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:40:13.621582 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:40:13.623874 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:40:13.625821 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:40:13.625969 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:40:13.633524 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Dec 16 12:40:13.634866 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Dec 16 12:40:13.637117 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Dec 16 12:40:13.639873 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Dec 16 12:40:13.646873 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Dec 16 12:40:13.647804 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Dec 16 12:40:13.647844 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:40:13.648504 systemd[1]: Finished ensure-sysext.service. Dec 16 12:40:13.649791 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Dec 16 12:40:13.651332 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Dec 16 12:40:13.652974 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Dec 16 12:40:13.653121 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Dec 16 12:40:13.654727 systemd[1]: modprobe@loop.service: Deactivated successfully. Dec 16 12:40:13.656701 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Dec 16 12:40:13.661972 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Dec 16 12:40:13.664519 augenrules[1330]: No rules Dec 16 12:40:13.671721 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Dec 16 12:40:13.673240 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Dec 16 12:40:13.674581 systemd[1]: Started systemd-userdbd.service - User Database Manager. Dec 16 12:40:13.675865 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:40:13.677732 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:40:13.684821 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Dec 16 12:40:13.686089 systemd[1]: modprobe@drm.service: Deactivated successfully. Dec 16 12:40:13.686243 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Dec 16 12:40:13.687512 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Dec 16 12:40:13.687737 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Dec 16 12:40:13.693111 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Dec 16 12:40:13.700859 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Dec 16 12:40:13.705785 systemd[1]: Starting systemd-update-done.service - Update is Completed... Dec 16 12:40:13.706635 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:40:13.714211 systemd[1]: Finished systemd-update-done.service - Update is Completed. Dec 16 12:40:13.728378 systemd-udevd[1348]: Using default interface naming scheme 'v255'. Dec 16 12:40:13.729537 systemd-resolved[1295]: Positive Trust Anchors: Dec 16 12:40:13.729888 systemd-resolved[1295]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Dec 16 12:40:13.729978 systemd-resolved[1295]: 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:40:13.736586 systemd-resolved[1295]: Defaulting to hostname 'linux'. Dec 16 12:40:13.738091 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Dec 16 12:40:13.739252 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Dec 16 12:40:13.740453 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Dec 16 12:40:13.741711 systemd[1]: Reached target time-set.target - System Time Set. Dec 16 12:40:13.744870 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Dec 16 12:40:13.746299 systemd[1]: Reached target sysinit.target - System Initialization. Dec 16 12:40:13.748627 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Dec 16 12:40:13.749668 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:40:13.750827 systemd[1]: Started logrotate.timer - Daily rotation of log files. Dec 16 12:40:13.752289 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Dec 16 12:40:13.753793 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Dec 16 12:40:13.755508 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Dec 16 12:40:13.755550 systemd[1]: Reached target paths.target - Path Units. Dec 16 12:40:13.756567 systemd[1]: Reached target timers.target - Timer Units. Dec 16 12:40:13.758662 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Dec 16 12:40:13.762057 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:40:13.766078 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Dec 16 12:40:13.767867 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Dec 16 12:40:13.769564 systemd[1]: Reached target ssh-access.target - SSH Access Available. Dec 16 12:40:13.774139 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Dec 16 12:40:13.775985 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Dec 16 12:40:13.780330 systemd[1]: Starting systemd-networkd.service - Network Configuration... Dec 16 12:40:13.782252 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:40:13.788989 systemd[1]: Reached target sockets.target - Socket Units. Dec 16 12:40:13.790738 systemd[1]: Reached target basic.target - Basic System. Dec 16 12:40:13.792790 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:40:13.792822 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Dec 16 12:40:13.794828 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Dec 16 12:40:13.797849 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Dec 16 12:40:13.801184 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Dec 16 12:40:13.804188 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Dec 16 12:40:13.805735 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:40:13.810818 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Dec 16 12:40:13.815168 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Dec 16 12:40:13.817495 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Dec 16 12:40:13.818462 jq[1384]: false Dec 16 12:40:13.820692 systemd[1]: Starting systemd-logind.service - User Login Management... Dec 16 12:40:13.823722 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Dec 16 12:40:13.824206 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Dec 16 12:40:13.826147 systemd[1]: Starting update-engine.service - Update Engine... Dec 16 12:40:13.830776 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Dec 16 12:40:13.832991 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Dec 16 12:40:13.835502 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Dec 16 12:40:13.835874 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Dec 16 12:40:13.836154 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Dec 16 12:40:13.836396 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Dec 16 12:40:13.838554 jq[1399]: true Dec 16 12:40:13.850251 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Dec 16 12:40:13.850532 extend-filesystems[1385]: Found /dev/vda6 Dec 16 12:40:13.857875 extend-filesystems[1385]: Found /dev/vda9 Dec 16 12:40:13.859375 jq[1403]: true Dec 16 12:40:13.862534 extend-filesystems[1385]: Checking size of /dev/vda9 Dec 16 12:40:13.867291 update_engine[1398]: I20251216 12:40:13.866986 1398 main.cc:92] Flatcar Update Engine starting Dec 16 12:40:13.874043 systemd[1]: motdgen.service: Deactivated successfully. Dec 16 12:40:13.877000 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Dec 16 12:40:13.878019 dbus-daemon[1382]: [system] SELinux support is enabled Dec 16 12:40:13.879015 systemd[1]: Started dbus.service - D-Bus System Message Bus. Dec 16 12:40:13.880579 extend-filesystems[1385]: Old size kept for /dev/vda9 Dec 16 12:40:13.885095 update_engine[1398]: I20251216 12:40:13.885036 1398 update_check_scheduler.cc:74] Next update check in 2m52s Dec 16 12:40:13.885206 systemd[1]: extend-filesystems.service: Deactivated successfully. Dec 16 12:40:13.885457 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Dec 16 12:40:13.891218 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:40:13.891277 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Dec 16 12:40:13.893843 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:40:13.893875 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Dec 16 12:40:13.896048 systemd[1]: Started update-engine.service - Update Engine. Dec 16 12:40:13.905113 systemd-logind[1396]: New seat seat0. Dec 16 12:40:13.913919 systemd[1]: Started systemd-logind.service - User Login Management. Dec 16 12:40:13.935681 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Dec 16 12:40:13.939900 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Dec 16 12:40:13.943275 systemd-networkd[1381]: lo: Link UP Dec 16 12:40:13.943287 systemd-networkd[1381]: lo: Gained carrier Dec 16 12:40:13.944212 systemd-networkd[1381]: Enumeration completed Dec 16 12:40:13.944706 systemd-networkd[1381]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:40:13.944713 systemd-networkd[1381]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Dec 16 12:40:13.944730 systemd[1]: Started locksmithd.service - Cluster reboot manager. Dec 16 12:40:13.945714 systemd-networkd[1381]: eth0: Link UP Dec 16 12:40:13.945870 systemd-networkd[1381]: eth0: Gained carrier Dec 16 12:40:13.945889 systemd-networkd[1381]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Dec 16 12:40:13.946428 systemd[1]: Started systemd-networkd.service - Network Configuration. Dec 16 12:40:13.947944 systemd[1]: Reached target network.target - Network. Dec 16 12:40:13.948720 bash[1438]: Updated "/home/core/.ssh/authorized_keys" Dec 16 12:40:13.958906 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:40:13.962187 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Dec 16 12:40:13.962250 systemd-networkd[1381]: eth0: DHCPv4 address 10.0.0.106/16, gateway 10.0.0.1 acquired from 10.0.0.1 Dec 16 12:40:13.963760 systemd-timesyncd[1337]: Network configuration changed, trying to establish connection. Dec 16 12:40:13.965853 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Dec 16 12:40:14.407129 systemd-timesyncd[1337]: Contacted time server 10.0.0.1:123 (10.0.0.1). Dec 16 12:40:14.407179 systemd-timesyncd[1337]: Initial clock synchronization to Tue 2025-12-16 12:40:14.406989 UTC. Dec 16 12:40:14.407282 systemd-resolved[1295]: Clock change detected. Flushing caches. Dec 16 12:40:14.408971 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Dec 16 12:40:14.411626 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Dec 16 12:40:14.417433 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Dec 16 12:40:14.431953 (ntainerd)[1452]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 16 12:40:14.433484 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Dec 16 12:40:14.457011 locksmithd[1442]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Dec 16 12:40:14.526901 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Dec 16 12:40:14.546437 systemd-logind[1396]: Watching system buttons on /dev/input/event0 (Power Button) Dec 16 12:40:14.607612 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Dec 16 12:40:14.618265 containerd[1452]: time="2025-12-16T12:40:14Z" 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:40:14.618987 containerd[1452]: time="2025-12-16T12:40:14.618927669Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Dec 16 12:40:14.626771 containerd[1452]: time="2025-12-16T12:40:14.626716869Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.08µs" Dec 16 12:40:14.626771 containerd[1452]: time="2025-12-16T12:40:14.626753989Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:40:14.626771 containerd[1452]: time="2025-12-16T12:40:14.626773189Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:40:14.626973 containerd[1452]: time="2025-12-16T12:40:14.626937909Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:40:14.626973 containerd[1452]: time="2025-12-16T12:40:14.626960109Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:40:14.627023 containerd[1452]: time="2025-12-16T12:40:14.626984269Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627042 containerd[1452]: time="2025-12-16T12:40:14.627031109Z" 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:40:14.627060 containerd[1452]: time="2025-12-16T12:40:14.627042709Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627287 containerd[1452]: time="2025-12-16T12:40:14.627252469Z" 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:40:14.627287 containerd[1452]: time="2025-12-16T12:40:14.627273109Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627287 containerd[1452]: time="2025-12-16T12:40:14.627284709Z" 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:40:14.627364 containerd[1452]: time="2025-12-16T12:40:14.627292469Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627430 containerd[1452]: time="2025-12-16T12:40:14.627374149Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627608 containerd[1452]: time="2025-12-16T12:40:14.627568949Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:40:14.627608 containerd[1452]: time="2025-12-16T12:40:14.627605069Z" 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:40:14.627652 containerd[1452]: time="2025-12-16T12:40:14.627615789Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:40:14.627652 containerd[1452]: time="2025-12-16T12:40:14.627643509Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:40:14.628552 containerd[1452]: time="2025-12-16T12:40:14.628228029Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:40:14.628552 containerd[1452]: time="2025-12-16T12:40:14.628314149Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:40:14.632281 containerd[1452]: time="2025-12-16T12:40:14.632247229Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:40:14.632349 containerd[1452]: time="2025-12-16T12:40:14.632306029Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:40:14.632349 containerd[1452]: time="2025-12-16T12:40:14.632327669Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:40:14.632349 containerd[1452]: time="2025-12-16T12:40:14.632340949Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632353069Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632364509Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632381029Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632392469Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632403469Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:40:14.632420 containerd[1452]: time="2025-12-16T12:40:14.632413389Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:40:14.632511 containerd[1452]: time="2025-12-16T12:40:14.632422709Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:40:14.632511 containerd[1452]: time="2025-12-16T12:40:14.632435789Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:40:14.632573 containerd[1452]: time="2025-12-16T12:40:14.632552069Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:40:14.632597 containerd[1452]: time="2025-12-16T12:40:14.632579309Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632595829Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632607549Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632618949Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632629549Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632644709Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632657789Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632668629Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:40:14.632678 containerd[1452]: time="2025-12-16T12:40:14.632679709Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:40:14.632854 containerd[1452]: time="2025-12-16T12:40:14.632690349Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:40:14.632898 containerd[1452]: time="2025-12-16T12:40:14.632879309Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:40:14.632929 containerd[1452]: time="2025-12-16T12:40:14.632901149Z" level=info msg="Start snapshots syncer" Dec 16 12:40:14.632929 containerd[1452]: time="2025-12-16T12:40:14.632924949Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:40:14.633188 containerd[1452]: time="2025-12-16T12:40:14.633146109Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Dec 16 12:40:14.633294 containerd[1452]: time="2025-12-16T12:40:14.633206829Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:40:14.633294 containerd[1452]: time="2025-12-16T12:40:14.633260069Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:40:14.633391 containerd[1452]: time="2025-12-16T12:40:14.633365269Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:40:14.633417 containerd[1452]: time="2025-12-16T12:40:14.633394469Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:40:14.633417 containerd[1452]: time="2025-12-16T12:40:14.633412989Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:40:14.633457 containerd[1452]: time="2025-12-16T12:40:14.633426869Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:40:14.633457 containerd[1452]: time="2025-12-16T12:40:14.633439429Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:40:14.633457 containerd[1452]: time="2025-12-16T12:40:14.633450349Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:40:14.633505 containerd[1452]: time="2025-12-16T12:40:14.633461149Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:40:14.633505 containerd[1452]: time="2025-12-16T12:40:14.633487149Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:40:14.633505 containerd[1452]: time="2025-12-16T12:40:14.633498469Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633509269Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633546869Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633561069Z" 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:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633570189Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633579709Z" 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:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633587149Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633596749Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:40:14.633619 containerd[1452]: time="2025-12-16T12:40:14.633606509Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:40:14.633800 containerd[1452]: time="2025-12-16T12:40:14.633683829Z" level=info msg="runtime interface created" Dec 16 12:40:14.633800 containerd[1452]: time="2025-12-16T12:40:14.633689229Z" level=info msg="created NRI interface" Dec 16 12:40:14.633800 containerd[1452]: time="2025-12-16T12:40:14.633712989Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:40:14.633800 containerd[1452]: time="2025-12-16T12:40:14.633727909Z" level=info msg="Connect containerd service" Dec 16 12:40:14.633800 containerd[1452]: time="2025-12-16T12:40:14.633749429Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:40:14.634426 containerd[1452]: time="2025-12-16T12:40:14.634402509Z" 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:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723657709Z" level=info msg="Start subscribing containerd event" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723741109Z" level=info msg="Start recovering state" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723830669Z" level=info msg="Start event monitor" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723843309Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723850389Z" level=info msg="Start streaming server" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723862229Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723869189Z" level=info msg="runtime interface starting up..." Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723885149Z" level=info msg="starting plugins..." Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723898829Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723943989Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:40:14.724774 containerd[1452]: time="2025-12-16T12:40:14.723988069Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:40:14.724140 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:40:14.725085 containerd[1452]: time="2025-12-16T12:40:14.725053149Z" level=info msg="containerd successfully booted in 0.107145s" Dec 16 12:40:15.001321 sshd_keygen[1411]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Dec 16 12:40:15.021754 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Dec 16 12:40:15.024183 systemd[1]: Starting issuegen.service - Generate /run/issue... Dec 16 12:40:15.056676 systemd[1]: issuegen.service: Deactivated successfully. Dec 16 12:40:15.056946 systemd[1]: Finished issuegen.service - Generate /run/issue. Dec 16 12:40:15.059527 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Dec 16 12:40:15.095640 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Dec 16 12:40:15.098261 systemd[1]: Started getty@tty1.service - Getty on tty1. Dec 16 12:40:15.100713 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Dec 16 12:40:15.103157 systemd[1]: Reached target getty.target - Login Prompts. Dec 16 12:40:15.626854 systemd-networkd[1381]: eth0: Gained IPv6LL Dec 16 12:40:15.631336 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Dec 16 12:40:15.636138 systemd[1]: Reached target network-online.target - Network is Online. Dec 16 12:40:15.639829 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Dec 16 12:40:15.644925 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Dec 16 12:40:15.692531 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Dec 16 12:40:15.707553 systemd[1]: coreos-metadata.service: Deactivated successfully. Dec 16 12:40:15.709788 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Dec 16 12:40:15.711688 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Dec 16 12:40:15.712580 systemd[1]: Reached target multi-user.target - Multi-User System. Dec 16 12:40:15.718731 systemd[1]: Startup finished in 2.102s (kernel) + 3.861s (initrd) + 2.862s (userspace) = 8.826s. Dec 16 12:40:22.023440 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Dec 16 12:40:22.024643 systemd[1]: Started sshd@0-10.0.0.106:22-10.0.0.1:35238.service - OpenSSH per-connection server daemon (10.0.0.1:35238). Dec 16 12:40:22.115800 sshd[1539]: Accepted publickey for core from 10.0.0.1 port 35238 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:22.118395 sshd-session[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:22.126490 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Dec 16 12:40:22.127498 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Dec 16 12:40:22.136652 systemd-logind[1396]: New session 1 of user core. Dec 16 12:40:22.160784 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Dec 16 12:40:22.163977 systemd[1]: Starting user@500.service - User Manager for UID 500... Dec 16 12:40:22.177025 (systemd)[1544]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Dec 16 12:40:22.180685 systemd-logind[1396]: New session c1 of user core. Dec 16 12:40:22.286407 systemd[1544]: Queued start job for default target default.target. Dec 16 12:40:22.306729 systemd[1544]: Created slice app.slice - User Application Slice. Dec 16 12:40:22.306758 systemd[1544]: Reached target paths.target - Paths. Dec 16 12:40:22.306801 systemd[1544]: Reached target timers.target - Timers. Dec 16 12:40:22.307983 systemd[1544]: Starting dbus.socket - D-Bus User Message Bus Socket... Dec 16 12:40:22.317447 systemd[1544]: Listening on dbus.socket - D-Bus User Message Bus Socket. Dec 16 12:40:22.317517 systemd[1544]: Reached target sockets.target - Sockets. Dec 16 12:40:22.317566 systemd[1544]: Reached target basic.target - Basic System. Dec 16 12:40:22.317594 systemd[1544]: Reached target default.target - Main User Target. Dec 16 12:40:22.317622 systemd[1544]: Startup finished in 129ms. Dec 16 12:40:22.317808 systemd[1]: Started user@500.service - User Manager for UID 500. Dec 16 12:40:22.319148 systemd[1]: Started session-1.scope - Session 1 of User core. Dec 16 12:40:22.383893 systemd[1]: Started sshd@1-10.0.0.106:22-10.0.0.1:35248.service - OpenSSH per-connection server daemon (10.0.0.1:35248). Dec 16 12:40:22.447805 sshd[1555]: Accepted publickey for core from 10.0.0.1 port 35248 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:22.449112 sshd-session[1555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:22.454032 systemd-logind[1396]: New session 2 of user core. Dec 16 12:40:22.467919 systemd[1]: Started session-2.scope - Session 2 of User core. Dec 16 12:40:22.520743 sshd[1558]: Connection closed by 10.0.0.1 port 35248 Dec 16 12:40:22.521175 sshd-session[1555]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:22.536933 systemd[1]: sshd@1-10.0.0.106:22-10.0.0.1:35248.service: Deactivated successfully. Dec 16 12:40:22.538378 systemd[1]: session-2.scope: Deactivated successfully. Dec 16 12:40:22.539176 systemd-logind[1396]: Session 2 logged out. Waiting for processes to exit. Dec 16 12:40:22.541166 systemd[1]: Started sshd@2-10.0.0.106:22-10.0.0.1:35252.service - OpenSSH per-connection server daemon (10.0.0.1:35252). Dec 16 12:40:22.542157 systemd-logind[1396]: Removed session 2. Dec 16 12:40:22.598824 sshd[1564]: Accepted publickey for core from 10.0.0.1 port 35252 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:22.600262 sshd-session[1564]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:22.604947 systemd-logind[1396]: New session 3 of user core. Dec 16 12:40:22.617961 systemd[1]: Started session-3.scope - Session 3 of User core. Dec 16 12:40:22.666450 sshd[1568]: Connection closed by 10.0.0.1 port 35252 Dec 16 12:40:22.666309 sshd-session[1564]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:22.687872 systemd[1]: sshd@2-10.0.0.106:22-10.0.0.1:35252.service: Deactivated successfully. Dec 16 12:40:22.690997 systemd[1]: session-3.scope: Deactivated successfully. Dec 16 12:40:22.692188 systemd-logind[1396]: Session 3 logged out. Waiting for processes to exit. Dec 16 12:40:22.695484 systemd[1]: Started sshd@3-10.0.0.106:22-10.0.0.1:35268.service - OpenSSH per-connection server daemon (10.0.0.1:35268). Dec 16 12:40:22.697010 systemd-logind[1396]: Removed session 3. Dec 16 12:40:22.748335 sshd[1574]: Accepted publickey for core from 10.0.0.1 port 35268 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:22.750679 sshd-session[1574]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:22.760132 systemd-logind[1396]: New session 4 of user core. Dec 16 12:40:22.764872 systemd[1]: Started session-4.scope - Session 4 of User core. Dec 16 12:40:22.822830 sshd[1577]: Connection closed by 10.0.0.1 port 35268 Dec 16 12:40:22.822640 sshd-session[1574]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:22.834246 systemd[1]: sshd@3-10.0.0.106:22-10.0.0.1:35268.service: Deactivated successfully. Dec 16 12:40:22.836205 systemd[1]: session-4.scope: Deactivated successfully. Dec 16 12:40:22.837309 systemd-logind[1396]: Session 4 logged out. Waiting for processes to exit. Dec 16 12:40:22.839831 systemd[1]: Started sshd@4-10.0.0.106:22-10.0.0.1:35274.service - OpenSSH per-connection server daemon (10.0.0.1:35274). Dec 16 12:40:22.840689 systemd-logind[1396]: Removed session 4. Dec 16 12:40:22.918213 sshd[1583]: Accepted publickey for core from 10.0.0.1 port 35274 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:22.920837 sshd-session[1583]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:22.925656 systemd-logind[1396]: New session 5 of user core. Dec 16 12:40:22.937903 systemd[1]: Started session-5.scope - Session 5 of User core. Dec 16 12:40:22.998260 sudo[1587]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Dec 16 12:40:22.998537 sudo[1587]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:40:23.010661 sudo[1587]: pam_unix(sudo:session): session closed for user root Dec 16 12:40:23.012265 sshd[1586]: Connection closed by 10.0.0.1 port 35274 Dec 16 12:40:23.012944 sshd-session[1583]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:23.032887 systemd[1]: sshd@4-10.0.0.106:22-10.0.0.1:35274.service: Deactivated successfully. Dec 16 12:40:23.040211 systemd[1]: session-5.scope: Deactivated successfully. Dec 16 12:40:23.042390 systemd-logind[1396]: Session 5 logged out. Waiting for processes to exit. Dec 16 12:40:23.045503 systemd[1]: Started sshd@5-10.0.0.106:22-10.0.0.1:35284.service - OpenSSH per-connection server daemon (10.0.0.1:35284). Dec 16 12:40:23.047396 systemd-logind[1396]: Removed session 5. Dec 16 12:40:23.108341 sshd[1593]: Accepted publickey for core from 10.0.0.1 port 35284 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:23.110134 sshd-session[1593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:23.113880 systemd-logind[1396]: New session 6 of user core. Dec 16 12:40:23.129908 systemd[1]: Started session-6.scope - Session 6 of User core. Dec 16 12:40:23.181421 sudo[1598]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Dec 16 12:40:23.182081 sudo[1598]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:40:23.186923 sudo[1598]: pam_unix(sudo:session): session closed for user root Dec 16 12:40:23.191776 sudo[1597]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Dec 16 12:40:23.192041 sudo[1597]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:40:23.200517 systemd[1]: Starting audit-rules.service - Load Audit Rules... Dec 16 12:40:23.247681 augenrules[1620]: No rules Dec 16 12:40:23.249148 systemd[1]: audit-rules.service: Deactivated successfully. Dec 16 12:40:23.249462 systemd[1]: Finished audit-rules.service - Load Audit Rules. Dec 16 12:40:23.252330 sudo[1597]: pam_unix(sudo:session): session closed for user root Dec 16 12:40:23.253758 sshd[1596]: Connection closed by 10.0.0.1 port 35284 Dec 16 12:40:23.254917 sshd-session[1593]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:23.268835 systemd[1]: sshd@5-10.0.0.106:22-10.0.0.1:35284.service: Deactivated successfully. Dec 16 12:40:23.271749 systemd[1]: session-6.scope: Deactivated successfully. Dec 16 12:40:23.273334 systemd-logind[1396]: Session 6 logged out. Waiting for processes to exit. Dec 16 12:40:23.275987 systemd[1]: Started sshd@6-10.0.0.106:22-10.0.0.1:35286.service - OpenSSH per-connection server daemon (10.0.0.1:35286). Dec 16 12:40:23.276528 systemd-logind[1396]: Removed session 6. Dec 16 12:40:23.334508 sshd[1629]: Accepted publickey for core from 10.0.0.1 port 35286 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:23.335927 sshd-session[1629]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:23.340922 systemd-logind[1396]: New session 7 of user core. Dec 16 12:40:23.350976 systemd[1]: Started session-7.scope - Session 7 of User core. Dec 16 12:40:23.405150 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 16 12:40:23.419077 (dockerd)[1634]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Dec 16 12:40:23.619780 dockerd[1634]: time="2025-12-16T12:40:23.618820669Z" level=info msg="Starting up" Dec 16 12:40:23.620375 dockerd[1634]: time="2025-12-16T12:40:23.620352869Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Dec 16 12:40:23.631623 dockerd[1634]: time="2025-12-16T12:40:23.631568829Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Dec 16 12:40:23.661087 dockerd[1634]: time="2025-12-16T12:40:23.660950309Z" level=info msg="Loading containers: start." Dec 16 12:40:23.669753 kernel: Initializing XFRM netlink socket Dec 16 12:40:23.877569 systemd-networkd[1381]: docker0: Link UP Dec 16 12:40:23.881476 dockerd[1634]: time="2025-12-16T12:40:23.881422309Z" level=info msg="Loading containers: done." Dec 16 12:40:23.895123 dockerd[1634]: time="2025-12-16T12:40:23.895062869Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 16 12:40:23.895275 dockerd[1634]: time="2025-12-16T12:40:23.895165149Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Dec 16 12:40:23.895275 dockerd[1634]: time="2025-12-16T12:40:23.895255469Z" level=info msg="Initializing buildkit" Dec 16 12:40:23.921673 dockerd[1634]: time="2025-12-16T12:40:23.921568789Z" level=info msg="Completed buildkit initialization" Dec 16 12:40:23.928677 dockerd[1634]: time="2025-12-16T12:40:23.928621869Z" level=info msg="Daemon has completed initialization" Dec 16 12:40:23.928803 dockerd[1634]: time="2025-12-16T12:40:23.928684869Z" level=info msg="API listen on /run/docker.sock" Dec 16 12:40:23.928879 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 16 12:40:23.937157 sshd[1632]: Connection closed by 10.0.0.1 port 35286 Dec 16 12:40:23.937793 sshd-session[1629]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:23.946797 systemd[1]: sshd@6-10.0.0.106:22-10.0.0.1:35286.service: Deactivated successfully. Dec 16 12:40:23.949274 systemd[1]: session-7.scope: Deactivated successfully. Dec 16 12:40:23.950043 systemd-logind[1396]: Session 7 logged out. Waiting for processes to exit. Dec 16 12:40:23.952297 systemd[1]: Started sshd@7-10.0.0.106:22-10.0.0.1:35302.service - OpenSSH per-connection server daemon (10.0.0.1:35302). Dec 16 12:40:23.952756 systemd-logind[1396]: Removed session 7. Dec 16 12:40:24.003125 sshd[1846]: Accepted publickey for core from 10.0.0.1 port 35302 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:24.004497 sshd-session[1846]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:24.009392 systemd-logind[1396]: New session 8 of user core. Dec 16 12:40:24.019915 systemd[1]: Started session-8.scope - Session 8 of User core. Dec 16 12:40:25.404691 systemd[1]: var-lib-docker-overlay2-ba101a770412ede6eacec598df916d5f59e21751c785c9eb4134df28870d007a\x2dinit-merged.mount: Deactivated successfully. Dec 16 12:40:25.448717 containerd[1452]: time="2025-12-16T12:40:25.448097389Z" level=info msg="connecting to shim f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca" address="unix:///run/containerd/s/1503f185c847cebaefe6f3c390f21e703857e84a7a6147aa977194d999f1f9fb" namespace=moby protocol=ttrpc version=3 Dec 16 12:40:25.469879 systemd[1]: Started docker-f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca.scope - libcontainer container f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca. Dec 16 12:40:25.483850 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:40:25.501176 kernel: docker0: port 1(veth07bd894) entered blocking state Dec 16 12:40:25.501263 kernel: docker0: port 1(veth07bd894) entered disabled state Dec 16 12:40:25.501288 kernel: veth07bd894: entered allmulticast mode Dec 16 12:40:25.501306 kernel: veth07bd894: entered promiscuous mode Dec 16 12:40:25.502173 systemd-networkd[1381]: veth07bd894: Link UP Dec 16 12:40:25.510045 kernel: eth0: renamed from vetha7d9c3c Dec 16 12:40:25.510116 kernel: docker0: port 1(veth07bd894) entered blocking state Dec 16 12:40:25.510131 kernel: docker0: port 1(veth07bd894) entered forwarding state Dec 16 12:40:25.510159 systemd-networkd[1381]: veth07bd894: Gained carrier Dec 16 12:40:25.510545 systemd-networkd[1381]: docker0: Gained carrier Dec 16 12:40:25.533860 sshd[1849]: Connection closed by 10.0.0.1 port 35302 Dec 16 12:40:25.534225 sshd-session[1846]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:25.542746 systemd[1]: sshd@7-10.0.0.106:22-10.0.0.1:35302.service: Deactivated successfully. Dec 16 12:40:25.544266 systemd[1]: session-8.scope: Deactivated successfully. Dec 16 12:40:25.544972 systemd-logind[1396]: Session 8 logged out. Waiting for processes to exit. Dec 16 12:40:25.547125 systemd[1]: Started sshd@8-10.0.0.106:22-10.0.0.1:35316.service - OpenSSH per-connection server daemon (10.0.0.1:35316). Dec 16 12:40:25.548260 systemd-logind[1396]: Removed session 8. Dec 16 12:40:25.598797 sshd[1923]: Accepted publickey for core from 10.0.0.1 port 35316 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:25.600101 sshd-session[1923]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:25.604771 systemd-logind[1396]: New session 9 of user core. Dec 16 12:40:25.616858 systemd[1]: Started session-9.scope - Session 9 of User core. Dec 16 12:40:25.671505 sshd[1926]: Connection closed by 10.0.0.1 port 35316 Dec 16 12:40:25.671956 sshd-session[1923]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:25.687775 systemd[1]: sshd@8-10.0.0.106:22-10.0.0.1:35316.service: Deactivated successfully. Dec 16 12:40:25.690120 systemd[1]: session-9.scope: Deactivated successfully. Dec 16 12:40:25.691333 systemd-logind[1396]: Session 9 logged out. Waiting for processes to exit. Dec 16 12:40:25.693023 systemd[1]: Started sshd@9-10.0.0.106:22-10.0.0.1:35332.service - OpenSSH per-connection server daemon (10.0.0.1:35332). Dec 16 12:40:25.693730 systemd-logind[1396]: Removed session 9. Dec 16 12:40:25.745546 sshd[1932]: Accepted publickey for core from 10.0.0.1 port 35332 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:25.746983 sshd-session[1932]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:25.750511 systemd-logind[1396]: New session 10 of user core. Dec 16 12:40:25.772926 systemd[1]: Started session-10.scope - Session 10 of User core. Dec 16 12:40:25.823905 sudo[1936]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1452 Dec 16 12:40:25.824173 sudo[1936]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:40:25.827315 sudo[1936]: pam_unix(sudo:session): session closed for user root Dec 16 12:40:25.827619 dockerd[1634]: time="2025-12-16T12:40:25.827500349Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Dec 16 12:40:25.827619 dockerd[1634]: time="2025-12-16T12:40:25.827535549Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Dec 16 12:40:25.827619 dockerd[1634]: time="2025-12-16T12:40:25.827560389Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Dec 16 12:40:25.827619 dockerd[1634]: time="2025-12-16T12:40:25.827583309Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Dec 16 12:40:25.828106 containerd[1452]: time="2025-12-16T12:40:25.827523469Z" level=info msg="Stop CRI service" Dec 16 12:40:25.828106 containerd[1452]: time="2025-12-16T12:40:25.827857829Z" level=info msg="Stop CRI service" Dec 16 12:40:25.828106 containerd[1452]: time="2025-12-16T12:40:25.827928149Z" level=info msg="Event monitor stopped" Dec 16 12:40:25.828106 containerd[1452]: time="2025-12-16T12:40:25.827934429Z" level=info msg="Stream server stopped" Dec 16 12:40:25.830807 sshd[1935]: Connection closed by 10.0.0.1 port 35332 Dec 16 12:40:25.830897 systemd[1]: containerd.service: Deactivated successfully. Dec 16 12:40:25.831027 systemd[1]: containerd.service: Unit process 1873 (containerd-shim) remains running after unit stopped. Dec 16 12:40:25.831289 systemd[1]: containerd.service: Consumed 292ms CPU time, 122M memory peak. Dec 16 12:40:25.831363 sshd-session[1932]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:25.843983 systemd[1]: sshd@9-10.0.0.106:22-10.0.0.1:35332.service: Deactivated successfully. Dec 16 12:40:25.845592 systemd[1]: session-10.scope: Deactivated successfully. Dec 16 12:40:25.847880 systemd-logind[1396]: Session 10 logged out. Waiting for processes to exit. Dec 16 12:40:25.849927 systemd[1]: Started sshd@10-10.0.0.106:22-10.0.0.1:35336.service - OpenSSH per-connection server daemon (10.0.0.1:35336). Dec 16 12:40:25.851199 systemd-logind[1396]: Removed session 10. Dec 16 12:40:25.898648 sshd[1943]: Accepted publickey for core from 10.0.0.1 port 35336 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:25.900059 sshd-session[1943]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:25.903910 systemd-logind[1396]: New session 11 of user core. Dec 16 12:40:25.916907 systemd[1]: Started session-11.scope - Session 11 of User core. Dec 16 12:40:25.970655 sshd[1946]: Connection closed by 10.0.0.1 port 35336 Dec 16 12:40:25.970987 sshd-session[1943]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:25.975822 systemd[1]: sshd@10-10.0.0.106:22-10.0.0.1:35336.service: Deactivated successfully. Dec 16 12:40:25.977559 systemd[1]: session-11.scope: Deactivated successfully. Dec 16 12:40:25.979316 systemd-logind[1396]: Session 11 logged out. Waiting for processes to exit. Dec 16 12:40:25.981499 systemd-logind[1396]: Removed session 11. Dec 16 12:40:26.570831 systemd-networkd[1381]: docker0: Gained IPv6LL Dec 16 12:40:27.018882 systemd-networkd[1381]: veth07bd894: Gained IPv6LL Dec 16 12:40:31.081431 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Dec 16 12:40:31.082286 systemd[1]: Stopping docker.service - Docker Application Container Engine... Dec 16 12:40:31.082502 dockerd[1634]: time="2025-12-16T12:40:31.082370429Z" level=info msg="Processing signal 'terminated'" Dec 16 12:40:31.988837 systemd[1]: Started sshd@11-10.0.0.106:22-10.0.0.1:42244.service - OpenSSH per-connection server daemon (10.0.0.1:42244). Dec 16 12:40:32.056786 sshd[1952]: Accepted publickey for core from 10.0.0.1 port 42244 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:32.058165 sshd-session[1952]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:32.062592 systemd-logind[1396]: New session 12 of user core. Dec 16 12:40:32.070952 systemd[1]: Started session-12.scope - Session 12 of User core. Dec 16 12:40:32.126625 sshd[1955]: Connection closed by 10.0.0.1 port 42244 Dec 16 12:40:32.127147 sshd-session[1952]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:32.132276 systemd[1]: sshd@11-10.0.0.106:22-10.0.0.1:42244.service: Deactivated successfully. Dec 16 12:40:32.135795 systemd[1]: session-12.scope: Deactivated successfully. Dec 16 12:40:32.138666 systemd-logind[1396]: Session 12 logged out. Waiting for processes to exit. Dec 16 12:40:32.140428 systemd-logind[1396]: Removed session 12. Dec 16 12:40:38.152497 systemd[1]: Started sshd@12-10.0.0.106:22-10.0.0.1:42260.service - OpenSSH per-connection server daemon (10.0.0.1:42260). Dec 16 12:40:38.197930 sshd[1961]: Accepted publickey for core from 10.0.0.1 port 42260 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:38.199758 sshd-session[1961]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:38.206162 systemd-logind[1396]: New session 13 of user core. Dec 16 12:40:38.212920 systemd[1]: Started session-13.scope - Session 13 of User core. Dec 16 12:40:38.269030 sshd[1964]: Connection closed by 10.0.0.1 port 42260 Dec 16 12:40:38.269464 sshd-session[1961]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:38.274351 systemd[1]: sshd@12-10.0.0.106:22-10.0.0.1:42260.service: Deactivated successfully. Dec 16 12:40:38.276236 systemd[1]: session-13.scope: Deactivated successfully. Dec 16 12:40:38.277759 systemd-logind[1396]: Session 13 logged out. Waiting for processes to exit. Dec 16 12:40:38.278762 systemd-logind[1396]: Removed session 13. Dec 16 12:40:44.288072 systemd[1]: Started sshd@13-10.0.0.106:22-10.0.0.1:49668.service - OpenSSH per-connection server daemon (10.0.0.1:49668). Dec 16 12:40:44.333981 sshd[1970]: Accepted publickey for core from 10.0.0.1 port 49668 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:44.335421 sshd-session[1970]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:44.340221 systemd-logind[1396]: New session 14 of user core. Dec 16 12:40:44.343881 systemd[1]: Started session-14.scope - Session 14 of User core. Dec 16 12:40:44.398376 sshd[1973]: Connection closed by 10.0.0.1 port 49668 Dec 16 12:40:44.398923 sshd-session[1970]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:44.404637 systemd[1]: sshd@13-10.0.0.106:22-10.0.0.1:49668.service: Deactivated successfully. Dec 16 12:40:44.406381 systemd[1]: session-14.scope: Deactivated successfully. Dec 16 12:40:44.408480 systemd-logind[1396]: Session 14 logged out. Waiting for processes to exit. Dec 16 12:40:44.409769 systemd-logind[1396]: Removed session 14. Dec 16 12:40:46.083737 dockerd[1634]: time="2025-12-16T12:40:46.083609589Z" level=error msg="Force shutdown daemon" Dec 16 12:40:46.084102 dockerd[1634]: time="2025-12-16T12:40:46.083779909Z" level=info msg="Daemon shutdown complete" Dec 16 12:40:46.086596 systemd[1]: docker.service: Deactivated successfully. Dec 16 12:40:46.087799 systemd[1]: Stopped docker.service - Docker Application Container Engine. Dec 16 12:40:46.087886 systemd[1]: docker.service: Consumed 1.002s CPU time, 123.6M memory peak. Dec 16 12:40:46.088846 systemd[1]: docker.socket: Deactivated successfully. Dec 16 12:40:46.089222 systemd[1]: Closed docker.socket - Docker Socket for the API. Dec 16 12:40:46.089272 systemd[1]: Stopping docker.socket - Docker Socket for the API... Dec 16 12:40:46.091911 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:40:46.092095 systemd[1]: containerd.service: Found left-over process 1873 (containerd-shim) in control group while starting unit. Ignoring. Dec 16 12:40:46.092105 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Dec 16 12:40:46.103896 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:40:46.104248 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:40:46.116941 systemd[1]: containerd.service: Found left-over process 1873 (containerd-shim) in control group while starting unit. Ignoring. Dec 16 12:40:46.116955 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Dec 16 12:40:46.122209 (ntainerd)[1984]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 16 12:40:46.137078 containerd[1984]: time="2025-12-16T12:40:46Z" 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:40:46.137729 containerd[1984]: time="2025-12-16T12:40:46.137663669Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Dec 16 12:40:46.146506 containerd[1984]: time="2025-12-16T12:40:46.146453269Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.72µs" Dec 16 12:40:46.146506 containerd[1984]: time="2025-12-16T12:40:46.146498749Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:40:46.146644 containerd[1984]: time="2025-12-16T12:40:46.146519909Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:40:46.146644 containerd[1984]: time="2025-12-16T12:40:46.146557989Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:40:46.146644 containerd[1984]: time="2025-12-16T12:40:46.146570269Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:40:46.146819 containerd[1984]: time="2025-12-16T12:40:46.146796629Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:40:46.146847 containerd[1984]: time="2025-12-16T12:40:46.146831709Z" 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:40:46.146868 containerd[1984]: time="2025-12-16T12:40:46.146844989Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:40:46.147103 containerd[1984]: time="2025-12-16T12:40:46.147067509Z" 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:40:46.147103 containerd[1984]: time="2025-12-16T12:40:46.147087109Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:40:46.147103 containerd[1984]: time="2025-12-16T12:40:46.147098989Z" 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:40:46.147170 containerd[1984]: time="2025-12-16T12:40:46.147107229Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:40:46.147170 containerd[1984]: time="2025-12-16T12:40:46.147128869Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:40:46.147242 containerd[1984]: time="2025-12-16T12:40:46.147225869Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:40:46.147264 containerd[1984]: time="2025-12-16T12:40:46.147252949Z" 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:40:46.147287 containerd[1984]: time="2025-12-16T12:40:46.147264389Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:40:46.147305 containerd[1984]: time="2025-12-16T12:40:46.147297349Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:40:46.147544 containerd[1984]: time="2025-12-16T12:40:46.147528589Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:40:46.147580 containerd[1984]: time="2025-12-16T12:40:46.147553229Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:40:46.147722 containerd[1984]: time="2025-12-16T12:40:46.147692069Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:40:46.147756 containerd[1984]: time="2025-12-16T12:40:46.147740989Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:40:46.147756 containerd[1984]: time="2025-12-16T12:40:46.147754829Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:40:46.147756 containerd[1984]: time="2025-12-16T12:40:46.147766989Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:40:46.147756 containerd[1984]: time="2025-12-16T12:40:46.147781029Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147809509Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147823589Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147835669Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147846269Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147856429Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:40:46.147872 containerd[1984]: time="2025-12-16T12:40:46.147865989Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:40:46.148029 containerd[1984]: time="2025-12-16T12:40:46.147878509Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:40:46.148118 containerd[1984]: time="2025-12-16T12:40:46.148095229Z" level=info msg="connecting to shim f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca" address="unix:///run/containerd/s/1503f185c847cebaefe6f3c390f21e703857e84a7a6147aa977194d999f1f9fb" namespace=moby protocol=ttrpc version=3 Dec 16 12:40:46.158712 containerd[1984]: time="2025-12-16T12:40:46.158653749Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158726509Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158746429Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158759989Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158772149Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158784829Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158797109Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158807989Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:40:46.158820 containerd[1984]: time="2025-12-16T12:40:46.158819949Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:40:46.158971 containerd[1984]: time="2025-12-16T12:40:46.158832629Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:40:46.158971 containerd[1984]: time="2025-12-16T12:40:46.158844949Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:40:46.158971 containerd[1984]: time="2025-12-16T12:40:46.158898389Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:40:46.158971 containerd[1984]: time="2025-12-16T12:40:46.158919229Z" level=info msg="Start snapshots syncer" Dec 16 12:40:46.158971 containerd[1984]: time="2025-12-16T12:40:46.158949989Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:40:46.159212 containerd[1984]: time="2025-12-16T12:40:46.159168229Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Dec 16 12:40:46.159319 containerd[1984]: time="2025-12-16T12:40:46.159228429Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:40:46.159319 containerd[1984]: time="2025-12-16T12:40:46.159285029Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159341269Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159370309Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159382909Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159394629Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159410149Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159421869Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:40:46.159442 containerd[1984]: time="2025-12-16T12:40:46.159434349Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159467069Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159480109Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159491909Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159534909Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159551909Z" 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:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159565509Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159576149Z" 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:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159584549Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159598909Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159610549Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159630749Z" level=info msg="runtime interface created" Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159637349Z" level=info msg="created NRI interface" Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159645749Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159659909Z" level=info msg="Connect containerd service" Dec 16 12:40:46.159586 containerd[1984]: time="2025-12-16T12:40:46.159690429Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:40:46.160343 containerd[1984]: time="2025-12-16T12:40:46.160301989Z" 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:40:46.169867 containerd[1984]: time="2025-12-16T12:40:46.169809469Z" level=info msg="Start subscribing containerd event" Dec 16 12:40:46.169969 containerd[1984]: time="2025-12-16T12:40:46.169879789Z" level=info msg="Start recovering state" Dec 16 12:40:46.169969 containerd[1984]: time="2025-12-16T12:40:46.169963589Z" level=info msg="Start event monitor" Dec 16 12:40:46.170034 containerd[1984]: time="2025-12-16T12:40:46.169976349Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:40:46.170034 containerd[1984]: time="2025-12-16T12:40:46.169976909Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:40:46.170034 containerd[1984]: time="2025-12-16T12:40:46.170019189Z" level=info msg="Start streaming server" Dec 16 12:40:46.170034 containerd[1984]: time="2025-12-16T12:40:46.170024669Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:40:46.170104 containerd[1984]: time="2025-12-16T12:40:46.170029669Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:40:46.170104 containerd[1984]: time="2025-12-16T12:40:46.170076389Z" level=info msg="runtime interface starting up..." Dec 16 12:40:46.170104 containerd[1984]: time="2025-12-16T12:40:46.170082229Z" level=info msg="starting plugins..." Dec 16 12:40:46.170104 containerd[1984]: time="2025-12-16T12:40:46.170092829Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:40:46.170220 containerd[1984]: time="2025-12-16T12:40:46.170191029Z" level=info msg="containerd successfully booted in 0.033297s" Dec 16 12:40:46.170330 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:40:46.172942 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 16 12:40:46.187127 (dockerd)[2012]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Dec 16 12:40:46.217032 dockerd[2012]: time="2025-12-16T12:40:46.216965309Z" level=info msg="Starting up" Dec 16 12:40:46.217563 dockerd[2012]: time="2025-12-16T12:40:46.217519949Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Dec 16 12:40:46.227420 dockerd[2012]: time="2025-12-16T12:40:46.227329549Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Dec 16 12:40:46.247377 dockerd[2012]: time="2025-12-16T12:40:46.247335589Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Dec 16 12:40:46.255151 dockerd[2012]: time="2025-12-16T12:40:46.255115269Z" level=info msg="Loading containers: start." Dec 16 12:40:50.414087 systemd[1]: Started sshd@14-10.0.0.106:22-10.0.0.1:49678.service - OpenSSH per-connection server daemon (10.0.0.1:49678). Dec 16 12:40:50.469452 sshd[2044]: Accepted publickey for core from 10.0.0.1 port 49678 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:50.470815 sshd-session[2044]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:50.476784 systemd-logind[1396]: New session 15 of user core. Dec 16 12:40:50.486898 systemd[1]: Started session-15.scope - Session 15 of User core. Dec 16 12:40:50.543367 sshd[2047]: Connection closed by 10.0.0.1 port 49678 Dec 16 12:40:50.543860 sshd-session[2044]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:50.556663 systemd[1]: sshd@14-10.0.0.106:22-10.0.0.1:49678.service: Deactivated successfully. Dec 16 12:40:50.559021 systemd[1]: session-15.scope: Deactivated successfully. Dec 16 12:40:50.559665 systemd-logind[1396]: Session 15 logged out. Waiting for processes to exit. Dec 16 12:40:50.561423 systemd[1]: Started sshd@15-10.0.0.106:22-10.0.0.1:49684.service - OpenSSH per-connection server daemon (10.0.0.1:49684). Dec 16 12:40:50.562336 systemd-logind[1396]: Removed session 15. Dec 16 12:40:50.625647 sshd[2053]: Accepted publickey for core from 10.0.0.1 port 49684 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:50.627017 sshd-session[2053]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:50.631794 systemd-logind[1396]: New session 16 of user core. Dec 16 12:40:50.640927 systemd[1]: Started session-16.scope - Session 16 of User core. Dec 16 12:40:50.694724 sshd[2056]: Connection closed by 10.0.0.1 port 49684 Dec 16 12:40:50.695318 sshd-session[2053]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:50.707767 systemd[1]: sshd@15-10.0.0.106:22-10.0.0.1:49684.service: Deactivated successfully. Dec 16 12:40:50.710045 systemd[1]: session-16.scope: Deactivated successfully. Dec 16 12:40:50.711558 systemd-logind[1396]: Session 16 logged out. Waiting for processes to exit. Dec 16 12:40:50.713032 systemd[1]: Started sshd@16-10.0.0.106:22-10.0.0.1:49694.service - OpenSSH per-connection server daemon (10.0.0.1:49694). Dec 16 12:40:50.714943 systemd-logind[1396]: Removed session 16. Dec 16 12:40:50.775288 sshd[2062]: Accepted publickey for core from 10.0.0.1 port 49694 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:50.778613 sshd-session[2062]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:50.783208 systemd-logind[1396]: New session 17 of user core. Dec 16 12:40:50.788851 systemd[1]: Started session-17.scope - Session 17 of User core. Dec 16 12:40:56.275768 dockerd[2012]: time="2025-12-16T12:40:56.275621938Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca Dec 16 12:40:56.285968 systemd[1]: docker-f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca.scope: Deactivated successfully. Dec 16 12:40:56.302426 containerd[1984]: time="2025-12-16T12:40:56.302265822Z" level=info msg="shim disconnected" id=f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca namespace=moby Dec 16 12:40:56.302426 containerd[1984]: time="2025-12-16T12:40:56.302303542Z" level=warning msg="cleaning up after shim disconnected" id=f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca namespace=moby Dec 16 12:40:56.302426 containerd[1984]: time="2025-12-16T12:40:56.302334703Z" level=info msg="cleaning up dead shim" namespace=moby Dec 16 12:40:56.302795 dockerd[2012]: time="2025-12-16T12:40:56.302529623Z" level=info msg="ignoring event" container=f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Dec 16 12:40:56.318097 systemd[1]: var-lib-docker-overlay2-ba101a770412ede6eacec598df916d5f59e21751c785c9eb4134df28870d007a-merged.mount: Deactivated successfully. Dec 16 12:40:56.735173 systemd[1]: run-docker-netns-2f0650b75839.mount: Deactivated successfully. Dec 16 12:40:56.737725 dockerd[2012]: time="2025-12-16T12:40:56.737628965Z" level=info msg="Removing stale sandbox 2f0650b758396d54876d45177289618d3c454fea55ea6967cd33cf4514df9c9d (f5ff32cea2d303052859a0b9ba9d2029516be19f2d2edb753c9a05ae2cecd2ca)" Dec 16 12:40:56.740768 systemd-networkd[1381]: veth07bd894: Link DOWN Dec 16 12:40:56.740775 systemd-networkd[1381]: veth07bd894: Lost carrier Dec 16 12:40:56.742821 kernel: docker0: port 1(veth07bd894) entered disabled state Dec 16 12:40:56.742882 kernel: veth07bd894 (unregistering): left allmulticast mode Dec 16 12:40:56.742908 kernel: veth07bd894 (unregistering): left promiscuous mode Dec 16 12:40:56.743884 dockerd[2012]: time="2025-12-16T12:40:56.743849945Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Dec 16 12:40:56.743940 dockerd[2012]: time="2025-12-16T12:40:56.743900265Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 4d8b8030b77bca52e689cdee808e33a2119d6b74939d4c70f23dffec4a04b31d 4ee977069a6e7b5f36fdf65e89df86e3b3eb0f42fb0af23dffbbf706e0dc592e], retrying...." Dec 16 12:40:56.744345 kernel: docker0: port 1(veth07bd894) entered disabled state Dec 16 12:40:56.745330 systemd-networkd[1381]: docker0: Lost carrier Dec 16 12:40:56.750227 systemd[1]: run-docker-netns-2f0650b75839.mount: Deactivated successfully. Dec 16 12:40:56.894792 dockerd[2012]: time="2025-12-16T12:40:56.894733544Z" level=warning msg="error locating sandbox id 2f0650b758396d54876d45177289618d3c454fea55ea6967cd33cf4514df9c9d: sandbox 2f0650b758396d54876d45177289618d3c454fea55ea6967cd33cf4514df9c9d not found" Dec 16 12:40:56.894886 dockerd[2012]: time="2025-12-16T12:40:56.894833864Z" level=info msg="Loading containers: done." Dec 16 12:40:56.909168 dockerd[2012]: time="2025-12-16T12:40:56.909117590Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 16 12:40:56.909324 dockerd[2012]: time="2025-12-16T12:40:56.909209270Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Dec 16 12:40:56.909324 dockerd[2012]: time="2025-12-16T12:40:56.909246190Z" level=info msg="Initializing buildkit" Dec 16 12:40:56.923757 dockerd[2012]: time="2025-12-16T12:40:56.923719396Z" level=info msg="Completed buildkit initialization" Dec 16 12:40:56.930929 dockerd[2012]: time="2025-12-16T12:40:56.930863699Z" level=info msg="Daemon has completed initialization" Dec 16 12:40:56.931031 dockerd[2012]: time="2025-12-16T12:40:56.930986059Z" level=info msg="API listen on /run/docker.sock" Dec 16 12:40:56.931115 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 16 12:40:56.938140 sshd[2065]: Connection closed by 10.0.0.1 port 49694 Dec 16 12:40:56.938647 sshd-session[2062]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:56.948592 systemd[1]: sshd@16-10.0.0.106:22-10.0.0.1:49694.service: Deactivated successfully. Dec 16 12:40:56.953957 systemd[1]: session-17.scope: Deactivated successfully. Dec 16 12:40:56.957654 systemd-logind[1396]: Session 17 logged out. Waiting for processes to exit. Dec 16 12:40:56.959548 systemd[1]: Started sshd@17-10.0.0.106:22-10.0.0.1:57588.service - OpenSSH per-connection server daemon (10.0.0.1:57588). Dec 16 12:40:56.960646 systemd-logind[1396]: Removed session 17. Dec 16 12:40:57.021298 sshd[2317]: Accepted publickey for core from 10.0.0.1 port 57588 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:57.022595 sshd-session[2317]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:57.026876 systemd-logind[1396]: New session 18 of user core. Dec 16 12:40:57.039845 systemd[1]: Started session-18.scope - Session 18 of User core. Dec 16 12:40:57.135714 containerd[1984]: time="2025-12-16T12:40:57.134598959Z" level=info msg="connecting to shim 3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d" address="unix:///run/containerd/s/53824f2d03f918e9690b77999cd5c31839df398a6dd409a68e5be5c5f6f026a8" namespace=moby protocol=ttrpc version=3 Dec 16 12:40:57.159844 systemd[1]: Started docker-3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d.scope - libcontainer container 3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d. Dec 16 12:40:57.170184 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:40:57.193051 kernel: docker0: port 1(vethecb0a62) entered blocking state Dec 16 12:40:57.193141 kernel: docker0: port 1(vethecb0a62) entered disabled state Dec 16 12:40:57.193168 kernel: vethecb0a62: entered allmulticast mode Dec 16 12:40:57.195746 kernel: vethecb0a62: entered promiscuous mode Dec 16 12:40:57.196780 systemd-networkd[1381]: vethecb0a62: Link UP Dec 16 12:40:57.202721 kernel: eth0: renamed from vethd7c5a71 Dec 16 12:40:57.204724 kernel: docker0: port 1(vethecb0a62) entered blocking state Dec 16 12:40:57.204771 kernel: docker0: port 1(vethecb0a62) entered forwarding state Dec 16 12:40:57.204826 systemd-networkd[1381]: vethecb0a62: Gained carrier Dec 16 12:40:57.205044 systemd-networkd[1381]: docker0: Gained carrier Dec 16 12:40:57.227260 sshd[2320]: Connection closed by 10.0.0.1 port 57588 Dec 16 12:40:57.225720 sshd-session[2317]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:57.234689 systemd[1]: sshd@17-10.0.0.106:22-10.0.0.1:57588.service: Deactivated successfully. Dec 16 12:40:57.236842 systemd[1]: session-18.scope: Deactivated successfully. Dec 16 12:40:57.238922 systemd-logind[1396]: Session 18 logged out. Waiting for processes to exit. Dec 16 12:40:57.242105 systemd[1]: Started sshd@18-10.0.0.106:22-10.0.0.1:57600.service - OpenSSH per-connection server daemon (10.0.0.1:57600). Dec 16 12:40:57.242744 systemd-logind[1396]: Removed session 18. Dec 16 12:40:57.307667 sshd[2386]: Accepted publickey for core from 10.0.0.1 port 57600 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:57.310050 sshd-session[2386]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:57.315534 systemd-logind[1396]: New session 19 of user core. Dec 16 12:40:57.334872 systemd[1]: Started session-19.scope - Session 19 of User core. Dec 16 12:40:57.392870 sshd[2389]: Connection closed by 10.0.0.1 port 57600 Dec 16 12:40:57.392800 sshd-session[2386]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:57.400479 systemd[1]: sshd@18-10.0.0.106:22-10.0.0.1:57600.service: Deactivated successfully. Dec 16 12:40:57.402961 systemd[1]: session-19.scope: Deactivated successfully. Dec 16 12:40:57.404030 systemd-logind[1396]: Session 19 logged out. Waiting for processes to exit. Dec 16 12:40:57.407156 systemd[1]: Started sshd@19-10.0.0.106:22-10.0.0.1:57606.service - OpenSSH per-connection server daemon (10.0.0.1:57606). Dec 16 12:40:57.412272 systemd-logind[1396]: Removed session 19. Dec 16 12:40:57.456339 sshd[2395]: Accepted publickey for core from 10.0.0.1 port 57606 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:57.457579 sshd-session[2395]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:57.462919 systemd-logind[1396]: New session 20 of user core. Dec 16 12:40:57.471883 systemd[1]: Started session-20.scope - Session 20 of User core. Dec 16 12:40:57.523477 sudo[2399]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1984 Dec 16 12:40:57.523777 sudo[2399]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Dec 16 12:40:57.527051 sudo[2399]: pam_unix(sudo:session): session closed for user root Dec 16 12:40:57.529493 sshd[2398]: Connection closed by 10.0.0.1 port 57606 Dec 16 12:40:57.529684 dockerd[2012]: time="2025-12-16T12:40:57.529439495Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Dec 16 12:40:57.529684 dockerd[2012]: time="2025-12-16T12:40:57.529474375Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Dec 16 12:40:57.530013 sshd-session[2395]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:57.532998 dockerd[2012]: time="2025-12-16T12:40:57.532964025Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Dec 16 12:40:57.532998 dockerd[2012]: time="2025-12-16T12:40:57.532991065Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Dec 16 12:40:57.541544 systemd[1]: containerd.service: Deactivated successfully. Dec 16 12:40:57.541645 systemd[1]: containerd.service: Unit process 2339 (containerd-shim) remains running after unit stopped. Dec 16 12:40:57.541884 systemd[1]: containerd.service: Consumed 180ms CPU time, 122M memory peak. Dec 16 12:40:57.542252 systemd[1]: sshd@19-10.0.0.106:22-10.0.0.1:57606.service: Deactivated successfully. Dec 16 12:40:57.543548 systemd[1]: session-20.scope: Deactivated successfully. Dec 16 12:40:57.545788 systemd-logind[1396]: Session 20 logged out. Waiting for processes to exit. Dec 16 12:40:57.548391 systemd[1]: Started sshd@20-10.0.0.106:22-10.0.0.1:57610.service - OpenSSH per-connection server daemon (10.0.0.1:57610). Dec 16 12:40:57.549342 systemd-logind[1396]: Removed session 20. Dec 16 12:40:57.602219 sshd[2406]: Accepted publickey for core from 10.0.0.1 port 57610 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:40:57.603634 sshd-session[2406]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:40:57.607901 systemd-logind[1396]: New session 21 of user core. Dec 16 12:40:57.613848 systemd[1]: Started session-21.scope - Session 21 of User core. Dec 16 12:40:57.668125 sshd[2409]: Connection closed by 10.0.0.1 port 57610 Dec 16 12:40:57.668436 sshd-session[2406]: pam_unix(sshd:session): session closed for user core Dec 16 12:40:57.671415 systemd[1]: sshd@20-10.0.0.106:22-10.0.0.1:57610.service: Deactivated successfully. Dec 16 12:40:57.674173 systemd[1]: session-21.scope: Deactivated successfully. Dec 16 12:40:57.674859 systemd-logind[1396]: Session 21 logged out. Waiting for processes to exit. Dec 16 12:40:57.676452 systemd-logind[1396]: Removed session 21. Dec 16 12:40:58.570843 systemd-networkd[1381]: vethecb0a62: Gained IPv6LL Dec 16 12:40:59.894088 update_engine[1398]: I20251216 12:40:59.893987 1398 update_attempter.cc:509] Updating boot flags... Dec 16 12:41:02.792178 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Dec 16 12:41:02.792548 systemd[1]: Stopping docker.service - Docker Application Container Engine... Dec 16 12:41:02.793154 dockerd[2012]: time="2025-12-16T12:41:02.792574447Z" level=info msg="Processing signal 'terminated'" Dec 16 12:41:03.691006 systemd[1]: Started sshd@21-10.0.0.106:22-10.0.0.1:33796.service - OpenSSH per-connection server daemon (10.0.0.1:33796). Dec 16 12:41:03.733823 sshd[2422]: Accepted publickey for core from 10.0.0.1 port 33796 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:03.734857 sshd-session[2422]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:03.738399 systemd-logind[1396]: New session 22 of user core. Dec 16 12:41:03.747855 systemd[1]: Started session-22.scope - Session 22 of User core. Dec 16 12:41:03.801710 sshd[2425]: Connection closed by 10.0.0.1 port 33796 Dec 16 12:41:03.802149 sshd-session[2422]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:03.805305 systemd[1]: sshd@21-10.0.0.106:22-10.0.0.1:33796.service: Deactivated successfully. Dec 16 12:41:03.806732 systemd[1]: session-22.scope: Deactivated successfully. Dec 16 12:41:03.808357 systemd-logind[1396]: Session 22 logged out. Waiting for processes to exit. Dec 16 12:41:03.809437 systemd-logind[1396]: Removed session 22. Dec 16 12:41:04.793218 dockerd[2012]: time="2025-12-16T12:41:04.793108555Z" level=error msg="Error sending stop (signal 15) to container" container=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d error="Cannot kill container 3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Dec 16 12:41:04.793218 dockerd[2012]: time="2025-12-16T12:41:04.793219515Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d Dec 16 12:41:09.819391 systemd[1]: Started sshd@22-10.0.0.106:22-10.0.0.1:33798.service - OpenSSH per-connection server daemon (10.0.0.1:33798). Dec 16 12:41:09.881545 sshd[2431]: Accepted publickey for core from 10.0.0.1 port 33798 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:09.882441 sshd-session[2431]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:09.889513 systemd-logind[1396]: New session 23 of user core. Dec 16 12:41:09.899860 systemd[1]: Started session-23.scope - Session 23 of User core. Dec 16 12:41:09.963594 sshd[2434]: Connection closed by 10.0.0.1 port 33798 Dec 16 12:41:09.963910 sshd-session[2431]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:09.967434 systemd[1]: sshd@22-10.0.0.106:22-10.0.0.1:33798.service: Deactivated successfully. Dec 16 12:41:09.968848 systemd[1]: session-23.scope: Deactivated successfully. Dec 16 12:41:09.969773 systemd-logind[1396]: Session 23 logged out. Waiting for processes to exit. Dec 16 12:41:09.970981 systemd-logind[1396]: Removed session 23. Dec 16 12:41:14.794688 dockerd[2012]: time="2025-12-16T12:41:14.794447948Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d error="context deadline exceeded" Dec 16 12:41:14.795415 systemd[1]: docker-3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d.scope: Deactivated successfully. Dec 16 12:41:15.979188 systemd[1]: Started sshd@23-10.0.0.106:22-10.0.0.1:60926.service - OpenSSH per-connection server daemon (10.0.0.1:60926). Dec 16 12:41:16.034515 sshd[2440]: Accepted publickey for core from 10.0.0.1 port 60926 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:16.036618 sshd-session[2440]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:16.040664 systemd-logind[1396]: New session 24 of user core. Dec 16 12:41:16.051868 systemd[1]: Started session-24.scope - Session 24 of User core. Dec 16 12:41:16.106247 sshd[2443]: Connection closed by 10.0.0.1 port 60926 Dec 16 12:41:16.106078 sshd-session[2440]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:16.110754 systemd[1]: sshd@23-10.0.0.106:22-10.0.0.1:60926.service: Deactivated successfully. Dec 16 12:41:16.113045 systemd[1]: session-24.scope: Deactivated successfully. Dec 16 12:41:16.115549 systemd-logind[1396]: Session 24 logged out. Waiting for processes to exit. Dec 16 12:41:16.116385 systemd-logind[1396]: Removed session 24. Dec 16 12:41:17.793137 dockerd[2012]: time="2025-12-16T12:41:17.793067377Z" level=error msg="Force shutdown daemon" Dec 16 12:41:17.793488 dockerd[2012]: time="2025-12-16T12:41:17.793248457Z" level=info msg="Daemon shutdown complete" Dec 16 12:41:17.797070 systemd[1]: docker.service: Deactivated successfully. Dec 16 12:41:17.797389 systemd[1]: Stopped docker.service - Docker Application Container Engine. Dec 16 12:41:17.797976 systemd[1]: docker.socket: Deactivated successfully. Dec 16 12:41:17.798970 systemd[1]: Closed docker.socket - Docker Socket for the API. Dec 16 12:41:17.799028 systemd[1]: Stopping docker.socket - Docker Socket for the API... Dec 16 12:41:17.800298 systemd[1]: Starting docker.socket - Docker Socket for the API... Dec 16 12:41:17.800448 systemd[1]: containerd.service: Found left-over process 2339 (containerd-shim) in control group while starting unit. Ignoring. Dec 16 12:41:17.800455 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Dec 16 12:41:17.812551 systemd[1]: Starting containerd.service - containerd container runtime... Dec 16 12:41:17.812798 systemd[1]: Listening on docker.socket - Docker Socket for the API. Dec 16 12:41:17.823963 systemd[1]: containerd.service: Found left-over process 2339 (containerd-shim) in control group while starting unit. Ignoring. Dec 16 12:41:17.823973 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Dec 16 12:41:17.828091 (ntainerd)[2454]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Dec 16 12:41:17.851052 containerd[2454]: time="2025-12-16T12:41:17Z" 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:41:17.851601 containerd[2454]: time="2025-12-16T12:41:17.851569224Z" level=info msg="starting containerd" revision=4ac6c20c7bbf8177f29e46bbdc658fec02ffb8ad version=v2.0.7 Dec 16 12:41:17.859511 containerd[2454]: time="2025-12-16T12:41:17.859468631Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="7.96µs" Dec 16 12:41:17.859511 containerd[2454]: time="2025-12-16T12:41:17.859498951Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Dec 16 12:41:17.859605 containerd[2454]: time="2025-12-16T12:41:17.859516711Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Dec 16 12:41:17.859605 containerd[2454]: time="2025-12-16T12:41:17.859544671Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Dec 16 12:41:17.859605 containerd[2454]: time="2025-12-16T12:41:17.859555591Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Dec 16 12:41:17.859758 containerd[2454]: time="2025-12-16T12:41:17.859730191Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Dec 16 12:41:17.859814 containerd[2454]: time="2025-12-16T12:41:17.859797311Z" 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:41:17.859843 containerd[2454]: time="2025-12-16T12:41:17.859815311Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Dec 16 12:41:17.860025 containerd[2454]: time="2025-12-16T12:41:17.859992711Z" 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:41:17.860025 containerd[2454]: time="2025-12-16T12:41:17.860014791Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Dec 16 12:41:17.860071 containerd[2454]: time="2025-12-16T12:41:17.860024871Z" 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:41:17.860071 containerd[2454]: time="2025-12-16T12:41:17.860032231Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Dec 16 12:41:17.860071 containerd[2454]: time="2025-12-16T12:41:17.860052151Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Dec 16 12:41:17.860140 containerd[2454]: time="2025-12-16T12:41:17.860126871Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Dec 16 12:41:17.860177 containerd[2454]: time="2025-12-16T12:41:17.860163391Z" 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:41:17.860203 containerd[2454]: time="2025-12-16T12:41:17.860176511Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Dec 16 12:41:17.860227 containerd[2454]: time="2025-12-16T12:41:17.860206791Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Dec 16 12:41:17.860997 containerd[2454]: time="2025-12-16T12:41:17.860518032Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Dec 16 12:41:17.860997 containerd[2454]: time="2025-12-16T12:41:17.860597792Z" level=info msg="metadata content store policy set" policy=shared Dec 16 12:41:17.860997 containerd[2454]: time="2025-12-16T12:41:17.860783112Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Dec 16 12:41:17.860997 containerd[2454]: time="2025-12-16T12:41:17.860979312Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Dec 16 12:41:17.861202 containerd[2454]: time="2025-12-16T12:41:17.861108432Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Dec 16 12:41:17.861202 containerd[2454]: time="2025-12-16T12:41:17.861187712Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Dec 16 12:41:17.861347 containerd[2454]: time="2025-12-16T12:41:17.861285512Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Dec 16 12:41:17.861347 containerd[2454]: time="2025-12-16T12:41:17.861333232Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Dec 16 12:41:17.861475 containerd[2454]: time="2025-12-16T12:41:17.861422672Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Dec 16 12:41:17.861475 containerd[2454]: time="2025-12-16T12:41:17.861460673Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Dec 16 12:41:17.861589 containerd[2454]: time="2025-12-16T12:41:17.861536273Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Dec 16 12:41:17.861589 containerd[2454]: time="2025-12-16T12:41:17.861574673Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Dec 16 12:41:17.861737 containerd[2454]: time="2025-12-16T12:41:17.861651753Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Dec 16 12:41:17.861737 containerd[2454]: time="2025-12-16T12:41:17.861716393Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Dec 16 12:41:17.862743 containerd[2454]: time="2025-12-16T12:41:17.861998193Z" level=info msg="connecting to shim 3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d" address="unix:///run/containerd/s/53824f2d03f918e9690b77999cd5c31839df398a6dd409a68e5be5c5f6f026a8" namespace=moby protocol=ttrpc version=3 Dec 16 12:41:17.874660 containerd[2454]: time="2025-12-16T12:41:17.874568763Z" level=info msg="cleaning leaked shim process" id=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d namespace=moby Dec 16 12:41:17.884177 containerd[2454]: time="2025-12-16T12:41:17.884086451Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Dec 16 12:41:17.884682 containerd[2454]: time="2025-12-16T12:41:17.884420771Z" level=info msg="shim disconnected" id=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d namespace=moby Dec 16 12:41:17.884682 containerd[2454]: time="2025-12-16T12:41:17.884446491Z" level=warning msg="cleaning up after shim disconnected" id=3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d namespace=moby Dec 16 12:41:17.884682 containerd[2454]: time="2025-12-16T12:41:17.884482851Z" level=info msg="cleaning up dead shim" namespace=moby Dec 16 12:41:17.897072 containerd[2454]: time="2025-12-16T12:41:17.897033862Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Dec 16 12:41:17.897217 containerd[2454]: time="2025-12-16T12:41:17.897197502Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Dec 16 12:41:17.897302 containerd[2454]: time="2025-12-16T12:41:17.897286822Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Dec 16 12:41:17.897360 containerd[2454]: time="2025-12-16T12:41:17.897348862Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Dec 16 12:41:17.897411 containerd[2454]: time="2025-12-16T12:41:17.897399382Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Dec 16 12:41:17.897461 containerd[2454]: time="2025-12-16T12:41:17.897449502Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Dec 16 12:41:17.897515 containerd[2454]: time="2025-12-16T12:41:17.897503462Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Dec 16 12:41:17.897566 containerd[2454]: time="2025-12-16T12:41:17.897553582Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Dec 16 12:41:17.897617 containerd[2454]: time="2025-12-16T12:41:17.897606382Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Dec 16 12:41:17.897682 containerd[2454]: time="2025-12-16T12:41:17.897669862Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Dec 16 12:41:17.897814 containerd[2454]: time="2025-12-16T12:41:17.897783782Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Dec 16 12:41:17.898756 containerd[2454]: time="2025-12-16T12:41:17.898043782Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Dec 16 12:41:17.898946 containerd[2454]: time="2025-12-16T12:41:17.898925823Z" level=info msg="Start snapshots syncer" Dec 16 12:41:17.898974 containerd[2454]: time="2025-12-16T12:41:17.898960903Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Dec 16 12:41:17.899221 containerd[2454]: time="2025-12-16T12:41:17.899186463Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Dec 16 12:41:17.899292 containerd[2454]: time="2025-12-16T12:41:17.899242383Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Dec 16 12:41:17.899315 containerd[2454]: time="2025-12-16T12:41:17.899300464Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Dec 16 12:41:17.899371 containerd[2454]: time="2025-12-16T12:41:17.899357184Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Dec 16 12:41:17.899392 containerd[2454]: time="2025-12-16T12:41:17.899379144Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Dec 16 12:41:17.899410 containerd[2454]: time="2025-12-16T12:41:17.899390264Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Dec 16 12:41:17.899410 containerd[2454]: time="2025-12-16T12:41:17.899401864Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Dec 16 12:41:17.899448 containerd[2454]: time="2025-12-16T12:41:17.899413304Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Dec 16 12:41:17.899448 containerd[2454]: time="2025-12-16T12:41:17.899423664Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Dec 16 12:41:17.899448 containerd[2454]: time="2025-12-16T12:41:17.899433704Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Dec 16 12:41:17.899499 containerd[2454]: time="2025-12-16T12:41:17.899455824Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Dec 16 12:41:17.899499 containerd[2454]: time="2025-12-16T12:41:17.899471944Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Dec 16 12:41:17.899499 containerd[2454]: time="2025-12-16T12:41:17.899486384Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Dec 16 12:41:17.899551 containerd[2454]: time="2025-12-16T12:41:17.899522344Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Dec 16 12:41:17.899551 containerd[2454]: time="2025-12-16T12:41:17.899537584Z" 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:41:17.899551 containerd[2454]: time="2025-12-16T12:41:17.899547104Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Dec 16 12:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899555984Z" 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:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899563784Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Dec 16 12:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899572264Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Dec 16 12:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899582264Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Dec 16 12:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899597504Z" level=info msg="runtime interface created" Dec 16 12:41:17.899604 containerd[2454]: time="2025-12-16T12:41:17.899602384Z" level=info msg="created NRI interface" Dec 16 12:41:17.899713 containerd[2454]: time="2025-12-16T12:41:17.899610864Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Dec 16 12:41:17.899713 containerd[2454]: time="2025-12-16T12:41:17.899621384Z" level=info msg="Connect containerd service" Dec 16 12:41:17.899713 containerd[2454]: time="2025-12-16T12:41:17.899640264Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Dec 16 12:41:17.900114 containerd[2454]: time="2025-12-16T12:41:17.900078624Z" 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:41:17.908159 containerd[2454]: time="2025-12-16T12:41:17.908107751Z" level=info msg="Start subscribing containerd event" Dec 16 12:41:17.908219 containerd[2454]: time="2025-12-16T12:41:17.908173111Z" level=info msg="Start recovering state" Dec 16 12:41:17.908265 containerd[2454]: time="2025-12-16T12:41:17.908249911Z" level=info msg="Start event monitor" Dec 16 12:41:17.908287 containerd[2454]: time="2025-12-16T12:41:17.908263991Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Dec 16 12:41:17.908319 containerd[2454]: time="2025-12-16T12:41:17.908265871Z" level=info msg="Start cni network conf syncer for default" Dec 16 12:41:17.908341 containerd[2454]: time="2025-12-16T12:41:17.908318151Z" level=info msg="Start streaming server" Dec 16 12:41:17.908341 containerd[2454]: time="2025-12-16T12:41:17.908325311Z" level=info msg=serving... address=/run/containerd/containerd.sock Dec 16 12:41:17.908383 containerd[2454]: time="2025-12-16T12:41:17.908330471Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Dec 16 12:41:17.910747 containerd[2454]: time="2025-12-16T12:41:17.908366031Z" level=info msg="runtime interface starting up..." Dec 16 12:41:17.910747 containerd[2454]: time="2025-12-16T12:41:17.910744793Z" level=info msg="starting plugins..." Dec 16 12:41:17.910792 containerd[2454]: time="2025-12-16T12:41:17.910757513Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Dec 16 12:41:17.910941 containerd[2454]: time="2025-12-16T12:41:17.910926833Z" level=info msg="containerd successfully booted in 0.060036s" Dec 16 12:41:17.911812 systemd[1]: Started containerd.service - containerd container runtime. Dec 16 12:41:17.913610 systemd[1]: Starting docker.service - Docker Application Container Engine... Dec 16 12:41:17.932088 (dockerd)[2502]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Dec 16 12:41:17.957687 dockerd[2502]: time="2025-12-16T12:41:17.957637631Z" level=info msg="Starting up" Dec 16 12:41:17.958366 dockerd[2502]: time="2025-12-16T12:41:17.958344552Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Dec 16 12:41:17.967445 dockerd[2502]: time="2025-12-16T12:41:17.967415399Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Dec 16 12:41:17.986292 dockerd[2502]: time="2025-12-16T12:41:17.986000415Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Dec 16 12:41:17.993754 dockerd[2502]: time="2025-12-16T12:41:17.993721221Z" level=info msg="Loading containers: start." Dec 16 12:41:18.009028 systemd[1]: var-lib-docker-overlay2-f10dc72ecfbab39a933d413c643f2ca3583d54efcd40ba3b3146688d340b95c0-merged.mount: Deactivated successfully. Dec 16 12:41:18.413331 dockerd[2502]: time="2025-12-16T12:41:18.413273463Z" level=info msg="Removing stale sandbox 356bc0f89830e56604a8841bd2426e731238bd6f034004c72f7fb53dfc2dc3b4 (3cc86b51ab7893a114c8f4739ea7aee197bfdd3bdfffcea812513cedb95f756d)" Dec 16 12:41:18.414826 systemd-networkd[1381]: vethecb0a62: Link DOWN Dec 16 12:41:18.414833 systemd-networkd[1381]: vethecb0a62: Lost carrier Dec 16 12:41:18.416758 kernel: docker0: port 1(vethecb0a62) entered disabled state Dec 16 12:41:18.419288 kernel: vethecb0a62 (unregistering): left allmulticast mode Dec 16 12:41:18.419530 kernel: vethecb0a62 (unregistering): left promiscuous mode Dec 16 12:41:18.419556 kernel: docker0: port 1(vethecb0a62) entered disabled state Dec 16 12:41:18.420687 dockerd[2502]: time="2025-12-16T12:41:18.420545189Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Dec 16 12:41:18.420687 dockerd[2502]: time="2025-12-16T12:41:18.420586469Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 3ac0425ed48d97bc5d2d4c83f6988a5791bf9ddd5aa645d5307b15ef5a796be2 1f3667f808fcab367c16614a4432ef9d539fd3c8abcaf5db392014b34a1197db], retrying...." Dec 16 12:41:18.426820 systemd-networkd[1381]: docker0: Lost carrier Dec 16 12:41:18.631928 dockerd[2502]: time="2025-12-16T12:41:18.631889431Z" level=warning msg="error locating sandbox id 2f0650b758396d54876d45177289618d3c454fea55ea6967cd33cf4514df9c9d: sandbox 2f0650b758396d54876d45177289618d3c454fea55ea6967cd33cf4514df9c9d not found" Dec 16 12:41:18.632111 dockerd[2502]: time="2025-12-16T12:41:18.632072791Z" level=warning msg="error locating sandbox id 356bc0f89830e56604a8841bd2426e731238bd6f034004c72f7fb53dfc2dc3b4: sandbox 356bc0f89830e56604a8841bd2426e731238bd6f034004c72f7fb53dfc2dc3b4 not found" Dec 16 12:41:18.632730 dockerd[2502]: time="2025-12-16T12:41:18.632193231Z" level=info msg="Loading containers: done." Dec 16 12:41:18.645262 dockerd[2502]: time="2025-12-16T12:41:18.645218321Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Dec 16 12:41:18.645470 dockerd[2502]: time="2025-12-16T12:41:18.645453522Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Dec 16 12:41:18.645556 dockerd[2502]: time="2025-12-16T12:41:18.645544562Z" level=info msg="Initializing buildkit" Dec 16 12:41:18.662993 dockerd[2502]: time="2025-12-16T12:41:18.662961855Z" level=info msg="Completed buildkit initialization" Dec 16 12:41:18.670043 dockerd[2502]: time="2025-12-16T12:41:18.669863060Z" level=info msg="Daemon has completed initialization" Dec 16 12:41:18.670417 dockerd[2502]: time="2025-12-16T12:41:18.670381541Z" level=info msg="API listen on /run/docker.sock" Dec 16 12:41:18.671332 systemd[1]: Started docker.service - Docker Application Container Engine. Dec 16 12:41:18.974591 systemd[1]: run-docker-netns-356bc0f89830.mount: Deactivated successfully. Dec 16 12:41:22.121331 systemd[1]: Started sshd@24-10.0.0.106:22-10.0.0.1:58912.service - OpenSSH per-connection server daemon (10.0.0.1:58912). Dec 16 12:41:22.183771 sshd[2739]: Accepted publickey for core from 10.0.0.1 port 58912 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:22.185300 sshd-session[2739]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:22.193421 systemd-logind[1396]: New session 25 of user core. Dec 16 12:41:22.202930 systemd[1]: Started session-25.scope - Session 25 of User core. Dec 16 12:41:22.262556 sshd[2742]: Connection closed by 10.0.0.1 port 58912 Dec 16 12:41:22.263634 sshd-session[2739]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:22.271552 systemd[1]: sshd@24-10.0.0.106:22-10.0.0.1:58912.service: Deactivated successfully. Dec 16 12:41:22.273004 systemd[1]: session-25.scope: Deactivated successfully. Dec 16 12:41:22.273705 systemd-logind[1396]: Session 25 logged out. Waiting for processes to exit. Dec 16 12:41:22.275864 systemd[1]: Started sshd@25-10.0.0.106:22-10.0.0.1:58916.service - OpenSSH per-connection server daemon (10.0.0.1:58916). Dec 16 12:41:22.279720 systemd-logind[1396]: Removed session 25. Dec 16 12:41:22.331704 sshd[2748]: Accepted publickey for core from 10.0.0.1 port 58916 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:22.332521 sshd-session[2748]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:22.338117 systemd-logind[1396]: New session 26 of user core. Dec 16 12:41:22.348877 systemd[1]: Started session-26.scope - Session 26 of User core. Dec 16 12:41:22.405333 sshd[2751]: Connection closed by 10.0.0.1 port 58916 Dec 16 12:41:22.405494 sshd-session[2748]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:22.418950 systemd[1]: sshd@25-10.0.0.106:22-10.0.0.1:58916.service: Deactivated successfully. Dec 16 12:41:22.422860 systemd[1]: session-26.scope: Deactivated successfully. Dec 16 12:41:22.424213 systemd-logind[1396]: Session 26 logged out. Waiting for processes to exit. Dec 16 12:41:22.427967 systemd[1]: Started sshd@26-10.0.0.106:22-10.0.0.1:58922.service - OpenSSH per-connection server daemon (10.0.0.1:58922). Dec 16 12:41:22.430721 systemd-logind[1396]: Removed session 26. Dec 16 12:41:22.483374 sshd[2757]: Accepted publickey for core from 10.0.0.1 port 58922 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:22.484661 sshd-session[2757]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:22.489407 systemd-logind[1396]: New session 27 of user core. Dec 16 12:41:22.496935 systemd[1]: Started session-27.scope - Session 27 of User core. Dec 16 12:41:22.581164 sshd[2760]: Connection closed by 10.0.0.1 port 58922 Dec 16 12:41:22.581505 sshd-session[2757]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:22.590974 systemd[1]: sshd@26-10.0.0.106:22-10.0.0.1:58922.service: Deactivated successfully. Dec 16 12:41:22.592329 systemd[1]: session-27.scope: Deactivated successfully. Dec 16 12:41:22.595283 systemd-logind[1396]: Session 27 logged out. Waiting for processes to exit. Dec 16 12:41:22.596985 systemd[1]: Started sshd@27-10.0.0.106:22-10.0.0.1:58924.service - OpenSSH per-connection server daemon (10.0.0.1:58924). Dec 16 12:41:22.598261 systemd-logind[1396]: Removed session 27. Dec 16 12:41:22.654422 sshd[2773]: Accepted publickey for core from 10.0.0.1 port 58924 ssh2: RSA SHA256:J/XE0kfUILM6R4vAQ/VFNBUvzOeHWyvHhn8QzqONTrE Dec 16 12:41:22.655646 sshd-session[2773]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Dec 16 12:41:22.660743 systemd-logind[1396]: New session 28 of user core. Dec 16 12:41:22.671897 systemd[1]: Started session-28.scope - Session 28 of User core. Dec 16 12:41:22.739629 systemd[1]: var-lib-docker-overlay2-f01e5f5e8dc5df226925a1a32469fd6ec5d41debbe8be4f3f2ba652753900cb0\x2dinit-merged.mount: Deactivated successfully. Dec 16 12:41:22.774193 containerd[2454]: time="2025-12-16T12:41:22.774152042Z" level=info msg="connecting to shim 9cb2e485a46ff46df8d4a5a4980bfca6631994baf03646269ff14887b31ac7a6" address="unix:///run/containerd/s/5c5ab04b51917d0865e9460d5f860d7d7396102290fd2d8a6c6b0bd798f5ae68" namespace=moby protocol=ttrpc version=3 Dec 16 12:41:22.800887 systemd[1]: Started docker-9cb2e485a46ff46df8d4a5a4980bfca6631994baf03646269ff14887b31ac7a6.scope - libcontainer container 9cb2e485a46ff46df8d4a5a4980bfca6631994baf03646269ff14887b31ac7a6. Dec 16 12:41:22.812518 systemd-resolved[1295]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Dec 16 12:41:22.828060 kernel: docker0: port 1(veth16aa923) entered blocking state Dec 16 12:41:22.828139 kernel: docker0: port 1(veth16aa923) entered disabled state Dec 16 12:41:22.828165 kernel: veth16aa923: entered allmulticast mode Dec 16 12:41:22.828180 kernel: veth16aa923: entered promiscuous mode Dec 16 12:41:22.829549 systemd-networkd[1381]: veth16aa923: Link UP Dec 16 12:41:22.835733 kernel: eth0: renamed from veth8991403 Dec 16 12:41:22.837530 kernel: docker0: port 1(veth16aa923) entered blocking state Dec 16 12:41:22.837565 kernel: docker0: port 1(veth16aa923) entered forwarding state Dec 16 12:41:22.837682 systemd-networkd[1381]: veth16aa923: Gained carrier Dec 16 12:41:22.838083 systemd-networkd[1381]: docker0: Gained carrier Dec 16 12:41:22.860357 sshd[2778]: Connection closed by 10.0.0.1 port 58924 Dec 16 12:41:22.860678 sshd-session[2773]: pam_unix(sshd:session): session closed for user core Dec 16 12:41:22.866500 systemd-logind[1396]: Session 28 logged out. Waiting for processes to exit. Dec 16 12:41:22.866531 systemd[1]: sshd@27-10.0.0.106:22-10.0.0.1:58924.service: Deactivated successfully. Dec 16 12:41:22.867905 systemd[1]: session-28.scope: Deactivated successfully. Dec 16 12:41:22.869454 systemd-logind[1396]: Removed session 28.