Sep 9 23:53:15.794042 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 9 23:53:15.794065 kernel: Linux version 6.12.45-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 Tue Sep 9 22:10:22 -00 2025 Sep 9 23:53:15.794075 kernel: KASLR enabled Sep 9 23:53:15.794081 kernel: efi: EFI v2.7 by EDK II Sep 9 23:53:15.794087 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Sep 9 23:53:15.794092 kernel: random: crng init done Sep 9 23:53:15.794099 kernel: secureboot: Secure boot disabled Sep 9 23:53:15.794105 kernel: ACPI: Early table checksum verification disabled Sep 9 23:53:15.794111 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Sep 9 23:53:15.794118 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 9 23:53:15.794124 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794130 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794136 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794142 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794149 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794157 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794163 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794169 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794175 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:53:15.794181 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 9 23:53:15.794187 kernel: ACPI: Use ACPI SPCR as default console: No Sep 9 23:53:15.794193 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:53:15.794199 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Sep 9 23:53:15.794205 kernel: Zone ranges: Sep 9 23:53:15.794211 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:53:15.794219 kernel: DMA32 empty Sep 9 23:53:15.794225 kernel: Normal empty Sep 9 23:53:15.794231 kernel: Device empty Sep 9 23:53:15.794237 kernel: Movable zone start for each node Sep 9 23:53:15.794243 kernel: Early memory node ranges Sep 9 23:53:15.794249 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Sep 9 23:53:15.794255 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Sep 9 23:53:15.794261 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Sep 9 23:53:15.794267 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Sep 9 23:53:15.794274 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Sep 9 23:53:15.794280 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Sep 9 23:53:15.794286 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Sep 9 23:53:15.794293 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Sep 9 23:53:15.794299 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Sep 9 23:53:15.794305 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 9 23:53:15.794314 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 9 23:53:15.794320 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 9 23:53:15.794327 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 9 23:53:15.794334 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:53:15.794341 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 9 23:53:15.794347 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Sep 9 23:53:15.794353 kernel: psci: probing for conduit method from ACPI. Sep 9 23:53:15.794360 kernel: psci: PSCIv1.1 detected in firmware. Sep 9 23:53:15.794366 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 23:53:15.794372 kernel: psci: Trusted OS migration not required Sep 9 23:53:15.794379 kernel: psci: SMC Calling Convention v1.1 Sep 9 23:53:15.794385 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 9 23:53:15.794391 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 9 23:53:15.794399 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 9 23:53:15.794405 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 9 23:53:15.794412 kernel: Detected PIPT I-cache on CPU0 Sep 9 23:53:15.794418 kernel: CPU features: detected: GIC system register CPU interface Sep 9 23:53:15.794424 kernel: CPU features: detected: Spectre-v4 Sep 9 23:53:15.794431 kernel: CPU features: detected: Spectre-BHB Sep 9 23:53:15.794437 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 9 23:53:15.794443 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 9 23:53:15.794450 kernel: CPU features: detected: ARM erratum 1418040 Sep 9 23:53:15.794456 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 9 23:53:15.794462 kernel: alternatives: applying boot alternatives Sep 9 23:53:15.794470 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=fc7b279c2d918629032c01551b74c66c198cf923a976f9b3bc0d959e7c2302db Sep 9 23:53:15.794478 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 23:53:15.794484 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 23:53:15.794491 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 23:53:15.794497 kernel: Fallback order for Node 0: 0 Sep 9 23:53:15.794504 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Sep 9 23:53:15.794510 kernel: Policy zone: DMA Sep 9 23:53:15.794516 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 23:53:15.794522 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Sep 9 23:53:15.794529 kernel: software IO TLB: area num 4. Sep 9 23:53:15.794535 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Sep 9 23:53:15.794541 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Sep 9 23:53:15.794549 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 9 23:53:15.794555 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 23:53:15.794563 kernel: rcu: RCU event tracing is enabled. Sep 9 23:53:15.794569 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 9 23:53:15.794576 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 23:53:15.794582 kernel: Tracing variant of Tasks RCU enabled. Sep 9 23:53:15.794588 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 23:53:15.794595 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 9 23:53:15.794601 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 23:53:15.794608 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 23:53:15.794614 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 23:53:15.794622 kernel: GICv3: 256 SPIs implemented Sep 9 23:53:15.794628 kernel: GICv3: 0 Extended SPIs implemented Sep 9 23:53:15.794634 kernel: Root IRQ handler: gic_handle_irq Sep 9 23:53:15.794640 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 9 23:53:15.794647 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 9 23:53:15.794653 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 9 23:53:15.794659 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 9 23:53:15.794665 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Sep 9 23:53:15.794672 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Sep 9 23:53:15.794678 kernel: GICv3: using LPI property table @0x0000000040130000 Sep 9 23:53:15.794685 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Sep 9 23:53:15.794691 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 23:53:15.794699 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:53:15.794705 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 9 23:53:15.794711 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 9 23:53:15.794718 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 9 23:53:15.794724 kernel: arm-pv: using stolen time PV Sep 9 23:53:15.794731 kernel: Console: colour dummy device 80x25 Sep 9 23:53:15.794738 kernel: ACPI: Core revision 20240827 Sep 9 23:53:15.794755 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 9 23:53:15.794763 kernel: pid_max: default: 32768 minimum: 301 Sep 9 23:53:15.794770 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 9 23:53:15.794778 kernel: landlock: Up and running. Sep 9 23:53:15.794784 kernel: SELinux: Initializing. Sep 9 23:53:15.794791 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:53:15.794798 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:53:15.794804 kernel: rcu: Hierarchical SRCU implementation. Sep 9 23:53:15.794811 kernel: rcu: Max phase no-delay instances is 400. Sep 9 23:53:15.794818 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 9 23:53:15.794825 kernel: Remapping and enabling EFI services. Sep 9 23:53:15.794831 kernel: smp: Bringing up secondary CPUs ... Sep 9 23:53:15.794850 kernel: Detected PIPT I-cache on CPU1 Sep 9 23:53:15.794857 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 9 23:53:15.794864 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Sep 9 23:53:15.794872 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:53:15.794879 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 9 23:53:15.794886 kernel: Detected PIPT I-cache on CPU2 Sep 9 23:53:15.794893 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 9 23:53:15.794900 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Sep 9 23:53:15.794908 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:53:15.794915 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 9 23:53:15.794922 kernel: Detected PIPT I-cache on CPU3 Sep 9 23:53:15.794929 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 9 23:53:15.794936 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Sep 9 23:53:15.794943 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:53:15.794949 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 9 23:53:15.794956 kernel: smp: Brought up 1 node, 4 CPUs Sep 9 23:53:15.794963 kernel: SMP: Total of 4 processors activated. Sep 9 23:53:15.794971 kernel: CPU: All CPU(s) started at EL1 Sep 9 23:53:15.794978 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 23:53:15.794985 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 9 23:53:15.794992 kernel: CPU features: detected: Common not Private translations Sep 9 23:53:15.794999 kernel: CPU features: detected: CRC32 instructions Sep 9 23:53:15.795006 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 9 23:53:15.795013 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 9 23:53:15.795020 kernel: CPU features: detected: LSE atomic instructions Sep 9 23:53:15.795026 kernel: CPU features: detected: Privileged Access Never Sep 9 23:53:15.795035 kernel: CPU features: detected: RAS Extension Support Sep 9 23:53:15.795042 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 9 23:53:15.795049 kernel: alternatives: applying system-wide alternatives Sep 9 23:53:15.795056 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Sep 9 23:53:15.795063 kernel: Memory: 2424544K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 125408K reserved, 16384K cma-reserved) Sep 9 23:53:15.795070 kernel: devtmpfs: initialized Sep 9 23:53:15.795077 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 23:53:15.795084 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 9 23:53:15.795091 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 9 23:53:15.795099 kernel: 0 pages in range for non-PLT usage Sep 9 23:53:15.795106 kernel: 508576 pages in range for PLT usage Sep 9 23:53:15.795113 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 23:53:15.795120 kernel: SMBIOS 3.0.0 present. Sep 9 23:53:15.795127 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 9 23:53:15.795134 kernel: DMI: Memory slots populated: 1/1 Sep 9 23:53:15.795140 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 23:53:15.795147 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 23:53:15.795154 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 23:53:15.795163 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 23:53:15.795170 kernel: audit: initializing netlink subsys (disabled) Sep 9 23:53:15.795177 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Sep 9 23:53:15.795183 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 23:53:15.795190 kernel: cpuidle: using governor menu Sep 9 23:53:15.795197 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 23:53:15.795204 kernel: ASID allocator initialised with 32768 entries Sep 9 23:53:15.795211 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 23:53:15.795218 kernel: Serial: AMBA PL011 UART driver Sep 9 23:53:15.795226 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 23:53:15.795233 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 23:53:15.795240 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 23:53:15.795247 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 9 23:53:15.795253 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 23:53:15.795260 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 23:53:15.795267 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 23:53:15.795274 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 9 23:53:15.795284 kernel: ACPI: Added _OSI(Module Device) Sep 9 23:53:15.795293 kernel: ACPI: Added _OSI(Processor Device) Sep 9 23:53:15.795300 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 23:53:15.795307 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 23:53:15.795314 kernel: ACPI: Interpreter enabled Sep 9 23:53:15.795321 kernel: ACPI: Using GIC for interrupt routing Sep 9 23:53:15.795328 kernel: ACPI: MCFG table detected, 1 entries Sep 9 23:53:15.795335 kernel: ACPI: CPU0 has been hot-added Sep 9 23:53:15.795342 kernel: ACPI: CPU1 has been hot-added Sep 9 23:53:15.795349 kernel: ACPI: CPU2 has been hot-added Sep 9 23:53:15.795356 kernel: ACPI: CPU3 has been hot-added Sep 9 23:53:15.795365 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 9 23:53:15.795372 kernel: printk: legacy console [ttyAMA0] enabled Sep 9 23:53:15.795379 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 9 23:53:15.795517 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 23:53:15.795581 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 23:53:15.795639 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 23:53:15.795695 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 9 23:53:15.795765 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 9 23:53:15.795776 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 9 23:53:15.795783 kernel: PCI host bridge to bus 0000:00 Sep 9 23:53:15.795859 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 9 23:53:15.795917 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 23:53:15.795984 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 9 23:53:15.796035 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 9 23:53:15.796113 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Sep 9 23:53:15.796182 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 9 23:53:15.796242 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Sep 9 23:53:15.796302 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Sep 9 23:53:15.796360 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 23:53:15.796418 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Sep 9 23:53:15.796476 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Sep 9 23:53:15.796536 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Sep 9 23:53:15.796587 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 9 23:53:15.796639 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 23:53:15.796690 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 9 23:53:15.796699 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 23:53:15.796706 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 23:53:15.796713 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 23:53:15.796722 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 23:53:15.796729 kernel: iommu: Default domain type: Translated Sep 9 23:53:15.796736 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 23:53:15.796743 kernel: efivars: Registered efivars operations Sep 9 23:53:15.796769 kernel: vgaarb: loaded Sep 9 23:53:15.796776 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 23:53:15.796783 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 23:53:15.796790 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 23:53:15.796797 kernel: pnp: PnP ACPI init Sep 9 23:53:15.796876 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 9 23:53:15.796888 kernel: pnp: PnP ACPI: found 1 devices Sep 9 23:53:15.796895 kernel: NET: Registered PF_INET protocol family Sep 9 23:53:15.796902 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 23:53:15.796909 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 23:53:15.796916 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 23:53:15.796923 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 23:53:15.796930 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 9 23:53:15.796939 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 23:53:15.796946 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:53:15.796953 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:53:15.796960 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 23:53:15.796967 kernel: PCI: CLS 0 bytes, default 64 Sep 9 23:53:15.796974 kernel: kvm [1]: HYP mode not available Sep 9 23:53:15.796981 kernel: Initialise system trusted keyrings Sep 9 23:53:15.796988 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 23:53:15.796995 kernel: Key type asymmetric registered Sep 9 23:53:15.797003 kernel: Asymmetric key parser 'x509' registered Sep 9 23:53:15.797010 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 9 23:53:15.797017 kernel: io scheduler mq-deadline registered Sep 9 23:53:15.797024 kernel: io scheduler kyber registered Sep 9 23:53:15.797032 kernel: io scheduler bfq registered Sep 9 23:53:15.797039 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 23:53:15.797045 kernel: ACPI: button: Power Button [PWRB] Sep 9 23:53:15.797053 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 23:53:15.797115 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 9 23:53:15.797126 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 23:53:15.797133 kernel: thunder_xcv, ver 1.0 Sep 9 23:53:15.797140 kernel: thunder_bgx, ver 1.0 Sep 9 23:53:15.797147 kernel: nicpf, ver 1.0 Sep 9 23:53:15.797154 kernel: nicvf, ver 1.0 Sep 9 23:53:15.797226 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 23:53:15.797282 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T23:53:15 UTC (1757461995) Sep 9 23:53:15.797291 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 23:53:15.797300 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 9 23:53:15.797307 kernel: watchdog: NMI not fully supported Sep 9 23:53:15.797314 kernel: watchdog: Hard watchdog permanently disabled Sep 9 23:53:15.797321 kernel: NET: Registered PF_INET6 protocol family Sep 9 23:53:15.797328 kernel: Segment Routing with IPv6 Sep 9 23:53:15.797335 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 23:53:15.797342 kernel: NET: Registered PF_PACKET protocol family Sep 9 23:53:15.797349 kernel: Key type dns_resolver registered Sep 9 23:53:15.797356 kernel: registered taskstats version 1 Sep 9 23:53:15.797363 kernel: Loading compiled-in X.509 certificates Sep 9 23:53:15.797371 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.45-flatcar: 61217a1897415238555e2058a4e44c51622b0f87' Sep 9 23:53:15.797379 kernel: Demotion targets for Node 0: null Sep 9 23:53:15.797386 kernel: Key type .fscrypt registered Sep 9 23:53:15.797392 kernel: Key type fscrypt-provisioning registered Sep 9 23:53:15.797399 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 23:53:15.797406 kernel: ima: Allocated hash algorithm: sha1 Sep 9 23:53:15.797413 kernel: ima: No architecture policies found Sep 9 23:53:15.797420 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 23:53:15.797428 kernel: clk: Disabling unused clocks Sep 9 23:53:15.797436 kernel: PM: genpd: Disabling unused power domains Sep 9 23:53:15.797443 kernel: Warning: unable to open an initial console. Sep 9 23:53:15.797450 kernel: Freeing unused kernel memory: 38912K Sep 9 23:53:15.797457 kernel: Run /init as init process Sep 9 23:53:15.797463 kernel: with arguments: Sep 9 23:53:15.797470 kernel: /init Sep 9 23:53:15.797477 kernel: with environment: Sep 9 23:53:15.797484 kernel: HOME=/ Sep 9 23:53:15.797492 kernel: TERM=linux Sep 9 23:53:15.797499 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 23:53:15.797507 systemd[1]: Successfully made /usr/ read-only. Sep 9 23:53:15.797517 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) Sep 9 23:53:15.797525 systemd[1]: Detected virtualization kvm. Sep 9 23:53:15.797533 systemd[1]: Detected architecture arm64. Sep 9 23:53:15.797540 systemd[1]: Running in initrd. Sep 9 23:53:15.797547 systemd[1]: No hostname configured, using default hostname. Sep 9 23:53:15.797556 systemd[1]: Hostname set to . Sep 9 23:53:15.797563 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:53:15.797571 systemd[1]: Queued start job for default target initrd.target. Sep 9 23:53:15.797578 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:53:15.797586 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:53:15.797594 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 23:53:15.797648 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:53:15.797664 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 23:53:15.797678 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 23:53:15.797687 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 9 23:53:15.797695 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 23:53:15.797703 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:53:15.797711 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:53:15.797718 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:53:15.797727 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:53:15.797735 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:53:15.797742 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:53:15.797762 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:53:15.797781 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:53:15.797789 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 23:53:15.797797 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 9 23:53:15.797805 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:53:15.797813 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:53:15.797823 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:53:15.797830 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:53:15.797838 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 23:53:15.797858 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:53:15.797866 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 23:53:15.797874 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). Sep 9 23:53:15.797882 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 23:53:15.797890 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:53:15.797898 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:53:15.797908 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:53:15.797916 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 23:53:15.797924 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:53:15.797932 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 23:53:15.797970 systemd-journald[246]: Collecting audit messages is disabled. Sep 9 23:53:15.797990 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 23:53:15.797999 systemd-journald[246]: Journal started Sep 9 23:53:15.798022 systemd-journald[246]: Runtime Journal (/run/log/journal/e77a7b716904407ebdef588a630ebdf1) is 6M, max 48.5M, 42.4M free. Sep 9 23:53:15.802849 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 23:53:15.802895 kernel: Bridge firewalling registered Sep 9 23:53:15.788467 systemd-modules-load[247]: Inserted module 'overlay' Sep 9 23:53:15.804831 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:53:15.802697 systemd-modules-load[247]: Inserted module 'br_netfilter' Sep 9 23:53:15.808393 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:53:15.808859 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:53:15.811858 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:53:15.815010 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 23:53:15.816915 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:53:15.820960 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:53:15.825304 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:53:15.835331 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:53:15.836873 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:53:15.841155 systemd-tmpfiles[271]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 9 23:53:15.842814 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:53:15.845003 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:53:15.848980 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 23:53:15.851713 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:53:15.879050 dracut-cmdline[289]: 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=fc7b279c2d918629032c01551b74c66c198cf923a976f9b3bc0d959e7c2302db Sep 9 23:53:15.898369 systemd-resolved[290]: Positive Trust Anchors: Sep 9 23:53:15.898683 systemd-resolved[290]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:53:15.898716 systemd-resolved[290]: 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 Sep 9 23:53:15.904698 systemd-resolved[290]: Defaulting to hostname 'linux'. Sep 9 23:53:15.906498 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:53:15.909223 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:53:15.964791 kernel: SCSI subsystem initialized Sep 9 23:53:15.969765 kernel: Loading iSCSI transport class v2.0-870. Sep 9 23:53:15.977791 kernel: iscsi: registered transport (tcp) Sep 9 23:53:15.990785 kernel: iscsi: registered transport (qla4xxx) Sep 9 23:53:15.990817 kernel: QLogic iSCSI HBA Driver Sep 9 23:53:16.007775 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 23:53:16.024706 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:53:16.027521 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 23:53:16.075134 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 23:53:16.077544 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 23:53:16.150778 kernel: raid6: neonx8 gen() 15704 MB/s Sep 9 23:53:16.167775 kernel: raid6: neonx4 gen() 15549 MB/s Sep 9 23:53:16.184772 kernel: raid6: neonx2 gen() 13176 MB/s Sep 9 23:53:16.201770 kernel: raid6: neonx1 gen() 10422 MB/s Sep 9 23:53:16.218785 kernel: raid6: int64x8 gen() 6895 MB/s Sep 9 23:53:16.235776 kernel: raid6: int64x4 gen() 7334 MB/s Sep 9 23:53:16.252772 kernel: raid6: int64x2 gen() 6095 MB/s Sep 9 23:53:16.269911 kernel: raid6: int64x1 gen() 5040 MB/s Sep 9 23:53:16.269982 kernel: raid6: using algorithm neonx8 gen() 15704 MB/s Sep 9 23:53:16.286801 kernel: raid6: .... xor() 11917 MB/s, rmw enabled Sep 9 23:53:16.286894 kernel: raid6: using neon recovery algorithm Sep 9 23:53:16.296123 kernel: xor: measuring software checksum speed Sep 9 23:53:16.296184 kernel: 8regs : 21653 MB/sec Sep 9 23:53:16.296764 kernel: 32regs : 21676 MB/sec Sep 9 23:53:16.296779 kernel: arm64_neon : 25793 MB/sec Sep 9 23:53:16.297767 kernel: xor: using function: arm64_neon (25793 MB/sec) Sep 9 23:53:16.349779 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 23:53:16.357260 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:53:16.360027 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:53:16.393651 systemd-udevd[500]: Using default interface naming scheme 'v255'. Sep 9 23:53:16.397976 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:53:16.400513 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 23:53:16.425306 dracut-pre-trigger[509]: rd.md=0: removing MD RAID activation Sep 9 23:53:16.451570 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:53:16.454415 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:53:16.510338 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:53:16.514222 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 23:53:16.572908 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 9 23:53:16.573093 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 9 23:53:16.576779 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:53:16.582412 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:53:16.582548 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:53:16.586176 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:53:16.589117 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:53:16.623178 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:53:16.632517 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 9 23:53:16.638689 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 23:53:16.645346 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 9 23:53:16.646820 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 9 23:53:16.657079 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 23:53:16.665033 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 9 23:53:16.666408 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:53:16.668706 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:53:16.670901 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:53:16.673648 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 23:53:16.675639 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 23:53:16.693493 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:53:16.696775 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:53:17.712710 disk-uuid[601]: The operation has completed successfully. Sep 9 23:53:17.713989 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:53:17.741256 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 23:53:17.741376 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 23:53:17.767133 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 9 23:53:17.797053 sh[612]: Success Sep 9 23:53:17.810888 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 23:53:17.810946 kernel: device-mapper: uevent: version 1.0.3 Sep 9 23:53:17.812333 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 9 23:53:17.823773 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 9 23:53:17.858436 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 9 23:53:17.861273 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 9 23:53:17.874061 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 9 23:53:17.881771 kernel: BTRFS: device fsid 2bc16190-0dd5-44d6-b331-3d703f5a1d1f devid 1 transid 40 /dev/mapper/usr (253:0) scanned by mount (625) Sep 9 23:53:17.881819 kernel: BTRFS info (device dm-0): first mount of filesystem 2bc16190-0dd5-44d6-b331-3d703f5a1d1f Sep 9 23:53:17.881830 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:53:17.888788 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 9 23:53:17.888839 kernel: BTRFS info (device dm-0): enabling free space tree Sep 9 23:53:17.890088 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 9 23:53:17.891411 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 9 23:53:17.892994 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 9 23:53:17.893727 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 9 23:53:17.895347 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 23:53:17.924417 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (656) Sep 9 23:53:17.924477 kernel: BTRFS info (device vda6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:53:17.924487 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:53:17.928315 kernel: BTRFS info (device vda6): turning on async discard Sep 9 23:53:17.928375 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 23:53:17.932794 kernel: BTRFS info (device vda6): last unmount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:53:17.934304 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 9 23:53:17.936617 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 23:53:18.008249 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:53:18.012685 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:53:18.052068 systemd-networkd[805]: lo: Link UP Sep 9 23:53:18.052945 systemd-networkd[805]: lo: Gained carrier Sep 9 23:53:18.053867 ignition[705]: Ignition 2.21.0 Sep 9 23:53:18.053705 systemd-networkd[805]: Enumeration completed Sep 9 23:53:18.053874 ignition[705]: Stage: fetch-offline Sep 9 23:53:18.053830 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:53:18.053951 ignition[705]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:18.055111 systemd[1]: Reached target network.target - Network. Sep 9 23:53:18.053961 ignition[705]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:18.056878 systemd-networkd[805]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:53:18.054130 ignition[705]: parsed url from cmdline: "" Sep 9 23:53:18.056881 systemd-networkd[805]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:53:18.054134 ignition[705]: no config URL provided Sep 9 23:53:18.057384 systemd-networkd[805]: eth0: Link UP Sep 9 23:53:18.054138 ignition[705]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 23:53:18.057975 systemd-networkd[805]: eth0: Gained carrier Sep 9 23:53:18.054145 ignition[705]: no config at "/usr/lib/ignition/user.ign" Sep 9 23:53:18.057986 systemd-networkd[805]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:53:18.054167 ignition[705]: op(1): [started] loading QEMU firmware config module Sep 9 23:53:18.054172 ignition[705]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 9 23:53:18.063762 ignition[705]: op(1): [finished] loading QEMU firmware config module Sep 9 23:53:18.072252 ignition[705]: parsing config with SHA512: 9d8205a064b24f99e7244946ba71f1f8c0b42f5c50fab30a56d2555901d6c851a492d4ace327a948b51a106cf2b83a6378be067b18429c69fe7c35fd9ba13f97 Sep 9 23:53:18.081828 systemd-networkd[805]: eth0: DHCPv4 address 10.0.0.99/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 23:53:18.085070 unknown[705]: fetched base config from "system" Sep 9 23:53:18.086004 unknown[705]: fetched user config from "qemu" Sep 9 23:53:18.086198 ignition[705]: fetch-offline: fetch-offline passed Sep 9 23:53:18.086295 ignition[705]: Ignition finished successfully Sep 9 23:53:18.088203 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:53:18.089928 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 9 23:53:18.090779 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 23:53:18.121945 ignition[813]: Ignition 2.21.0 Sep 9 23:53:18.121961 ignition[813]: Stage: kargs Sep 9 23:53:18.122114 ignition[813]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:18.122124 ignition[813]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:18.125015 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 23:53:18.122688 ignition[813]: kargs: kargs passed Sep 9 23:53:18.122796 ignition[813]: Ignition finished successfully Sep 9 23:53:18.127613 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 23:53:18.151731 ignition[821]: Ignition 2.21.0 Sep 9 23:53:18.151764 ignition[821]: Stage: disks Sep 9 23:53:18.151927 ignition[821]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:18.151938 ignition[821]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:18.152688 ignition[821]: disks: disks passed Sep 9 23:53:18.155263 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 23:53:18.152788 ignition[821]: Ignition finished successfully Sep 9 23:53:18.156809 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 23:53:18.158259 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 23:53:18.160274 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:53:18.161575 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:53:18.163363 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:53:18.166289 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 23:53:18.205224 systemd-fsck[831]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 9 23:53:18.210124 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 23:53:18.213135 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 23:53:18.289778 kernel: EXT4-fs (vda9): mounted filesystem 7cc0d7f3-e4a1-4dc4-8b58-ceece0d874c1 r/w with ordered data mode. Quota mode: none. Sep 9 23:53:18.289892 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 23:53:18.291168 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 23:53:18.293776 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:53:18.297739 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 23:53:18.298785 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 9 23:53:18.298845 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 23:53:18.298875 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:53:18.309473 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 23:53:18.311993 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 23:53:18.315763 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (839) Sep 9 23:53:18.317472 kernel: BTRFS info (device vda6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:53:18.317499 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:53:18.322284 kernel: BTRFS info (device vda6): turning on async discard Sep 9 23:53:18.322336 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 23:53:18.324458 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:53:18.351766 initrd-setup-root[863]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 23:53:18.356323 initrd-setup-root[870]: cut: /sysroot/etc/group: No such file or directory Sep 9 23:53:18.359603 initrd-setup-root[877]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 23:53:18.363510 initrd-setup-root[884]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 23:53:18.436791 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 23:53:18.439006 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 23:53:18.440962 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 9 23:53:18.462852 kernel: BTRFS info (device vda6): last unmount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:53:18.477910 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 9 23:53:18.489967 ignition[953]: INFO : Ignition 2.21.0 Sep 9 23:53:18.489967 ignition[953]: INFO : Stage: mount Sep 9 23:53:18.493209 ignition[953]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:18.493209 ignition[953]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:18.493209 ignition[953]: INFO : mount: mount passed Sep 9 23:53:18.493209 ignition[953]: INFO : Ignition finished successfully Sep 9 23:53:18.496160 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 23:53:18.498900 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 23:53:18.880130 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 9 23:53:18.881617 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:53:18.901770 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (966) Sep 9 23:53:18.904331 kernel: BTRFS info (device vda6): first mount of filesystem 3a7d3e29-58a5-4f0c-ac69-b528108338f5 Sep 9 23:53:18.904368 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:53:18.907378 kernel: BTRFS info (device vda6): turning on async discard Sep 9 23:53:18.907410 kernel: BTRFS info (device vda6): enabling free space tree Sep 9 23:53:18.909133 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:53:18.940863 ignition[983]: INFO : Ignition 2.21.0 Sep 9 23:53:18.940863 ignition[983]: INFO : Stage: files Sep 9 23:53:18.943518 ignition[983]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:18.943518 ignition[983]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:18.943518 ignition[983]: DEBUG : files: compiled without relabeling support, skipping Sep 9 23:53:18.943518 ignition[983]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 23:53:18.943518 ignition[983]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 23:53:18.951018 ignition[983]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 23:53:18.951018 ignition[983]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 23:53:18.951018 ignition[983]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 23:53:18.945591 unknown[983]: wrote ssh authorized keys file for user: core Sep 9 23:53:18.957615 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 23:53:18.957615 ignition[983]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(4): [started] processing unit "docker.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(4): [finished] processing unit "docker.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Sep 9 23:53:18.957615 ignition[983]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 9 23:53:18.973289 ignition[983]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 23:53:18.974851 ignition[983]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 23:53:18.974851 ignition[983]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 9 23:53:18.974851 ignition[983]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 9 23:53:18.974851 ignition[983]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 9 23:53:18.974851 ignition[983]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:53:18.974851 ignition[983]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:53:18.974851 ignition[983]: INFO : files: files passed Sep 9 23:53:18.974851 ignition[983]: INFO : Ignition finished successfully Sep 9 23:53:18.976582 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 23:53:18.981013 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 23:53:18.982692 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 23:53:18.996658 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 23:53:18.996770 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 23:53:18.999797 initrd-setup-root-after-ignition[1012]: grep: /sysroot/oem/oem-release: No such file or directory Sep 9 23:53:19.001157 initrd-setup-root-after-ignition[1014]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:53:19.001157 initrd-setup-root-after-ignition[1014]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:53:19.005418 initrd-setup-root-after-ignition[1018]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:53:19.002420 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:53:19.004215 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 9 23:53:19.007214 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 23:53:19.042932 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 23:53:19.043862 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 23:53:19.045262 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 23:53:19.047360 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 9 23:53:19.049582 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 9 23:53:19.050474 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 23:53:19.065524 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:53:19.068168 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 23:53:19.087896 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:53:19.089244 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:53:19.091462 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 23:53:19.093448 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 23:53:19.093572 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:53:19.096339 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 9 23:53:19.098546 systemd[1]: Stopped target basic.target - Basic System. Sep 9 23:53:19.100386 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 9 23:53:19.102444 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:53:19.104612 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 23:53:19.106807 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 9 23:53:19.109016 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 23:53:19.111011 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:53:19.113127 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 23:53:19.115312 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 23:53:19.117219 systemd[1]: Stopped target swap.target - Swaps. Sep 9 23:53:19.118901 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 23:53:19.119034 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:53:19.121588 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:53:19.123789 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:53:19.125934 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 23:53:19.126823 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:53:19.128223 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 23:53:19.128351 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 23:53:19.131411 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 23:53:19.131537 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:53:19.133738 systemd[1]: Stopped target paths.target - Path Units. Sep 9 23:53:19.135505 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 23:53:19.138836 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:53:19.140844 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 23:53:19.143256 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 23:53:19.144964 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 23:53:19.145054 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:53:19.146785 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 23:53:19.146873 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:53:19.148692 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 23:53:19.148839 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:53:19.150854 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 23:53:19.150964 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 23:53:19.153705 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 23:53:19.156560 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 9 23:53:19.157890 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 23:53:19.158014 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:53:19.160047 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 23:53:19.160140 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:53:19.166392 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 23:53:19.166474 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 23:53:19.173628 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 23:53:19.180489 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 23:53:19.180598 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 9 23:53:19.184311 ignition[1039]: INFO : Ignition 2.21.0 Sep 9 23:53:19.184311 ignition[1039]: INFO : Stage: umount Sep 9 23:53:19.184311 ignition[1039]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:53:19.184311 ignition[1039]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:53:19.184311 ignition[1039]: INFO : umount: umount passed Sep 9 23:53:19.184311 ignition[1039]: INFO : Ignition finished successfully Sep 9 23:53:19.184100 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 23:53:19.184817 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 23:53:19.186431 systemd[1]: Stopped target network.target - Network. Sep 9 23:53:19.187775 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 23:53:19.187887 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 23:53:19.189693 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 23:53:19.189742 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 23:53:19.191764 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 23:53:19.191824 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 9 23:53:19.193458 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 23:53:19.193500 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 23:53:19.195211 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 23:53:19.195263 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 23:53:19.197275 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 9 23:53:19.198900 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 23:53:19.209358 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 23:53:19.209494 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 23:53:19.212550 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 9 23:53:19.212809 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 23:53:19.212859 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:53:19.217717 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 9 23:53:19.218012 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 23:53:19.218110 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 9 23:53:19.222255 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 9 23:53:19.223660 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 23:53:19.223698 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:53:19.226858 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 23:53:19.227761 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 23:53:19.227837 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:53:19.230132 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 23:53:19.230185 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:53:19.232976 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 23:53:19.233021 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 23:53:19.235136 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:53:19.254461 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 23:53:19.262945 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:53:19.264611 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 23:53:19.264655 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 23:53:19.266661 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 23:53:19.266694 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:53:19.269099 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 23:53:19.269160 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:53:19.271930 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 23:53:19.271990 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 23:53:19.274986 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 23:53:19.275049 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:53:19.278837 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 23:53:19.280021 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 9 23:53:19.280085 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:53:19.283286 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 23:53:19.283398 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:53:19.286853 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 9 23:53:19.286911 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:53:19.290452 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 23:53:19.290504 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:53:19.293112 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:53:19.293168 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:53:19.297437 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 23:53:19.297542 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 23:53:19.299116 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 23:53:19.299192 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 23:53:19.301826 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 23:53:19.303909 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 23:53:19.334591 systemd[1]: Switching root. Sep 9 23:53:19.365299 systemd-journald[246]: Journal stopped Sep 9 23:53:20.108423 systemd-journald[246]: Received SIGTERM from PID 1 (systemd). Sep 9 23:53:20.108534 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 23:53:20.108546 kernel: SELinux: policy capability open_perms=1 Sep 9 23:53:20.108555 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 23:53:20.108564 kernel: SELinux: policy capability always_check_network=0 Sep 9 23:53:20.108573 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 23:53:20.108583 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 23:53:20.108593 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 23:53:20.108607 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 23:53:20.108617 kernel: SELinux: policy capability userspace_initial_context=0 Sep 9 23:53:20.108626 kernel: audit: type=1403 audit(1757461999.465:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 23:53:20.108641 systemd[1]: Successfully loaded SELinux policy in 59.118ms. Sep 9 23:53:20.108657 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.654ms. Sep 9 23:53:20.108672 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) Sep 9 23:53:20.108682 systemd[1]: Detected virtualization kvm. Sep 9 23:53:20.108693 systemd[1]: Detected architecture arm64. Sep 9 23:53:20.108703 systemd[1]: Detected first boot. Sep 9 23:53:20.108713 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:53:20.108723 zram_generator::config[1084]: No configuration found. Sep 9 23:53:20.108734 kernel: NET: Registered PF_VSOCK protocol family Sep 9 23:53:20.108787 systemd[1]: Populated /etc with preset unit settings. Sep 9 23:53:20.108800 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 9 23:53:20.108810 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 23:53:20.108824 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 23:53:20.108844 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 23:53:20.108856 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 23:53:20.108866 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 23:53:20.108875 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 23:53:20.108885 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 23:53:20.108895 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 23:53:20.108906 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 23:53:20.108917 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 23:53:20.108927 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 23:53:20.108936 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:53:20.108948 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:53:20.108959 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 23:53:20.108969 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 23:53:20.108979 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 23:53:20.108989 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:53:20.108999 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 9 23:53:20.109010 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:53:20.109021 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:53:20.109031 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 23:53:20.109041 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 23:53:20.109052 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 23:53:20.109061 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 23:53:20.109071 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:53:20.109083 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:53:20.109093 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:53:20.109104 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:53:20.109114 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 23:53:20.109126 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 23:53:20.109135 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 9 23:53:20.109146 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:53:20.109155 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:53:20.109166 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:53:20.109176 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 23:53:20.109186 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 23:53:20.109196 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 23:53:20.109206 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 23:53:20.109218 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 23:53:20.109228 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 23:53:20.109237 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 23:53:20.109248 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). Sep 9 23:53:20.109257 systemd[1]: Reached target machines.target - Containers. Sep 9 23:53:20.109267 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 23:53:20.109278 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:53:20.109288 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:53:20.109300 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 23:53:20.109310 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:53:20.109319 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:53:20.109329 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:53:20.109339 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 23:53:20.109349 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:53:20.109359 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 23:53:20.109369 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 23:53:20.109384 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 23:53:20.109393 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 23:53:20.109403 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 23:53:20.109414 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). Sep 9 23:53:20.109424 kernel: fuse: init (API version 7.41) Sep 9 23:53:20.109433 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:53:20.109443 kernel: loop: module loaded Sep 9 23:53:20.109452 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:53:20.109462 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 23:53:20.109473 kernel: ACPI: bus type drm_connector registered Sep 9 23:53:20.109483 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 23:53:20.109493 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 9 23:53:20.109503 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:53:20.109513 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 23:53:20.109524 systemd[1]: Stopped verity-setup.service. Sep 9 23:53:20.109534 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 23:53:20.109544 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 23:53:20.109573 systemd-journald[1152]: Collecting audit messages is disabled. Sep 9 23:53:20.109595 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 23:53:20.109606 systemd-journald[1152]: Journal started Sep 9 23:53:20.109628 systemd-journald[1152]: Runtime Journal (/run/log/journal/e77a7b716904407ebdef588a630ebdf1) is 6M, max 48.5M, 42.4M free. Sep 9 23:53:20.109666 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 23:53:19.853728 systemd[1]: Queued start job for default target multi-user.target. Sep 9 23:53:19.874881 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 9 23:53:19.875796 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 23:53:20.113417 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:53:20.114229 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 23:53:20.115618 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 23:53:20.117057 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 23:53:20.119788 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:53:20.121435 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 23:53:20.121630 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 23:53:20.123275 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:53:20.124789 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:53:20.126259 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:53:20.126426 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:53:20.127909 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:53:20.128066 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:53:20.129667 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 23:53:20.129848 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 23:53:20.131540 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:53:20.131702 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:53:20.133233 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:53:20.135030 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:53:20.138192 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 23:53:20.140067 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 9 23:53:20.150412 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:53:20.153889 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 23:53:20.156371 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 23:53:20.158668 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 23:53:20.160022 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 23:53:20.160052 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:53:20.162139 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 9 23:53:20.176993 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 23:53:20.178623 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:53:20.180004 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 23:53:20.182097 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 23:53:20.183671 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:53:20.184885 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 23:53:20.187114 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:53:20.188498 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:53:20.191940 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 23:53:20.197798 systemd-journald[1152]: Time spent on flushing to /var/log/journal/e77a7b716904407ebdef588a630ebdf1 is 14.728ms for 856 entries. Sep 9 23:53:20.197798 systemd-journald[1152]: System Journal (/var/log/journal/e77a7b716904407ebdef588a630ebdf1) is 8M, max 195.6M, 187.6M free. Sep 9 23:53:20.226349 systemd-journald[1152]: Received client request to flush runtime journal. Sep 9 23:53:20.208925 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 23:53:20.212034 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 23:53:20.213719 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 23:53:20.216768 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 23:53:20.220584 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 23:53:20.223700 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 9 23:53:20.231733 kernel: loop0: detected capacity change from 0 to 119320 Sep 9 23:53:20.233956 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 23:53:20.236035 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:53:20.243774 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 23:53:20.254673 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Sep 9 23:53:20.254693 systemd-tmpfiles[1202]: ACLs are not supported, ignoring. Sep 9 23:53:20.258078 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 23:53:20.258858 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:53:20.261043 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 9 23:53:20.264784 kernel: loop1: detected capacity change from 0 to 100608 Sep 9 23:53:20.270003 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 23:53:20.283973 kernel: loop2: detected capacity change from 0 to 119320 Sep 9 23:53:20.297783 kernel: loop3: detected capacity change from 0 to 100608 Sep 9 23:53:20.305109 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 23:53:20.308591 (sd-merge)[1220]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 9 23:53:20.309066 (sd-merge)[1220]: Merged extensions into '/usr'. Sep 9 23:53:20.311542 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:53:20.313730 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 23:53:20.327935 systemd[1]: Starting ensure-sysext.service... Sep 9 23:53:20.329940 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:53:20.348999 systemd[1]: Reload requested from client PID 1224 ('systemctl') (unit ensure-sysext.service)... Sep 9 23:53:20.349017 systemd[1]: Reloading... Sep 9 23:53:20.350522 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 9 23:53:20.350571 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 9 23:53:20.350972 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 23:53:20.351190 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 9 23:53:20.351873 systemd-tmpfiles[1226]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 23:53:20.352086 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 9 23:53:20.352145 systemd-tmpfiles[1226]: ACLs are not supported, ignoring. Sep 9 23:53:20.354353 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 9 23:53:20.354368 systemd-tmpfiles[1222]: ACLs are not supported, ignoring. Sep 9 23:53:20.355189 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:53:20.355196 systemd-tmpfiles[1226]: Skipping /boot Sep 9 23:53:20.362102 systemd-tmpfiles[1226]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:53:20.362119 systemd-tmpfiles[1226]: Skipping /boot Sep 9 23:53:20.420781 zram_generator::config[1253]: No configuration found. Sep 9 23:53:20.499791 ldconfig[1196]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 23:53:20.567132 systemd[1]: Reloading finished in 217 ms. Sep 9 23:53:20.584642 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 23:53:20.586308 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:53:20.602765 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:53:20.611642 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:53:20.615589 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 23:53:20.628056 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 23:53:20.633036 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:53:20.635665 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 23:53:20.641459 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:53:20.642880 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:53:20.649118 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:53:20.654662 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:53:20.656690 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:53:20.656888 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). Sep 9 23:53:20.659562 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:53:20.659761 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:53:20.661861 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:53:20.662072 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:53:20.669488 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:53:20.669693 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:53:20.675876 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 23:53:20.682994 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 23:53:20.687278 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:53:20.688570 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:53:20.693560 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:53:20.697602 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:53:20.700434 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:53:20.702009 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:53:20.702062 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). Sep 9 23:53:20.705944 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 23:53:20.707941 systemd[1]: Finished ensure-sysext.service. Sep 9 23:53:20.709218 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:53:20.709386 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:53:20.709450 augenrules[1329]: No rules Sep 9 23:53:20.711198 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:53:20.711411 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:53:20.712932 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:53:20.713089 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:53:20.714855 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:53:20.716799 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:53:20.718625 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:53:20.718830 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:53:20.725320 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:53:20.725406 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:53:20.727626 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 9 23:53:20.746887 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 23:53:20.756970 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 23:53:20.758907 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 23:53:20.763851 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:53:20.766275 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 23:53:20.767451 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). Sep 9 23:53:20.784551 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 23:53:20.807515 systemd-udevd[1349]: Using default interface naming scheme 'v255'. Sep 9 23:53:20.808604 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 9 23:53:20.810486 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 23:53:20.814100 systemd-resolved[1296]: Positive Trust Anchors: Sep 9 23:53:20.814121 systemd-resolved[1296]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:53:20.814154 systemd-resolved[1296]: 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 Sep 9 23:53:20.821938 systemd-resolved[1296]: Defaulting to hostname 'linux'. Sep 9 23:53:20.823442 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:53:20.824927 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:53:20.831895 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:53:20.833718 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:53:20.835354 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 23:53:20.837178 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 9 23:53:20.839359 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 23:53:20.841486 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 23:53:20.843768 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 23:53:20.845217 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 23:53:20.845258 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:53:20.846880 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:53:20.848998 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 23:53:20.852290 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:53:20.857036 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 9 23:53:20.858336 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 9 23:53:20.860513 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 9 23:53:20.865568 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 23:53:20.868227 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 9 23:53:20.873695 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:53:20.876468 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:53:20.891720 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:53:20.894576 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:53:20.896080 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:53:20.896110 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:53:20.899154 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 23:53:20.902457 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 23:53:20.906084 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 23:53:20.912930 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 23:53:20.914719 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). Sep 9 23:53:20.916975 jq[1386]: false Sep 9 23:53:20.917480 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 23:53:20.921990 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 23:53:20.929143 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 23:53:20.934661 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 23:53:20.938687 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 23:53:20.939309 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 23:53:20.941019 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 23:53:20.946293 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 23:53:20.950834 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 23:53:20.952486 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 23:53:20.952770 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 9 23:53:20.953052 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 23:53:20.953235 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 23:53:20.958109 extend-filesystems[1387]: Found /dev/vda6 Sep 9 23:53:20.961813 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 9 23:53:20.974690 update_engine[1394]: I20250909 23:53:20.973654 1394 main.cc:92] Flatcar Update Engine starting Sep 9 23:53:20.977005 extend-filesystems[1387]: Found /dev/vda9 Sep 9 23:53:20.983920 extend-filesystems[1387]: Checking size of /dev/vda9 Sep 9 23:53:20.991362 jq[1396]: true Sep 9 23:53:21.004901 extend-filesystems[1387]: Old size kept for /dev/vda9 Sep 9 23:53:21.006146 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 23:53:21.006434 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 23:53:21.010539 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 23:53:21.010739 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 23:53:21.011714 jq[1415]: true Sep 9 23:53:21.016640 dbus-daemon[1383]: [system] SELinux support is enabled Sep 9 23:53:21.018167 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 23:53:21.019694 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 23:53:21.024103 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). Sep 9 23:53:21.024937 update_engine[1394]: I20250909 23:53:21.024324 1394 update_check_scheduler.cc:74] Next update check in 4m25s Sep 9 23:53:21.024134 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 23:53:21.028180 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 23:53:21.029522 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). Sep 9 23:53:21.029552 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 23:53:21.031215 systemd[1]: Started update-engine.service - Update Engine. Sep 9 23:53:21.034178 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 23:53:21.034954 systemd-networkd[1382]: lo: Link UP Sep 9 23:53:21.034966 systemd-networkd[1382]: lo: Gained carrier Sep 9 23:53:21.045613 systemd-networkd[1382]: Enumeration completed Sep 9 23:53:21.047084 systemd-networkd[1382]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:53:21.047090 systemd-networkd[1382]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:53:21.048262 systemd-logind[1393]: New seat seat0. Sep 9 23:53:21.048887 systemd-networkd[1382]: eth0: Link UP Sep 9 23:53:21.049055 systemd-networkd[1382]: eth0: Gained carrier Sep 9 23:53:21.049074 systemd-networkd[1382]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:53:21.049266 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:53:21.051056 systemd[1]: Reached target network.target - Network. Sep 9 23:53:21.054040 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:53:21.059580 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 9 23:53:21.062978 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 9 23:53:21.064768 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 23:53:21.068789 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 23:53:21.073030 systemd-networkd[1382]: eth0: DHCPv4 address 10.0.0.99/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 23:53:21.075165 systemd-timesyncd[1340]: Network configuration changed, trying to establish connection. Sep 9 23:53:21.076281 systemd-timesyncd[1340]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 9 23:53:21.076643 systemd-timesyncd[1340]: Initial clock synchronization to Tue 2025-09-09 23:53:21.380738 UTC. Sep 9 23:53:21.087246 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 9 23:53:21.087604 bash[1450]: Updated "/home/core/.ssh/authorized_keys" Sep 9 23:53:21.103416 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 9 23:53:21.103559 (ntainerd)[1452]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:53:21.113122 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 9 23:53:21.150183 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:53:21.167889 locksmithd[1429]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 23:53:21.184496 systemd-logind[1393]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 23:53:21.234797 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:53:21.310871 containerd[1452]: time="2025-09-09T23:53:21Z" 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 Sep 9 23:53:21.312601 containerd[1452]: time="2025-09-09T23:53:21.312560200Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 9 23:53:21.323070 containerd[1452]: time="2025-09-09T23:53:21.323022880Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.24µs" Sep 9 23:53:21.323070 containerd[1452]: time="2025-09-09T23:53:21.323067920Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 23:53:21.323124 containerd[1452]: time="2025-09-09T23:53:21.323086840Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 23:53:21.323276 containerd[1452]: time="2025-09-09T23:53:21.323254520Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 23:53:21.323300 containerd[1452]: time="2025-09-09T23:53:21.323278840Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 23:53:21.323329 containerd[1452]: time="2025-09-09T23:53:21.323305040Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323378 containerd[1452]: time="2025-09-09T23:53:21.323357280Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323378 containerd[1452]: time="2025-09-09T23:53:21.323372680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323636 containerd[1452]: time="2025-09-09T23:53:21.323612440Z" 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 Sep 9 23:53:21.323662 containerd[1452]: time="2025-09-09T23:53:21.323634600Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323662 containerd[1452]: time="2025-09-09T23:53:21.323647080Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323662 containerd[1452]: time="2025-09-09T23:53:21.323656080Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323742 containerd[1452]: time="2025-09-09T23:53:21.323723680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 23:53:21.323984 containerd[1452]: time="2025-09-09T23:53:21.323959680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 23:53:21.324009 containerd[1452]: time="2025-09-09T23:53:21.323999200Z" 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 Sep 9 23:53:21.324028 containerd[1452]: time="2025-09-09T23:53:21.324010560Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 23:53:21.324067 containerd[1452]: time="2025-09-09T23:53:21.324049240Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 23:53:21.324369 containerd[1452]: time="2025-09-09T23:53:21.324346880Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 23:53:21.324439 containerd[1452]: time="2025-09-09T23:53:21.324420160Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:53:21.330715 containerd[1452]: time="2025-09-09T23:53:21.330674520Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 23:53:21.330830 containerd[1452]: time="2025-09-09T23:53:21.330805480Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 23:53:21.330857 containerd[1452]: time="2025-09-09T23:53:21.330836320Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 23:53:21.330857 containerd[1452]: time="2025-09-09T23:53:21.330852040Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 23:53:21.330890 containerd[1452]: time="2025-09-09T23:53:21.330865480Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 23:53:21.330890 containerd[1452]: time="2025-09-09T23:53:21.330876320Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 23:53:21.330890 containerd[1452]: time="2025-09-09T23:53:21.330887920Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 23:53:21.330954 containerd[1452]: time="2025-09-09T23:53:21.330900280Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 23:53:21.330954 containerd[1452]: time="2025-09-09T23:53:21.330912280Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 23:53:21.330954 containerd[1452]: time="2025-09-09T23:53:21.330922320Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 23:53:21.330954 containerd[1452]: time="2025-09-09T23:53:21.330932240Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 23:53:21.330954 containerd[1452]: time="2025-09-09T23:53:21.330944040Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 23:53:21.331097 containerd[1452]: time="2025-09-09T23:53:21.331074200Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 23:53:21.331120 containerd[1452]: time="2025-09-09T23:53:21.331103840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 23:53:21.331138 containerd[1452]: time="2025-09-09T23:53:21.331120600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 23:53:21.331138 containerd[1452]: time="2025-09-09T23:53:21.331132920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 23:53:21.331169 containerd[1452]: time="2025-09-09T23:53:21.331144160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 23:53:21.331169 containerd[1452]: time="2025-09-09T23:53:21.331155320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 23:53:21.331205 containerd[1452]: time="2025-09-09T23:53:21.331167880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 23:53:21.331205 containerd[1452]: time="2025-09-09T23:53:21.331186160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 23:53:21.331205 containerd[1452]: time="2025-09-09T23:53:21.331200040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 23:53:21.331262 containerd[1452]: time="2025-09-09T23:53:21.331212040Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 23:53:21.331262 containerd[1452]: time="2025-09-09T23:53:21.331224080Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 23:53:21.331438 containerd[1452]: time="2025-09-09T23:53:21.331416720Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 23:53:21.331465 containerd[1452]: time="2025-09-09T23:53:21.331439960Z" level=info msg="Start snapshots syncer" Sep 9 23:53:21.331495 containerd[1452]: time="2025-09-09T23:53:21.331481680Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 23:53:21.331880 containerd[1452]: time="2025-09-09T23:53:21.331840920Z" 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\"}" Sep 9 23:53:21.331976 containerd[1452]: time="2025-09-09T23:53:21.331899880Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 23:53:21.331998 containerd[1452]: time="2025-09-09T23:53:21.331989560Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 23:53:21.332250 containerd[1452]: time="2025-09-09T23:53:21.332220800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 23:53:21.332274 containerd[1452]: time="2025-09-09T23:53:21.332259360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 23:53:21.332292 containerd[1452]: time="2025-09-09T23:53:21.332271480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 23:53:21.332292 containerd[1452]: time="2025-09-09T23:53:21.332281600Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 23:53:21.332329 containerd[1452]: time="2025-09-09T23:53:21.332294000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 23:53:21.332329 containerd[1452]: time="2025-09-09T23:53:21.332304760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 23:53:21.332329 containerd[1452]: time="2025-09-09T23:53:21.332316360Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 23:53:21.332382 containerd[1452]: time="2025-09-09T23:53:21.332341160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 23:53:21.332382 containerd[1452]: time="2025-09-09T23:53:21.332354640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 23:53:21.332382 containerd[1452]: time="2025-09-09T23:53:21.332366120Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 23:53:21.332447 containerd[1452]: time="2025-09-09T23:53:21.332437280Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 23:53:21.332465 containerd[1452]: time="2025-09-09T23:53:21.332453200Z" 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 Sep 9 23:53:21.332465 containerd[1452]: time="2025-09-09T23:53:21.332462320Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:53:21.332498 containerd[1452]: time="2025-09-09T23:53:21.332472120Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332480520Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332558320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332569800Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332652000Z" level=info msg="runtime interface created" Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332657320Z" level=info msg="created NRI interface" Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332665200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332677960Z" level=info msg="Connect containerd service" Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.332703240Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:53:21.333769 containerd[1452]: time="2025-09-09T23:53:21.333665720Z" 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" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409351720Z" level=info msg="Start subscribing containerd event" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409433480Z" level=info msg="Start recovering state" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409527040Z" level=info msg="Start event monitor" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409547960Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409556280Z" level=info msg="Start streaming server" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409564880Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409572040Z" level=info msg="runtime interface starting up..." Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409578120Z" level=info msg="starting plugins..." Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409591880Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409724000Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:53:21.409787 containerd[1452]: time="2025-09-09T23:53:21.409791600Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:53:21.411708 containerd[1452]: time="2025-09-09T23:53:21.409888640Z" level=info msg="containerd successfully booted in 0.099466s" Sep 9 23:53:21.409979 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:53:22.136739 sshd_keygen[1412]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 23:53:22.139916 systemd-networkd[1382]: eth0: Gained IPv6LL Sep 9 23:53:22.142734 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 9 23:53:22.144650 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 23:53:22.147337 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 9 23:53:22.149754 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 23:53:22.161042 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 23:53:22.166303 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 23:53:22.174889 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 23:53:22.176477 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 23:53:22.176677 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 23:53:22.178280 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 23:53:22.178476 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 9 23:53:22.182084 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 9 23:53:22.183529 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 23:53:22.206164 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 23:53:22.209116 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 23:53:22.211423 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 9 23:53:22.212967 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 23:53:22.214122 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 23:53:22.215658 systemd[1]: Startup finished in 2.018s (kernel) + 3.854s (initrd) + 2.810s (userspace) = 8.682s. Sep 9 23:53:28.890827 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 23:53:28.892375 systemd[1]: Started sshd@0-10.0.0.99:22-10.0.0.1:60326.service - OpenSSH per-connection server daemon (10.0.0.1:60326). Sep 9 23:53:28.979553 sshd[1538]: Accepted publickey for core from 10.0.0.1 port 60326 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:28.983196 sshd-session[1538]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:28.990543 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 23:53:28.991646 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 23:53:28.998850 systemd-logind[1393]: New session 1 of user core. Sep 9 23:53:29.012869 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 23:53:29.016023 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 23:53:29.044132 (systemd)[1543]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 23:53:29.047868 systemd-logind[1393]: New session c1 of user core. Sep 9 23:53:29.174901 systemd[1543]: Queued start job for default target default.target. Sep 9 23:53:29.192867 systemd[1543]: Created slice app.slice - User Application Slice. Sep 9 23:53:29.192896 systemd[1543]: Reached target paths.target - Paths. Sep 9 23:53:29.192933 systemd[1543]: Reached target timers.target - Timers. Sep 9 23:53:29.194187 systemd[1543]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 23:53:29.205689 systemd[1543]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 23:53:29.205815 systemd[1543]: Reached target sockets.target - Sockets. Sep 9 23:53:29.205860 systemd[1543]: Reached target basic.target - Basic System. Sep 9 23:53:29.205888 systemd[1543]: Reached target default.target - Main User Target. Sep 9 23:53:29.205913 systemd[1543]: Startup finished in 150ms. Sep 9 23:53:29.206068 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 23:53:29.207574 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 23:53:29.276417 systemd[1]: Started sshd@1-10.0.0.99:22-10.0.0.1:60340.service - OpenSSH per-connection server daemon (10.0.0.1:60340). Sep 9 23:53:29.325242 sshd[1554]: Accepted publickey for core from 10.0.0.1 port 60340 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:29.326539 sshd-session[1554]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:29.335148 systemd-logind[1393]: New session 2 of user core. Sep 9 23:53:29.361004 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 23:53:29.415821 sshd[1557]: Connection closed by 10.0.0.1 port 60340 Sep 9 23:53:29.416160 sshd-session[1554]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:29.427068 systemd[1]: sshd@1-10.0.0.99:22-10.0.0.1:60340.service: Deactivated successfully. Sep 9 23:53:29.428817 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 23:53:29.429496 systemd-logind[1393]: Session 2 logged out. Waiting for processes to exit. Sep 9 23:53:29.431374 systemd[1]: Started sshd@2-10.0.0.99:22-10.0.0.1:60346.service - OpenSSH per-connection server daemon (10.0.0.1:60346). Sep 9 23:53:29.432436 systemd-logind[1393]: Removed session 2. Sep 9 23:53:29.486693 sshd[1563]: Accepted publickey for core from 10.0.0.1 port 60346 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:29.488077 sshd-session[1563]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:29.492037 systemd-logind[1393]: New session 3 of user core. Sep 9 23:53:29.499953 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 23:53:29.548146 sshd[1566]: Connection closed by 10.0.0.1 port 60346 Sep 9 23:53:29.548488 sshd-session[1563]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:29.564855 systemd[1]: sshd@2-10.0.0.99:22-10.0.0.1:60346.service: Deactivated successfully. Sep 9 23:53:29.566353 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 23:53:29.567019 systemd-logind[1393]: Session 3 logged out. Waiting for processes to exit. Sep 9 23:53:29.569081 systemd[1]: Started sshd@3-10.0.0.99:22-10.0.0.1:60356.service - OpenSSH per-connection server daemon (10.0.0.1:60356). Sep 9 23:53:29.570141 systemd-logind[1393]: Removed session 3. Sep 9 23:53:29.623764 sshd[1572]: Accepted publickey for core from 10.0.0.1 port 60356 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:29.624987 sshd-session[1572]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:29.629058 systemd-logind[1393]: New session 4 of user core. Sep 9 23:53:29.639968 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 9 23:53:29.694323 sshd[1575]: Connection closed by 10.0.0.1 port 60356 Sep 9 23:53:29.694141 sshd-session[1572]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:29.708231 systemd[1]: sshd@3-10.0.0.99:22-10.0.0.1:60356.service: Deactivated successfully. Sep 9 23:53:29.710617 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 23:53:29.711725 systemd-logind[1393]: Session 4 logged out. Waiting for processes to exit. Sep 9 23:53:29.713838 systemd-logind[1393]: Removed session 4. Sep 9 23:53:29.715434 systemd[1]: Started sshd@4-10.0.0.99:22-10.0.0.1:60358.service - OpenSSH per-connection server daemon (10.0.0.1:60358). Sep 9 23:53:29.791289 sshd[1581]: Accepted publickey for core from 10.0.0.1 port 60358 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:29.792724 sshd-session[1581]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:29.798063 systemd-logind[1393]: New session 5 of user core. Sep 9 23:53:29.807959 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 23:53:29.864396 sudo[1585]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 23:53:29.864650 sudo[1585]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:53:29.876710 sudo[1585]: pam_unix(sudo:session): session closed for user root Sep 9 23:53:29.878138 sshd[1584]: Connection closed by 10.0.0.1 port 60358 Sep 9 23:53:29.878688 sshd-session[1581]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:29.891023 systemd[1]: sshd@4-10.0.0.99:22-10.0.0.1:60358.service: Deactivated successfully. Sep 9 23:53:29.894172 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 23:53:29.894914 systemd-logind[1393]: Session 5 logged out. Waiting for processes to exit. Sep 9 23:53:29.897187 systemd[1]: Started sshd@5-10.0.0.99:22-10.0.0.1:39938.service - OpenSSH per-connection server daemon (10.0.0.1:39938). Sep 9 23:53:29.898512 systemd-logind[1393]: Removed session 5. Sep 9 23:53:29.963099 sshd[1591]: Accepted publickey for core from 10.0.0.1 port 39938 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:29.964346 sshd-session[1591]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:29.968971 systemd-logind[1393]: New session 6 of user core. Sep 9 23:53:29.978968 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 23:53:30.032108 sudo[1596]: 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 Sep 9 23:53:30.032364 sudo[1596]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:53:30.037129 sudo[1596]: pam_unix(sudo:session): session closed for user root Sep 9 23:53:30.041717 sudo[1595]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 9 23:53:30.042013 sudo[1595]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:53:30.050497 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:53:30.089566 augenrules[1618]: No rules Sep 9 23:53:30.090699 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:53:30.090981 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:53:30.091945 sudo[1595]: pam_unix(sudo:session): session closed for user root Sep 9 23:53:30.093691 sshd[1594]: Connection closed by 10.0.0.1 port 39938 Sep 9 23:53:30.093612 sshd-session[1591]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:30.104709 systemd[1]: sshd@5-10.0.0.99:22-10.0.0.1:39938.service: Deactivated successfully. Sep 9 23:53:30.108051 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 23:53:30.108681 systemd-logind[1393]: Session 6 logged out. Waiting for processes to exit. Sep 9 23:53:30.110795 systemd[1]: Started sshd@6-10.0.0.99:22-10.0.0.1:39942.service - OpenSSH per-connection server daemon (10.0.0.1:39942). Sep 9 23:53:30.111674 systemd-logind[1393]: Removed session 6. Sep 9 23:53:30.168849 sshd[1627]: Accepted publickey for core from 10.0.0.1 port 39942 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:30.170085 sshd-session[1627]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:30.174416 systemd-logind[1393]: New session 7 of user core. Sep 9 23:53:30.181938 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 23:53:30.237207 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:53:30.263158 (dockerd)[1632]: 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 Sep 9 23:53:30.479589 dockerd[1632]: time="2025-09-09T23:53:30.479191006Z" level=info msg="Starting up" Sep 9 23:53:30.480546 dockerd[1632]: time="2025-09-09T23:53:30.480399935Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 9 23:53:30.493016 dockerd[1632]: time="2025-09-09T23:53:30.492879588Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 9 23:53:30.524894 systemd[1]: var-lib-docker-metacopy\x2dcheck2838799300-merged.mount: Deactivated successfully. Sep 9 23:53:30.546263 dockerd[1632]: time="2025-09-09T23:53:30.546202355Z" level=info msg="Loading containers: start." Sep 9 23:53:30.558790 kernel: Initializing XFRM netlink socket Sep 9 23:53:30.786691 systemd-networkd[1382]: docker0: Link UP Sep 9 23:53:30.792971 dockerd[1632]: time="2025-09-09T23:53:30.792917867Z" level=info msg="Loading containers: done." Sep 9 23:53:30.808018 dockerd[1632]: time="2025-09-09T23:53:30.807960169Z" 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 Sep 9 23:53:30.808169 dockerd[1632]: time="2025-09-09T23:53:30.808050414Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 9 23:53:30.808169 dockerd[1632]: time="2025-09-09T23:53:30.808137904Z" level=info msg="Initializing buildkit" Sep 9 23:53:30.839202 dockerd[1632]: time="2025-09-09T23:53:30.839160416Z" level=info msg="Completed buildkit initialization" Sep 9 23:53:30.844050 dockerd[1632]: time="2025-09-09T23:53:30.844010682Z" level=info msg="Daemon has completed initialization" Sep 9 23:53:30.844258 dockerd[1632]: time="2025-09-09T23:53:30.844068265Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:53:30.844341 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:53:30.852997 sshd[1630]: Connection closed by 10.0.0.1 port 39942 Sep 9 23:53:30.853363 sshd-session[1627]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:30.867934 systemd[1]: sshd@6-10.0.0.99:22-10.0.0.1:39942.service: Deactivated successfully. Sep 9 23:53:30.869713 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 23:53:30.872861 systemd-logind[1393]: Session 7 logged out. Waiting for processes to exit. Sep 9 23:53:30.874549 systemd[1]: Started sshd@7-10.0.0.99:22-10.0.0.1:39944.service - OpenSSH per-connection server daemon (10.0.0.1:39944). Sep 9 23:53:30.875383 systemd-logind[1393]: Removed session 7. Sep 9 23:53:30.931883 sshd[1845]: Accepted publickey for core from 10.0.0.1 port 39944 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:30.933222 sshd-session[1845]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:30.937480 systemd-logind[1393]: New session 8 of user core. Sep 9 23:53:30.950953 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 9 23:53:31.509399 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3042926640-merged.mount: Deactivated successfully. Sep 9 23:53:32.224496 containerd[1452]: time="2025-09-09T23:53:32.224389125Z" level=info msg="connecting to shim d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355" address="unix:///run/containerd/s/4194368c62479db2f8c1a97c90c95f8c884ab3197b8ac74c9c7b84f552abe183" namespace=moby protocol=ttrpc version=3 Sep 9 23:53:32.248223 systemd[1]: Started docker-d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355.scope - libcontainer container d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355. Sep 9 23:53:32.262321 systemd-resolved[1296]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:53:32.286030 kernel: docker0: port 1(veth7ea16e0) entered blocking state Sep 9 23:53:32.286122 kernel: docker0: port 1(veth7ea16e0) entered disabled state Sep 9 23:53:32.286140 kernel: veth7ea16e0: entered allmulticast mode Sep 9 23:53:32.287415 kernel: veth7ea16e0: entered promiscuous mode Sep 9 23:53:32.288097 systemd-networkd[1382]: veth7ea16e0: Link UP Sep 9 23:53:32.317780 kernel: eth0: renamed from vethdec28e7 Sep 9 23:53:32.319124 kernel: docker0: port 1(veth7ea16e0) entered blocking state Sep 9 23:53:32.319151 kernel: docker0: port 1(veth7ea16e0) entered forwarding state Sep 9 23:53:32.319226 systemd-networkd[1382]: veth7ea16e0: Gained carrier Sep 9 23:53:32.319567 systemd-networkd[1382]: docker0: Gained carrier Sep 9 23:53:32.409565 sshd[1848]: Connection closed by 10.0.0.1 port 39944 Sep 9 23:53:32.409883 sshd-session[1845]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:32.422282 systemd[1]: sshd@7-10.0.0.99:22-10.0.0.1:39944.service: Deactivated successfully. Sep 9 23:53:32.425207 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 23:53:32.425904 systemd-logind[1393]: Session 8 logged out. Waiting for processes to exit. Sep 9 23:53:32.428134 systemd[1]: Started sshd@8-10.0.0.99:22-10.0.0.1:39946.service - OpenSSH per-connection server daemon (10.0.0.1:39946). Sep 9 23:53:32.428600 systemd-logind[1393]: Removed session 8. Sep 9 23:53:32.490488 sshd[1921]: Accepted publickey for core from 10.0.0.1 port 39946 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:32.492141 sshd-session[1921]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:32.498981 systemd-logind[1393]: New session 9 of user core. Sep 9 23:53:32.511012 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 9 23:53:32.568398 sshd[1924]: Connection closed by 10.0.0.1 port 39946 Sep 9 23:53:32.568879 sshd-session[1921]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:32.586538 systemd[1]: sshd@8-10.0.0.99:22-10.0.0.1:39946.service: Deactivated successfully. Sep 9 23:53:32.588647 systemd[1]: session-9.scope: Deactivated successfully. Sep 9 23:53:32.589731 systemd-logind[1393]: Session 9 logged out. Waiting for processes to exit. Sep 9 23:53:32.592024 systemd[1]: Started sshd@9-10.0.0.99:22-10.0.0.1:39952.service - OpenSSH per-connection server daemon (10.0.0.1:39952). Sep 9 23:53:32.593328 systemd-logind[1393]: Removed session 9. Sep 9 23:53:32.645916 sshd[1930]: Accepted publickey for core from 10.0.0.1 port 39952 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:32.647720 sshd-session[1930]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:32.651374 systemd-logind[1393]: New session 10 of user core. Sep 9 23:53:32.662983 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 9 23:53:32.714600 sudo[1934]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1452 Sep 9 23:53:32.714885 sudo[1934]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:53:32.719802 sudo[1934]: pam_unix(sudo:session): session closed for user root Sep 9 23:53:32.720169 containerd[1452]: time="2025-09-09T23:53:32.719983921Z" level=info msg="Stop CRI service" Sep 9 23:53:32.720482 dockerd[1632]: time="2025-09-09T23:53:32.720422914Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 9 23:53:32.721071 dockerd[1632]: time="2025-09-09T23:53:32.720797024Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 23:53:32.721071 dockerd[1632]: time="2025-09-09T23:53:32.720636472Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 23:53:32.721071 dockerd[1632]: time="2025-09-09T23:53:32.720855806Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 23:53:32.721172 containerd[1452]: time="2025-09-09T23:53:32.720961292Z" level=info msg="Stop CRI service" Sep 9 23:53:32.721172 containerd[1452]: time="2025-09-09T23:53:32.721011268Z" level=info msg="Event monitor stopped" Sep 9 23:53:32.721172 containerd[1452]: time="2025-09-09T23:53:32.721032276Z" level=info msg="Stream server stopped" Sep 9 23:53:32.721228 sshd[1933]: Connection closed by 10.0.0.1 port 39952 Sep 9 23:53:32.722121 sshd-session[1930]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:32.734565 systemd[1]: containerd.service: Deactivated successfully. Sep 9 23:53:32.734676 systemd[1]: containerd.service: Unit process 1873 (containerd-shim) remains running after unit stopped. Sep 9 23:53:32.734936 systemd[1]: containerd.service: Consumed 299ms CPU time, 121.1M memory peak. Sep 9 23:53:32.735298 systemd[1]: sshd@9-10.0.0.99:22-10.0.0.1:39952.service: Deactivated successfully. Sep 9 23:53:32.736885 systemd[1]: session-10.scope: Deactivated successfully. Sep 9 23:53:32.738803 systemd-logind[1393]: Session 10 logged out. Waiting for processes to exit. Sep 9 23:53:32.740419 systemd[1]: Started sshd@10-10.0.0.99:22-10.0.0.1:39962.service - OpenSSH per-connection server daemon (10.0.0.1:39962). Sep 9 23:53:32.741643 systemd-logind[1393]: Removed session 10. Sep 9 23:53:32.801838 sshd[1941]: Accepted publickey for core from 10.0.0.1 port 39962 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:32.803199 sshd-session[1941]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:32.808995 systemd-logind[1393]: New session 11 of user core. Sep 9 23:53:32.815978 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 9 23:53:32.873679 sshd[1944]: Connection closed by 10.0.0.1 port 39962 Sep 9 23:53:32.873983 sshd-session[1941]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:32.877479 systemd[1]: sshd@10-10.0.0.99:22-10.0.0.1:39962.service: Deactivated successfully. Sep 9 23:53:32.880162 systemd[1]: session-11.scope: Deactivated successfully. Sep 9 23:53:32.882097 systemd-logind[1393]: Session 11 logged out. Waiting for processes to exit. Sep 9 23:53:32.883175 systemd-logind[1393]: Removed session 11. Sep 9 23:53:33.595994 systemd-networkd[1382]: veth7ea16e0: Gained IPv6LL Sep 9 23:53:34.044906 systemd-networkd[1382]: docker0: Gained IPv6LL Sep 9 23:53:37.985545 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 9 23:53:37.986100 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 23:53:37.987095 dockerd[1632]: time="2025-09-09T23:53:37.986944409Z" level=info msg="Processing signal 'terminated'" Sep 9 23:53:38.937409 systemd[1]: Started sshd@11-10.0.0.99:22-10.0.0.1:39974.service - OpenSSH per-connection server daemon (10.0.0.1:39974). Sep 9 23:53:39.015582 sshd[1950]: Accepted publickey for core from 10.0.0.1 port 39974 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:39.017090 sshd-session[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:39.024298 systemd-logind[1393]: New session 12 of user core. Sep 9 23:53:39.032989 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 9 23:53:39.088799 sshd[1953]: Connection closed by 10.0.0.1 port 39974 Sep 9 23:53:39.089134 sshd-session[1950]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:39.093612 systemd[1]: sshd@11-10.0.0.99:22-10.0.0.1:39974.service: Deactivated successfully. Sep 9 23:53:39.095611 systemd[1]: session-12.scope: Deactivated successfully. Sep 9 23:53:39.098070 systemd-logind[1393]: Session 12 logged out. Waiting for processes to exit. Sep 9 23:53:39.100217 systemd-logind[1393]: Removed session 12. Sep 9 23:53:45.124847 systemd[1]: Started sshd@12-10.0.0.99:22-10.0.0.1:56884.service - OpenSSH per-connection server daemon (10.0.0.1:56884). Sep 9 23:53:45.186820 sshd[1959]: Accepted publickey for core from 10.0.0.1 port 56884 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:45.188220 sshd-session[1959]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:45.198652 systemd-logind[1393]: New session 13 of user core. Sep 9 23:53:45.209661 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 9 23:53:45.268214 sshd[1962]: Connection closed by 10.0.0.1 port 56884 Sep 9 23:53:45.268516 sshd-session[1959]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:45.271909 systemd[1]: sshd@12-10.0.0.99:22-10.0.0.1:56884.service: Deactivated successfully. Sep 9 23:53:45.273910 systemd[1]: session-13.scope: Deactivated successfully. Sep 9 23:53:45.278413 systemd-logind[1393]: Session 13 logged out. Waiting for processes to exit. Sep 9 23:53:45.279893 systemd-logind[1393]: Removed session 13. Sep 9 23:53:51.295120 systemd[1]: Started sshd@13-10.0.0.99:22-10.0.0.1:46798.service - OpenSSH per-connection server daemon (10.0.0.1:46798). Sep 9 23:53:51.357562 sshd[1968]: Accepted publickey for core from 10.0.0.1 port 46798 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:51.360074 sshd-session[1968]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:51.365121 systemd-logind[1393]: New session 14 of user core. Sep 9 23:53:51.376995 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 9 23:53:51.440249 sshd[1971]: Connection closed by 10.0.0.1 port 46798 Sep 9 23:53:51.440783 sshd-session[1968]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:51.444398 systemd[1]: sshd@13-10.0.0.99:22-10.0.0.1:46798.service: Deactivated successfully. Sep 9 23:53:51.446694 systemd[1]: session-14.scope: Deactivated successfully. Sep 9 23:53:51.450835 systemd-logind[1393]: Session 14 logged out. Waiting for processes to exit. Sep 9 23:53:51.451919 systemd-logind[1393]: Removed session 14. Sep 9 23:53:52.988522 dockerd[1632]: time="2025-09-09T23:53:52.988466540Z" level=error msg="Force shutdown daemon" Sep 9 23:53:52.988918 dockerd[1632]: time="2025-09-09T23:53:52.988626251Z" level=info msg="Daemon shutdown complete" Sep 9 23:53:52.992562 systemd[1]: docker.service: Deactivated successfully. Sep 9 23:53:52.993851 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 23:53:52.993917 systemd[1]: docker.service: Consumed 1.036s CPU time, 122.5M memory peak. Sep 9 23:53:52.994299 systemd[1]: docker.socket: Deactivated successfully. Sep 9 23:53:52.994553 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 23:53:52.994592 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 23:53:52.995839 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:53:52.995995 systemd[1]: containerd.service: Found left-over process 1873 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:53:52.995998 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:53:53.001391 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:53:53.001647 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:53:53.017685 systemd[1]: containerd.service: Found left-over process 1873 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:53:53.017698 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:53:53.023501 (ntainerd)[1982]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:53:53.042093 containerd[1982]: time="2025-09-09T23:53:53Z" 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 Sep 9 23:53:53.044130 containerd[1982]: time="2025-09-09T23:53:53.044090638Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 9 23:53:53.056033 containerd[1982]: time="2025-09-09T23:53:53.055977002Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.086µs" Sep 9 23:53:53.056033 containerd[1982]: time="2025-09-09T23:53:53.056020869Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 23:53:53.056147 containerd[1982]: time="2025-09-09T23:53:53.056043803Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 23:53:53.056147 containerd[1982]: time="2025-09-09T23:53:53.056077944Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 23:53:53.056147 containerd[1982]: time="2025-09-09T23:53:53.056090151Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 23:53:53.056427 containerd[1982]: time="2025-09-09T23:53:53.056391614Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056456 containerd[1982]: time="2025-09-09T23:53:53.056433479Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056456 containerd[1982]: time="2025-09-09T23:53:53.056443565Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056674 containerd[1982]: time="2025-09-09T23:53:53.056645768Z" 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 Sep 9 23:53:53.056674 containerd[1982]: time="2025-09-09T23:53:53.056665780Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056719 containerd[1982]: time="2025-09-09T23:53:53.056676787Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056719 containerd[1982]: time="2025-09-09T23:53:53.056685112Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056719 containerd[1982]: time="2025-09-09T23:53:53.056704844Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056886 containerd[1982]: time="2025-09-09T23:53:53.056866862Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 23:53:53.056909 containerd[1982]: time="2025-09-09T23:53:53.056898721Z" 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 Sep 9 23:53:53.056929 containerd[1982]: time="2025-09-09T23:53:53.056908847Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 23:53:53.056996 containerd[1982]: time="2025-09-09T23:53:53.056979890Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 23:53:53.057363 containerd[1982]: time="2025-09-09T23:53:53.057343150Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 23:53:53.057402 containerd[1982]: time="2025-09-09T23:53:53.057376050Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:53:53.057729 containerd[1982]: time="2025-09-09T23:53:53.057685398Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 23:53:53.057854 containerd[1982]: time="2025-09-09T23:53:53.057833608Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 23:53:53.057887 containerd[1982]: time="2025-09-09T23:53:53.057855981Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 23:53:53.057949 containerd[1982]: time="2025-09-09T23:53:53.057930667Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 23:53:53.057980 containerd[1982]: time="2025-09-09T23:53:53.057953320Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 23:53:53.057980 containerd[1982]: time="2025-09-09T23:53:53.057968529Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 23:53:53.058018 containerd[1982]: time="2025-09-09T23:53:53.057979496Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 23:53:53.058018 containerd[1982]: time="2025-09-09T23:53:53.057991263Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 23:53:53.058018 containerd[1982]: time="2025-09-09T23:53:53.058001269Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 23:53:53.058018 containerd[1982]: time="2025-09-09T23:53:53.058010875Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 23:53:53.058136 containerd[1982]: time="2025-09-09T23:53:53.058020521Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 23:53:53.058136 containerd[1982]: time="2025-09-09T23:53:53.058032288Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 23:53:53.058374 containerd[1982]: time="2025-09-09T23:53:53.058348680Z" level=info msg="connecting to shim d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355" address="unix:///run/containerd/s/4194368c62479db2f8c1a97c90c95f8c884ab3197b8ac74c9c7b84f552abe183" namespace=moby protocol=ttrpc version=3 Sep 9 23:53:53.067068 containerd[1982]: time="2025-09-09T23:53:53.067037466Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 23:53:53.067186 containerd[1982]: time="2025-09-09T23:53:53.067082013Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 23:53:53.067211 containerd[1982]: time="2025-09-09T23:53:53.067194361Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 23:53:53.067258 containerd[1982]: time="2025-09-09T23:53:53.067211171Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 23:53:53.067258 containerd[1982]: time="2025-09-09T23:53:53.067235106Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 23:53:53.067258 containerd[1982]: time="2025-09-09T23:53:53.067245672Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 23:53:53.067353 containerd[1982]: time="2025-09-09T23:53:53.067260722Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 23:53:53.067353 containerd[1982]: time="2025-09-09T23:53:53.067272048Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 23:53:53.067353 containerd[1982]: time="2025-09-09T23:53:53.067294902Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 23:53:53.067353 containerd[1982]: time="2025-09-09T23:53:53.067310031Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 23:53:53.067353 containerd[1982]: time="2025-09-09T23:53:53.067320678Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 23:53:53.067485 containerd[1982]: time="2025-09-09T23:53:53.067378073Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 23:53:53.067485 containerd[1982]: time="2025-09-09T23:53:53.067394322Z" level=info msg="Start snapshots syncer" Sep 9 23:53:53.067485 containerd[1982]: time="2025-09-09T23:53:53.067422460Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 23:53:53.067659 containerd[1982]: time="2025-09-09T23:53:53.067624262Z" 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\"}" Sep 9 23:53:53.067843 containerd[1982]: time="2025-09-09T23:53:53.067815298Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 23:53:53.068255 containerd[1982]: time="2025-09-09T23:53:53.068158906Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 23:53:53.068308 containerd[1982]: time="2025-09-09T23:53:53.068248880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 23:53:53.068308 containerd[1982]: time="2025-09-09T23:53:53.068298671Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 23:53:53.068356 containerd[1982]: time="2025-09-09T23:53:53.068316642Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 23:53:53.068356 containerd[1982]: time="2025-09-09T23:53:53.068333252Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 23:53:53.068356 containerd[1982]: time="2025-09-09T23:53:53.068352703Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 23:53:53.068409 containerd[1982]: time="2025-09-09T23:53:53.068369954Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 23:53:53.068409 containerd[1982]: time="2025-09-09T23:53:53.068386164Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 23:53:53.068448 containerd[1982]: time="2025-09-09T23:53:53.068422025Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 23:53:53.068448 containerd[1982]: time="2025-09-09T23:53:53.068436394Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 23:53:53.068483 containerd[1982]: time="2025-09-09T23:53:53.068452204Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 23:53:53.068503 containerd[1982]: time="2025-09-09T23:53:53.068490627Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 23:53:53.068614 containerd[1982]: time="2025-09-09T23:53:53.068509278Z" 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 Sep 9 23:53:53.068688 containerd[1982]: time="2025-09-09T23:53:53.068609339Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:53:53.068688 containerd[1982]: time="2025-09-09T23:53:53.068672537Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:53:53.069018 containerd[1982]: time="2025-09-09T23:53:53.068687706Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069196055Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069225713Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069245484Z" level=info msg="runtime interface created" Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069250808Z" level=info msg="created NRI interface" Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069258893Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069272541Z" level=info msg="Connect containerd service" Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069314086Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:53:53.070017 containerd[1982]: time="2025-09-09T23:53:53.069834281Z" 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" Sep 9 23:53:53.079934 containerd[1982]: time="2025-09-09T23:53:53.079894179Z" level=info msg="Start subscribing containerd event" Sep 9 23:53:53.080047 containerd[1982]: time="2025-09-09T23:53:53.080034184Z" level=info msg="Start recovering state" Sep 9 23:53:53.080154 containerd[1982]: time="2025-09-09T23:53:53.080141729Z" level=info msg="Start event monitor" Sep 9 23:53:53.080310 containerd[1982]: time="2025-09-09T23:53:53.080282774Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:53:53.080385 containerd[1982]: time="2025-09-09T23:53:53.080372349Z" level=info msg="Start streaming server" Sep 9 23:53:53.080436 containerd[1982]: time="2025-09-09T23:53:53.080425381Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 23:53:53.080479 containerd[1982]: time="2025-09-09T23:53:53.080470128Z" level=info msg="runtime interface starting up..." Sep 9 23:53:53.080522 containerd[1982]: time="2025-09-09T23:53:53.080513434Z" level=info msg="starting plugins..." Sep 9 23:53:53.080569 containerd[1982]: time="2025-09-09T23:53:53.080560142Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 23:53:53.080686 containerd[1982]: time="2025-09-09T23:53:53.080255278Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:53:53.080798 containerd[1982]: time="2025-09-09T23:53:53.080783478Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:53:53.080906 containerd[1982]: time="2025-09-09T23:53:53.080895185Z" level=info msg="containerd successfully booted in 0.038987s" Sep 9 23:53:53.081043 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:53:53.083011 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:53:53.105238 (dockerd)[2010]: 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 Sep 9 23:53:53.132317 dockerd[2010]: time="2025-09-09T23:53:53.132243108Z" level=info msg="Starting up" Sep 9 23:53:53.132836 dockerd[2010]: time="2025-09-09T23:53:53.132809411Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 9 23:53:53.144334 dockerd[2010]: time="2025-09-09T23:53:53.144229933Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 9 23:53:53.158542 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport2145851874-merged.mount: Deactivated successfully. Sep 9 23:53:53.173088 dockerd[2010]: time="2025-09-09T23:53:53.173038594Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 23:53:53.181290 dockerd[2010]: time="2025-09-09T23:53:53.181229479Z" level=info msg="Loading containers: start." Sep 9 23:53:57.461887 systemd[1]: Started sshd@14-10.0.0.99:22-10.0.0.1:46808.service - OpenSSH per-connection server daemon (10.0.0.1:46808). Sep 9 23:53:57.528314 sshd[2041]: Accepted publickey for core from 10.0.0.1 port 46808 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:57.529633 sshd-session[2041]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:57.533688 systemd-logind[1393]: New session 15 of user core. Sep 9 23:53:57.544074 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 9 23:53:57.598800 sshd[2044]: Connection closed by 10.0.0.1 port 46808 Sep 9 23:53:57.599212 sshd-session[2041]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:57.616983 systemd[1]: sshd@14-10.0.0.99:22-10.0.0.1:46808.service: Deactivated successfully. Sep 9 23:53:57.618739 systemd[1]: session-15.scope: Deactivated successfully. Sep 9 23:53:57.621644 systemd-logind[1393]: Session 15 logged out. Waiting for processes to exit. Sep 9 23:53:57.623613 systemd[1]: Started sshd@15-10.0.0.99:22-10.0.0.1:46812.service - OpenSSH per-connection server daemon (10.0.0.1:46812). Sep 9 23:53:57.624708 systemd-logind[1393]: Removed session 15. Sep 9 23:53:57.680288 sshd[2050]: Accepted publickey for core from 10.0.0.1 port 46812 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:57.681675 sshd-session[2050]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:57.686522 systemd-logind[1393]: New session 16 of user core. Sep 9 23:53:57.698959 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 9 23:53:57.754689 sshd[2054]: Connection closed by 10.0.0.1 port 46812 Sep 9 23:53:57.754983 sshd-session[2050]: pam_unix(sshd:session): session closed for user core Sep 9 23:53:57.770958 systemd[1]: sshd@15-10.0.0.99:22-10.0.0.1:46812.service: Deactivated successfully. Sep 9 23:53:57.774086 systemd[1]: session-16.scope: Deactivated successfully. Sep 9 23:53:57.774824 systemd-logind[1393]: Session 16 logged out. Waiting for processes to exit. Sep 9 23:53:57.776688 systemd[1]: Started sshd@16-10.0.0.99:22-10.0.0.1:46824.service - OpenSSH per-connection server daemon (10.0.0.1:46824). Sep 9 23:53:57.777459 systemd-logind[1393]: Removed session 16. Sep 9 23:53:57.837563 sshd[2060]: Accepted publickey for core from 10.0.0.1 port 46824 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:53:57.838940 sshd-session[2060]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:53:57.844678 systemd-logind[1393]: New session 17 of user core. Sep 9 23:53:57.861962 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 9 23:54:03.207902 dockerd[2010]: time="2025-09-09T23:54:03.207831266Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355 Sep 9 23:54:03.219869 systemd[1]: docker-d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355.scope: Deactivated successfully. Sep 9 23:54:03.240845 dockerd[2010]: time="2025-09-09T23:54:03.240702816Z" level=info msg="ignoring event" container=d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 9 23:54:03.241939 containerd[1982]: time="2025-09-09T23:54:03.241903689Z" level=info msg="shim disconnected" id=d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355 namespace=moby Sep 9 23:54:03.243000 containerd[1982]: time="2025-09-09T23:54:03.242818759Z" level=warning msg="cleaning up after shim disconnected" id=d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355 namespace=moby Sep 9 23:54:03.243000 containerd[1982]: time="2025-09-09T23:54:03.242864859Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 23:54:03.261007 systemd[1]: var-lib-docker-overlay2-20bf5ccdac4f93415a1446be085af20322a5abda5ecbc066446ebea0da267636-merged.mount: Deactivated successfully. Sep 9 23:54:03.766882 systemd[1]: run-docker-netns-2ec5b20ac2aa.mount: Deactivated successfully. Sep 9 23:54:03.768271 systemd-networkd[1382]: veth7ea16e0: Link DOWN Sep 9 23:54:03.768277 systemd-networkd[1382]: veth7ea16e0: Lost carrier Sep 9 23:54:03.769798 kernel: docker0: port 1(veth7ea16e0) entered disabled state Sep 9 23:54:03.771830 kernel: veth7ea16e0 (unregistering): left allmulticast mode Sep 9 23:54:03.771888 kernel: veth7ea16e0 (unregistering): left promiscuous mode Sep 9 23:54:03.771905 kernel: docker0: port 1(veth7ea16e0) entered disabled state Sep 9 23:54:03.773821 systemd-networkd[1382]: docker0: Lost carrier Sep 9 23:54:03.775417 dockerd[2010]: time="2025-09-09T23:54:03.775377951Z" level=info msg="Removing stale sandbox 2ec5b20ac2aa90e618089534aad9f725a3d087194dd9e1ef784981900c363fe6 (d018bd9cb01e039b76cd31f14808b9ab4cc4cf73f9e6ee093927bab553ed7355)" Sep 9 23:54:03.780467 dockerd[2010]: time="2025-09-09T23:54:03.780414500Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 9 23:54:03.780467 dockerd[2010]: time="2025-09-09T23:54:03.780467603Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint d7f2bb2f8228e2c4a5d73e08f2c068a22a1063c17ee04c8cda47307c462f1e2b 7238da218f742f646ecfec0cb4cce62c343a628907654074ca2d443b3b745e35], retrying...." Sep 9 23:54:03.783683 systemd[1]: run-docker-netns-2ec5b20ac2aa.mount: Deactivated successfully. Sep 9 23:54:03.983488 dockerd[2010]: time="2025-09-09T23:54:03.983421229Z" level=warning msg="error locating sandbox id 2ec5b20ac2aa90e618089534aad9f725a3d087194dd9e1ef784981900c363fe6: sandbox 2ec5b20ac2aa90e618089534aad9f725a3d087194dd9e1ef784981900c363fe6 not found" Sep 9 23:54:03.984205 dockerd[2010]: time="2025-09-09T23:54:03.983662652Z" level=info msg="Loading containers: done." Sep 9 23:54:04.003853 dockerd[2010]: time="2025-09-09T23:54:04.003786216Z" 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 Sep 9 23:54:04.004037 dockerd[2010]: time="2025-09-09T23:54:04.003920470Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 9 23:54:04.004037 dockerd[2010]: time="2025-09-09T23:54:04.003958606Z" level=info msg="Initializing buildkit" Sep 9 23:54:04.019982 dockerd[2010]: time="2025-09-09T23:54:04.019871691Z" level=info msg="Completed buildkit initialization" Sep 9 23:54:04.026986 dockerd[2010]: time="2025-09-09T23:54:04.026916184Z" level=info msg="Daemon has completed initialization" Sep 9 23:54:04.027107 dockerd[2010]: time="2025-09-09T23:54:04.027068846Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:54:04.027241 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:54:04.043446 sshd[2063]: Connection closed by 10.0.0.1 port 46824 Sep 9 23:54:04.043931 sshd-session[2060]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:04.057158 systemd[1]: sshd@16-10.0.0.99:22-10.0.0.1:46824.service: Deactivated successfully. Sep 9 23:54:04.058993 systemd[1]: session-17.scope: Deactivated successfully. Sep 9 23:54:04.060181 systemd-logind[1393]: Session 17 logged out. Waiting for processes to exit. Sep 9 23:54:04.063575 systemd[1]: Started sshd@17-10.0.0.99:22-10.0.0.1:46850.service - OpenSSH per-connection server daemon (10.0.0.1:46850). Sep 9 23:54:04.064257 systemd-logind[1393]: Removed session 17. Sep 9 23:54:04.115966 sshd[2316]: Accepted publickey for core from 10.0.0.1 port 46850 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:04.117707 sshd-session[2316]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:04.122677 systemd-logind[1393]: New session 18 of user core. Sep 9 23:54:04.135967 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 9 23:54:04.252419 containerd[1982]: time="2025-09-09T23:54:04.251087821Z" level=info msg="connecting to shim 8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d" address="unix:///run/containerd/s/fe611cc8009fb7182b7fd0ec86d2bfa653d24e38283c23dd02309eda7cd313e8" namespace=moby protocol=ttrpc version=3 Sep 9 23:54:04.286974 systemd[1]: Started docker-8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d.scope - libcontainer container 8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d. Sep 9 23:54:04.297455 systemd-resolved[1296]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:54:04.313309 kernel: docker0: port 1(veth1221db0) entered blocking state Sep 9 23:54:04.313401 kernel: docker0: port 1(veth1221db0) entered disabled state Sep 9 23:54:04.313942 kernel: veth1221db0: entered allmulticast mode Sep 9 23:54:04.314758 kernel: veth1221db0: entered promiscuous mode Sep 9 23:54:04.315365 systemd-networkd[1382]: veth1221db0: Link UP Sep 9 23:54:04.322786 kernel: eth0: renamed from veth7f8dc61 Sep 9 23:54:04.324931 kernel: docker0: port 1(veth1221db0) entered blocking state Sep 9 23:54:04.325085 kernel: docker0: port 1(veth1221db0) entered forwarding state Sep 9 23:54:04.325056 systemd-networkd[1382]: veth1221db0: Gained carrier Sep 9 23:54:04.326225 systemd-networkd[1382]: docker0: Gained carrier Sep 9 23:54:04.347700 sshd[2319]: Connection closed by 10.0.0.1 port 46850 Sep 9 23:54:04.348652 sshd-session[2316]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:04.358147 systemd[1]: sshd@17-10.0.0.99:22-10.0.0.1:46850.service: Deactivated successfully. Sep 9 23:54:04.360253 systemd[1]: session-18.scope: Deactivated successfully. Sep 9 23:54:04.361479 systemd-logind[1393]: Session 18 logged out. Waiting for processes to exit. Sep 9 23:54:04.364407 systemd[1]: Started sshd@18-10.0.0.99:22-10.0.0.1:46860.service - OpenSSH per-connection server daemon (10.0.0.1:46860). Sep 9 23:54:04.367153 systemd-logind[1393]: Removed session 18. Sep 9 23:54:04.422561 sshd[2387]: Accepted publickey for core from 10.0.0.1 port 46860 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:04.425911 sshd-session[2387]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:04.430294 systemd-logind[1393]: New session 19 of user core. Sep 9 23:54:04.441935 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 9 23:54:04.496422 sshd[2390]: Connection closed by 10.0.0.1 port 46860 Sep 9 23:54:04.496926 sshd-session[2387]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:04.509465 systemd[1]: sshd@18-10.0.0.99:22-10.0.0.1:46860.service: Deactivated successfully. Sep 9 23:54:04.513328 systemd[1]: session-19.scope: Deactivated successfully. Sep 9 23:54:04.514030 systemd-logind[1393]: Session 19 logged out. Waiting for processes to exit. Sep 9 23:54:04.516325 systemd[1]: Started sshd@19-10.0.0.99:22-10.0.0.1:46864.service - OpenSSH per-connection server daemon (10.0.0.1:46864). Sep 9 23:54:04.516989 systemd-logind[1393]: Removed session 19. Sep 9 23:54:04.567716 sshd[2396]: Accepted publickey for core from 10.0.0.1 port 46864 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:04.568475 sshd-session[2396]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:04.572904 systemd-logind[1393]: New session 20 of user core. Sep 9 23:54:04.586909 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 9 23:54:04.637547 sudo[2400]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1982 Sep 9 23:54:04.638177 sudo[2400]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:54:04.641129 sudo[2400]: pam_unix(sudo:session): session closed for user root Sep 9 23:54:04.643293 dockerd[2010]: time="2025-09-09T23:54:04.643188434Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 23:54:04.643293 dockerd[2010]: time="2025-09-09T23:54:04.643225169Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 23:54:04.643571 dockerd[2010]: time="2025-09-09T23:54:04.643206001Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 9 23:54:04.643571 dockerd[2010]: time="2025-09-09T23:54:04.643356382Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 23:54:04.644653 sshd[2399]: Connection closed by 10.0.0.1 port 46864 Sep 9 23:54:04.644490 systemd[1]: containerd.service: Deactivated successfully. Sep 9 23:54:04.644466 sshd-session[2396]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:04.644601 systemd[1]: containerd.service: Unit process 2338 (containerd-shim) remains running after unit stopped. Sep 9 23:54:04.645112 systemd[1]: containerd.service: Consumed 193ms CPU time, 121.3M memory peak. Sep 9 23:54:04.655732 systemd[1]: sshd@19-10.0.0.99:22-10.0.0.1:46864.service: Deactivated successfully. Sep 9 23:54:04.657471 systemd[1]: session-20.scope: Deactivated successfully. Sep 9 23:54:04.659334 systemd-logind[1393]: Session 20 logged out. Waiting for processes to exit. Sep 9 23:54:04.661567 systemd[1]: Started sshd@20-10.0.0.99:22-10.0.0.1:46866.service - OpenSSH per-connection server daemon (10.0.0.1:46866). Sep 9 23:54:04.662489 systemd-logind[1393]: Removed session 20. Sep 9 23:54:04.715491 sshd[2407]: Accepted publickey for core from 10.0.0.1 port 46866 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:04.717447 sshd-session[2407]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:04.721665 systemd-logind[1393]: New session 21 of user core. Sep 9 23:54:04.726928 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 9 23:54:04.779803 sshd[2410]: Connection closed by 10.0.0.1 port 46866 Sep 9 23:54:04.780260 sshd-session[2407]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:04.783534 systemd[1]: sshd@20-10.0.0.99:22-10.0.0.1:46866.service: Deactivated successfully. Sep 9 23:54:04.785103 systemd[1]: session-21.scope: Deactivated successfully. Sep 9 23:54:04.785769 systemd-logind[1393]: Session 21 logged out. Waiting for processes to exit. Sep 9 23:54:04.786651 systemd-logind[1393]: Removed session 21. Sep 9 23:54:05.851996 systemd-networkd[1382]: veth1221db0: Gained IPv6LL Sep 9 23:54:06.534763 update_engine[1394]: I20250909 23:54:06.534642 1394 update_attempter.cc:509] Updating boot flags... Sep 9 23:54:09.683516 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 9 23:54:09.683878 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 23:54:09.684150 dockerd[2010]: time="2025-09-09T23:54:09.684070482Z" level=info msg="Processing signal 'terminated'" Sep 9 23:54:10.799730 systemd[1]: Started sshd@21-10.0.0.99:22-10.0.0.1:39310.service - OpenSSH per-connection server daemon (10.0.0.1:39310). Sep 9 23:54:10.870472 sshd[2425]: Accepted publickey for core from 10.0.0.1 port 39310 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:10.871785 sshd-session[2425]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:10.878149 systemd-logind[1393]: New session 22 of user core. Sep 9 23:54:10.886992 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 9 23:54:10.945766 sshd[2428]: Connection closed by 10.0.0.1 port 39310 Sep 9 23:54:10.946222 sshd-session[2425]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:10.949399 systemd[1]: sshd@21-10.0.0.99:22-10.0.0.1:39310.service: Deactivated successfully. Sep 9 23:54:10.952879 systemd[1]: session-22.scope: Deactivated successfully. Sep 9 23:54:10.953687 systemd-logind[1393]: Session 22 logged out. Waiting for processes to exit. Sep 9 23:54:10.954865 systemd-logind[1393]: Removed session 22. Sep 9 23:54:11.684778 dockerd[2010]: time="2025-09-09T23:54:11.684660875Z" level=error msg="Error sending stop (signal 15) to container" container=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d error="Cannot kill container 8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 9 23:54:11.684778 dockerd[2010]: time="2025-09-09T23:54:11.684767346Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d Sep 9 23:54:16.971198 systemd[1]: Started sshd@22-10.0.0.99:22-10.0.0.1:39318.service - OpenSSH per-connection server daemon (10.0.0.1:39318). Sep 9 23:54:17.053923 sshd[2434]: Accepted publickey for core from 10.0.0.1 port 39318 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:17.058441 sshd-session[2434]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:17.066709 systemd-logind[1393]: New session 23 of user core. Sep 9 23:54:17.076440 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 9 23:54:17.138716 sshd[2437]: Connection closed by 10.0.0.1 port 39318 Sep 9 23:54:17.139176 sshd-session[2434]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:17.144208 systemd[1]: sshd@22-10.0.0.99:22-10.0.0.1:39318.service: Deactivated successfully. Sep 9 23:54:17.146702 systemd[1]: session-23.scope: Deactivated successfully. Sep 9 23:54:17.149113 systemd-logind[1393]: Session 23 logged out. Waiting for processes to exit. Sep 9 23:54:17.151824 systemd-logind[1393]: Removed session 23. Sep 9 23:54:21.686177 dockerd[2010]: time="2025-09-09T23:54:21.685911769Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d error="context deadline exceeded" Sep 9 23:54:21.687762 systemd[1]: docker-8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d.scope: Deactivated successfully. Sep 9 23:54:23.165996 systemd[1]: Started sshd@23-10.0.0.99:22-10.0.0.1:32918.service - OpenSSH per-connection server daemon (10.0.0.1:32918). Sep 9 23:54:23.229407 sshd[2443]: Accepted publickey for core from 10.0.0.1 port 32918 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:23.233343 sshd-session[2443]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:23.240196 systemd-logind[1393]: New session 24 of user core. Sep 9 23:54:23.262258 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 9 23:54:23.321856 sshd[2446]: Connection closed by 10.0.0.1 port 32918 Sep 9 23:54:23.322249 sshd-session[2443]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:23.327254 systemd[1]: sshd@23-10.0.0.99:22-10.0.0.1:32918.service: Deactivated successfully. Sep 9 23:54:23.331189 systemd[1]: session-24.scope: Deactivated successfully. Sep 9 23:54:23.332102 systemd-logind[1393]: Session 24 logged out. Waiting for processes to exit. Sep 9 23:54:23.333490 systemd-logind[1393]: Removed session 24. Sep 9 23:54:24.691013 dockerd[2010]: time="2025-09-09T23:54:24.690913936Z" level=error msg="Force shutdown daemon" Sep 9 23:54:24.691485 dockerd[2010]: time="2025-09-09T23:54:24.691433183Z" level=info msg="Daemon shutdown complete" Sep 9 23:54:24.691636 dockerd[2010]: time="2025-09-09T23:54:24.691611453Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 9 23:54:24.695870 systemd[1]: docker.service: Deactivated successfully. Sep 9 23:54:24.696185 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 23:54:24.696691 systemd[1]: docker.socket: Deactivated successfully. Sep 9 23:54:24.696981 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 23:54:24.697021 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 23:54:24.698259 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:54:24.698425 systemd[1]: containerd.service: Found left-over process 2338 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:54:24.698427 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:54:24.707034 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:54:24.707314 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:54:24.722725 systemd[1]: containerd.service: Found left-over process 2338 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:54:24.722737 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:54:24.730876 (ntainerd)[2457]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:54:24.753161 containerd[2457]: time="2025-09-09T23:54:24Z" 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 Sep 9 23:54:24.753988 containerd[2457]: time="2025-09-09T23:54:24.753935841Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 9 23:54:24.763484 containerd[2457]: time="2025-09-09T23:54:24.763437157Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.521µs" Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763600024Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763631230Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763664315Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763676317Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763894634Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763931360Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.763942562Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.764159118Z" 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 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.764173441Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.764255895Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.764268217Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764576 containerd[2457]: time="2025-09-09T23:54:24.764325546Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764947 containerd[2457]: time="2025-09-09T23:54:24.764418162Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 9 23:54:24.764947 containerd[2457]: time="2025-09-09T23:54:24.764441446Z" 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 Sep 9 23:54:24.764947 containerd[2457]: time="2025-09-09T23:54:24.764451648Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 9 23:54:24.764947 containerd[2457]: time="2025-09-09T23:54:24.764489974Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 9 23:54:24.765540 containerd[2457]: time="2025-09-09T23:54:24.765055829Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 9 23:54:24.765646 containerd[2457]: time="2025-09-09T23:54:24.765549112Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:54:24.765761 containerd[2457]: time="2025-09-09T23:54:24.765710699Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 9 23:54:24.765788 containerd[2457]: time="2025-09-09T23:54:24.765768789Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 9 23:54:24.765788 containerd[2457]: time="2025-09-09T23:54:24.765784551Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765797314Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765811476Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765828679Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765852363Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765865365Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765876447Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 9 23:54:24.765886 containerd[2457]: time="2025-09-09T23:54:24.765886609Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 9 23:54:24.766005 containerd[2457]: time="2025-09-09T23:54:24.765898371Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 9 23:54:24.766005 containerd[2457]: time="2025-09-09T23:54:24.765912413Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 9 23:54:24.766152 containerd[2457]: time="2025-09-09T23:54:24.766130770Z" level=info msg="connecting to shim 8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d" address="unix:///run/containerd/s/fe611cc8009fb7182b7fd0ec86d2bfa653d24e38283c23dd02309eda7cd313e8" namespace=moby protocol=ttrpc version=3 Sep 9 23:54:24.773159 containerd[2457]: time="2025-09-09T23:54:24.773111822Z" level=info msg="cleaning leaked shim process" id=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d namespace=moby Sep 9 23:54:24.788284 containerd[2457]: time="2025-09-09T23:54:24.788190835Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 9 23:54:24.788828 containerd[2457]: time="2025-09-09T23:54:24.788773893Z" level=info msg="shim disconnected" id=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d namespace=moby Sep 9 23:54:24.788902 containerd[2457]: time="2025-09-09T23:54:24.788804938Z" level=warning msg="cleaning up after shim disconnected" id=8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d namespace=moby Sep 9 23:54:24.788902 containerd[2457]: time="2025-09-09T23:54:24.788855306Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 23:54:24.803357 containerd[2457]: time="2025-09-09T23:54:24.803296932Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 9 23:54:24.803357 containerd[2457]: time="2025-09-09T23:54:24.803359102Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 9 23:54:24.803502 containerd[2457]: time="2025-09-09T23:54:24.803401270Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 9 23:54:24.803502 containerd[2457]: time="2025-09-09T23:54:24.803420553Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 9 23:54:24.803502 containerd[2457]: time="2025-09-09T23:54:24.803437436Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 9 23:54:24.803502 containerd[2457]: time="2025-09-09T23:54:24.803449678Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 9 23:54:24.803502 containerd[2457]: time="2025-09-09T23:54:24.803473682Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 9 23:54:24.803588 containerd[2457]: time="2025-09-09T23:54:24.803491125Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 9 23:54:24.803588 containerd[2457]: time="2025-09-09T23:54:24.803576779Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 9 23:54:24.803624 containerd[2457]: time="2025-09-09T23:54:24.803595862Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 9 23:54:24.803624 containerd[2457]: time="2025-09-09T23:54:24.803610945Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 9 23:54:24.803958 containerd[2457]: time="2025-09-09T23:54:24.803931439Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 9 23:54:24.804026 containerd[2457]: time="2025-09-09T23:54:24.803974126Z" level=info msg="Start snapshots syncer" Sep 9 23:54:24.804026 containerd[2457]: time="2025-09-09T23:54:24.804006371Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 9 23:54:24.804332 containerd[2457]: time="2025-09-09T23:54:24.804293139Z" 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\"}" Sep 9 23:54:24.804420 containerd[2457]: time="2025-09-09T23:54:24.804351549Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 9 23:54:24.804474 containerd[2457]: time="2025-09-09T23:54:24.804451286Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 9 23:54:24.804524 containerd[2457]: time="2025-09-09T23:54:24.804503815Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 9 23:54:24.804557 containerd[2457]: time="2025-09-09T23:54:24.804539021Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 9 23:54:24.804557 containerd[2457]: time="2025-09-09T23:54:24.804552263Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 9 23:54:24.804593 containerd[2457]: time="2025-09-09T23:54:24.804562545Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 9 23:54:24.804593 containerd[2457]: time="2025-09-09T23:54:24.804575587Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 9 23:54:24.804593 containerd[2457]: time="2025-09-09T23:54:24.804586309Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 9 23:54:24.804642 containerd[2457]: time="2025-09-09T23:54:24.804605952Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 9 23:54:24.804642 containerd[2457]: time="2025-09-09T23:54:24.804633276Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 9 23:54:24.804688 containerd[2457]: time="2025-09-09T23:54:24.804652320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 9 23:54:24.804688 containerd[2457]: time="2025-09-09T23:54:24.804664122Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 9 23:54:24.804729 containerd[2457]: time="2025-09-09T23:54:24.804699488Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 9 23:54:24.804729 containerd[2457]: time="2025-09-09T23:54:24.804715450Z" 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 Sep 9 23:54:24.804729 containerd[2457]: time="2025-09-09T23:54:24.804725212Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:54:24.804801 containerd[2457]: time="2025-09-09T23:54:24.804734854Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 9 23:54:24.804801 containerd[2457]: time="2025-09-09T23:54:24.804743735Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 9 23:54:24.804801 containerd[2457]: time="2025-09-09T23:54:24.804796984Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 9 23:54:24.804878 containerd[2457]: time="2025-09-09T23:54:24.804809426Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 9 23:54:24.804878 containerd[2457]: time="2025-09-09T23:54:24.804828269Z" level=info msg="runtime interface created" Sep 9 23:54:24.804878 containerd[2457]: time="2025-09-09T23:54:24.804833750Z" level=info msg="created NRI interface" Sep 9 23:54:24.804878 containerd[2457]: time="2025-09-09T23:54:24.804851473Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 9 23:54:24.804878 containerd[2457]: time="2025-09-09T23:54:24.804877798Z" level=info msg="Connect containerd service" Sep 9 23:54:24.804973 containerd[2457]: time="2025-09-09T23:54:24.804920685Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:54:24.805509 containerd[2457]: time="2025-09-09T23:54:24.805467016Z" 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" Sep 9 23:54:24.815497 containerd[2457]: time="2025-09-09T23:54:24.815424569Z" level=info msg="Start subscribing containerd event" Sep 9 23:54:24.815497 containerd[2457]: time="2025-09-09T23:54:24.815496741Z" level=info msg="Start recovering state" Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815532427Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815581155Z" level=info msg="Start event monitor" Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815597438Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815607040Z" level=info msg="Start streaming server" Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815580755Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:54:24.815638 containerd[2457]: time="2025-09-09T23:54:24.815617761Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 9 23:54:24.815826 containerd[2457]: time="2025-09-09T23:54:24.815644166Z" level=info msg="runtime interface starting up..." Sep 9 23:54:24.815826 containerd[2457]: time="2025-09-09T23:54:24.815649767Z" level=info msg="starting plugins..." Sep 9 23:54:24.815826 containerd[2457]: time="2025-09-09T23:54:24.815658968Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 9 23:54:24.815826 containerd[2457]: time="2025-09-09T23:54:24.815770187Z" level=info msg="containerd successfully booted in 0.063252s" Sep 9 23:54:24.815902 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:54:24.817607 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:54:24.835135 (dockerd)[2505]: 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 Sep 9 23:54:24.864403 dockerd[2505]: time="2025-09-09T23:54:24.864344466Z" level=info msg="Starting up" Sep 9 23:54:24.864960 dockerd[2505]: time="2025-09-09T23:54:24.864934725Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 9 23:54:24.874766 dockerd[2505]: time="2025-09-09T23:54:24.874668240Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 9 23:54:24.897999 dockerd[2505]: time="2025-09-09T23:54:24.897929427Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 23:54:24.906461 dockerd[2505]: time="2025-09-09T23:54:24.906391048Z" level=info msg="Loading containers: start." Sep 9 23:54:24.922475 systemd[1]: var-lib-docker-overlay2-0a6f27bf3c726ce860a6b8816d0c9183a25618d93486e58fcd54188fd0092058-merged.mount: Deactivated successfully. Sep 9 23:54:25.357483 systemd-networkd[1382]: veth1221db0: Link DOWN Sep 9 23:54:25.357489 systemd-networkd[1382]: veth1221db0: Lost carrier Sep 9 23:54:25.359355 kernel: docker0: port 1(veth1221db0) entered disabled state Sep 9 23:54:25.359411 kernel: veth1221db0 (unregistering): left allmulticast mode Sep 9 23:54:25.360067 kernel: veth1221db0 (unregistering): left promiscuous mode Sep 9 23:54:25.360098 kernel: docker0: port 1(veth1221db0) entered disabled state Sep 9 23:54:25.362828 systemd-networkd[1382]: docker0: Lost carrier Sep 9 23:54:25.364167 dockerd[2505]: time="2025-09-09T23:54:25.364106403Z" level=info msg="Removing stale sandbox bc5fa285cd68807bdfd432e17e94f74492580d92eba6bf4947228d7cc82405dc (8a3aba0a3577070cfacf047ae7ca8131643f1cb1951bf6968c9d0f2550035a3d)" Sep 9 23:54:25.371235 dockerd[2505]: time="2025-09-09T23:54:25.371160708Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 9 23:54:25.371235 dockerd[2505]: time="2025-09-09T23:54:25.371221478Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 8c3e962aca8b3c769e9fdf59376a9b65d49f31c2d4d46aa983732e0ff4369950 94ae8b11a6e08846ed837ad5bb7cc9aa31815bfbe52c7301a823c42eb4fa971f], retrying...." Sep 9 23:54:25.597108 dockerd[2505]: time="2025-09-09T23:54:25.596989848Z" level=warning msg="error locating sandbox id bc5fa285cd68807bdfd432e17e94f74492580d92eba6bf4947228d7cc82405dc: sandbox bc5fa285cd68807bdfd432e17e94f74492580d92eba6bf4947228d7cc82405dc not found" Sep 9 23:54:25.597108 dockerd[2505]: time="2025-09-09T23:54:25.597037176Z" level=warning msg="error locating sandbox id 2ec5b20ac2aa90e618089534aad9f725a3d087194dd9e1ef784981900c363fe6: sandbox 2ec5b20ac2aa90e618089534aad9f725a3d087194dd9e1ef784981900c363fe6 not found" Sep 9 23:54:25.597246 dockerd[2505]: time="2025-09-09T23:54:25.597134272Z" level=info msg="Loading containers: done." Sep 9 23:54:25.626193 dockerd[2505]: time="2025-09-09T23:54:25.626024042Z" 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 Sep 9 23:54:25.626865 dockerd[2505]: time="2025-09-09T23:54:25.626608737Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 9 23:54:25.626865 dockerd[2505]: time="2025-09-09T23:54:25.626700832Z" level=info msg="Initializing buildkit" Sep 9 23:54:25.653086 dockerd[2505]: time="2025-09-09T23:54:25.652995660Z" level=info msg="Completed buildkit initialization" Sep 9 23:54:25.661127 dockerd[2505]: time="2025-09-09T23:54:25.661032525Z" level=info msg="Daemon has completed initialization" Sep 9 23:54:25.661338 dockerd[2505]: time="2025-09-09T23:54:25.661299128Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:54:25.661379 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:54:25.882623 systemd[1]: run-docker-netns-bc5fa285cd68.mount: Deactivated successfully. Sep 9 23:54:29.345913 systemd[1]: Started sshd@24-10.0.0.99:22-10.0.0.1:32936.service - OpenSSH per-connection server daemon (10.0.0.1:32936). Sep 9 23:54:29.405329 sshd[2741]: Accepted publickey for core from 10.0.0.1 port 32936 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:29.407026 sshd-session[2741]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:29.412278 systemd-logind[1393]: New session 25 of user core. Sep 9 23:54:29.429314 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 9 23:54:29.491717 sshd[2744]: Connection closed by 10.0.0.1 port 32936 Sep 9 23:54:29.492204 sshd-session[2741]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:29.500778 systemd[1]: sshd@24-10.0.0.99:22-10.0.0.1:32936.service: Deactivated successfully. Sep 9 23:54:29.504365 systemd[1]: session-25.scope: Deactivated successfully. Sep 9 23:54:29.505284 systemd-logind[1393]: Session 25 logged out. Waiting for processes to exit. Sep 9 23:54:29.507626 systemd[1]: Started sshd@25-10.0.0.99:22-10.0.0.1:32950.service - OpenSSH per-connection server daemon (10.0.0.1:32950). Sep 9 23:54:29.508695 systemd-logind[1393]: Removed session 25. Sep 9 23:54:29.569492 sshd[2750]: Accepted publickey for core from 10.0.0.1 port 32950 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:29.571011 sshd-session[2750]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:29.576795 systemd-logind[1393]: New session 26 of user core. Sep 9 23:54:29.592992 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 9 23:54:29.653284 sshd[2753]: Connection closed by 10.0.0.1 port 32950 Sep 9 23:54:29.654435 sshd-session[2750]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:29.662663 systemd[1]: sshd@25-10.0.0.99:22-10.0.0.1:32950.service: Deactivated successfully. Sep 9 23:54:29.664322 systemd[1]: session-26.scope: Deactivated successfully. Sep 9 23:54:29.668727 systemd-logind[1393]: Session 26 logged out. Waiting for processes to exit. Sep 9 23:54:29.670985 systemd[1]: Started sshd@26-10.0.0.99:22-10.0.0.1:32958.service - OpenSSH per-connection server daemon (10.0.0.1:32958). Sep 9 23:54:29.673139 systemd-logind[1393]: Removed session 26. Sep 9 23:54:29.732289 sshd[2759]: Accepted publickey for core from 10.0.0.1 port 32958 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:29.733645 sshd-session[2759]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:29.738540 systemd-logind[1393]: New session 27 of user core. Sep 9 23:54:29.757962 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 9 23:54:29.823072 sshd[2762]: Connection closed by 10.0.0.1 port 32958 Sep 9 23:54:29.823566 sshd-session[2759]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:29.835701 systemd[1]: sshd@26-10.0.0.99:22-10.0.0.1:32958.service: Deactivated successfully. Sep 9 23:54:29.837961 systemd[1]: session-27.scope: Deactivated successfully. Sep 9 23:54:29.840939 systemd-logind[1393]: Session 27 logged out. Waiting for processes to exit. Sep 9 23:54:29.842126 systemd[1]: Started sshd@27-10.0.0.99:22-10.0.0.1:32974.service - OpenSSH per-connection server daemon (10.0.0.1:32974). Sep 9 23:54:29.843467 systemd-logind[1393]: Removed session 27. Sep 9 23:54:29.916642 sshd[2775]: Accepted publickey for core from 10.0.0.1 port 32974 ssh2: RSA SHA256:ShEbAFDiud3N347dMM7a5FvhCCVidjBtKvjtghHDp6o Sep 9 23:54:29.918560 sshd-session[2775]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:54:29.923275 systemd-logind[1393]: New session 28 of user core. Sep 9 23:54:29.936966 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 9 23:54:30.196134 systemd[1]: var-lib-docker-overlay2-5da9d4c78968396ab53cd2d6c42166c7ac76e322af41364bc4eb9aecc14d4abf-merged.mount: Deactivated successfully. Sep 9 23:54:30.310656 containerd[2457]: time="2025-09-09T23:54:30.310594227Z" level=info msg="connecting to shim 1a5375ee9940ce24ada5ed061d0f112f5db16e0c4f15eda7b849538901fa66ea" address="unix:///run/containerd/s/4180639cc914470b86a464bb2e0bf333a9c8efcf6869cc96dc609c8b0c530f72" namespace=moby protocol=ttrpc version=3 Sep 9 23:54:30.337911 systemd[1]: Started docker-1a5375ee9940ce24ada5ed061d0f112f5db16e0c4f15eda7b849538901fa66ea.scope - libcontainer container 1a5375ee9940ce24ada5ed061d0f112f5db16e0c4f15eda7b849538901fa66ea. Sep 9 23:54:30.354483 systemd-resolved[1296]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:54:30.380117 kernel: docker0: port 1(veth0b574cf) entered blocking state Sep 9 23:54:30.380205 kernel: docker0: port 1(veth0b574cf) entered disabled state Sep 9 23:54:30.380222 kernel: veth0b574cf: entered allmulticast mode Sep 9 23:54:30.380236 kernel: veth0b574cf: entered promiscuous mode Sep 9 23:54:30.380921 systemd-networkd[1382]: veth0b574cf: Link UP Sep 9 23:54:30.420826 kernel: eth0: renamed from veth586d4c4 Sep 9 23:54:30.422053 kernel: docker0: port 1(veth0b574cf) entered blocking state Sep 9 23:54:30.422090 kernel: docker0: port 1(veth0b574cf) entered forwarding state Sep 9 23:54:30.422245 systemd-networkd[1382]: veth0b574cf: Gained carrier Sep 9 23:54:30.422532 systemd-networkd[1382]: docker0: Gained carrier Sep 9 23:54:30.467892 sshd[2778]: Connection closed by 10.0.0.1 port 32974 Sep 9 23:54:30.469479 sshd-session[2775]: pam_unix(sshd:session): session closed for user core Sep 9 23:54:30.481073 systemd[1]: sshd@27-10.0.0.99:22-10.0.0.1:32974.service: Deactivated successfully. Sep 9 23:54:30.483637 systemd[1]: session-28.scope: Deactivated successfully. Sep 9 23:54:30.485664 systemd-logind[1393]: Session 28 logged out. Waiting for processes to exit. Sep 9 23:54:30.488007 systemd-logind[1393]: Removed session 28. Sep 9 23:54:31.900079 systemd-networkd[1382]: veth0b574cf: Gained IPv6LL