Oct 28 04:39:39.348559 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 28 04:39:39.348582 kernel: Linux version 6.12.54-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.1_p20250801 p4) 14.3.1 20250801, GNU ld (Gentoo 2.45 p3) 2.45.0) #1 SMP PREEMPT Tue Oct 28 03:20:07 -00 2025 Oct 28 04:39:39.348599 kernel: KASLR enabled Oct 28 04:39:39.348605 kernel: efi: EFI v2.7 by EDK II Oct 28 04:39:39.348611 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb221f18 Oct 28 04:39:39.348617 kernel: random: crng init done Oct 28 04:39:39.348624 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Oct 28 04:39:39.348630 kernel: secureboot: Secure boot enabled Oct 28 04:39:39.348638 kernel: ACPI: Early table checksum verification disabled Oct 28 04:39:39.348644 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Oct 28 04:39:39.348650 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 28 04:39:39.348656 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348662 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348668 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348677 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348683 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348689 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348696 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348702 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348708 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 28 04:39:39.348715 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 28 04:39:39.348721 kernel: ACPI: Use ACPI SPCR as default console: No Oct 28 04:39:39.348729 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:39:39.348735 kernel: NODE_DATA(0) allocated [mem 0xdc737a00-0xdc73efff] Oct 28 04:39:39.348741 kernel: Zone ranges: Oct 28 04:39:39.348748 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:39:39.348754 kernel: DMA32 empty Oct 28 04:39:39.348760 kernel: Normal empty Oct 28 04:39:39.348767 kernel: Device empty Oct 28 04:39:39.348773 kernel: Movable zone start for each node Oct 28 04:39:39.348779 kernel: Early memory node ranges Oct 28 04:39:39.348785 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Oct 28 04:39:39.348792 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Oct 28 04:39:39.348798 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Oct 28 04:39:39.348806 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Oct 28 04:39:39.348812 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Oct 28 04:39:39.348818 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Oct 28 04:39:39.348825 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Oct 28 04:39:39.348831 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Oct 28 04:39:39.348837 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 28 04:39:39.348847 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 28 04:39:39.348854 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 28 04:39:39.348861 kernel: cma: Reserved 16 MiB at 0x00000000d7a00000 on node -1 Oct 28 04:39:39.348868 kernel: psci: probing for conduit method from ACPI. Oct 28 04:39:39.348874 kernel: psci: PSCIv1.1 detected in firmware. Oct 28 04:39:39.348891 kernel: psci: Using standard PSCI v0.2 function IDs Oct 28 04:39:39.348899 kernel: psci: Trusted OS migration not required Oct 28 04:39:39.348906 kernel: psci: SMC Calling Convention v1.1 Oct 28 04:39:39.348914 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 28 04:39:39.348921 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Oct 28 04:39:39.348928 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Oct 28 04:39:39.348935 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 28 04:39:39.348942 kernel: Detected PIPT I-cache on CPU0 Oct 28 04:39:39.348948 kernel: CPU features: detected: GIC system register CPU interface Oct 28 04:39:39.348955 kernel: CPU features: detected: Spectre-v4 Oct 28 04:39:39.348962 kernel: CPU features: detected: Spectre-BHB Oct 28 04:39:39.348969 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 28 04:39:39.348976 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 28 04:39:39.348982 kernel: CPU features: detected: ARM erratum 1418040 Oct 28 04:39:39.348990 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 28 04:39:39.348997 kernel: alternatives: applying boot alternatives Oct 28 04:39:39.349005 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=1f35b74acbf2082d1ccaf19af5ba856ed6811e7fe1caa7e6e44e2aaa205180aa Oct 28 04:39:39.349012 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 28 04:39:39.349019 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 28 04:39:39.349026 kernel: Fallback order for Node 0: 0 Oct 28 04:39:39.349032 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Oct 28 04:39:39.349039 kernel: Policy zone: DMA Oct 28 04:39:39.349046 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 28 04:39:39.349052 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Oct 28 04:39:39.349060 kernel: software IO TLB: area num 4. Oct 28 04:39:39.349067 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Oct 28 04:39:39.349074 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Oct 28 04:39:39.349081 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 28 04:39:39.349088 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 28 04:39:39.349096 kernel: rcu: RCU event tracing is enabled. Oct 28 04:39:39.349102 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 28 04:39:39.349109 kernel: Trampoline variant of Tasks RCU enabled. Oct 28 04:39:39.349116 kernel: Tracing variant of Tasks RCU enabled. Oct 28 04:39:39.349123 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 28 04:39:39.349137 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 28 04:39:39.349145 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 28 04:39:39.349153 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 28 04:39:39.349160 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 28 04:39:39.349167 kernel: GICv3: 256 SPIs implemented Oct 28 04:39:39.349174 kernel: GICv3: 0 Extended SPIs implemented Oct 28 04:39:39.349180 kernel: Root IRQ handler: gic_handle_irq Oct 28 04:39:39.349187 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 28 04:39:39.349194 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Oct 28 04:39:39.349201 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 28 04:39:39.349207 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 28 04:39:39.349214 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Oct 28 04:39:39.349222 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Oct 28 04:39:39.349230 kernel: GICv3: using LPI property table @0x0000000040130000 Oct 28 04:39:39.349237 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Oct 28 04:39:39.349244 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 28 04:39:39.349250 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:39:39.349257 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 28 04:39:39.349264 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 28 04:39:39.349271 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 28 04:39:39.349278 kernel: arm-pv: using stolen time PV Oct 28 04:39:39.349285 kernel: Console: colour dummy device 80x25 Oct 28 04:39:39.349294 kernel: ACPI: Core revision 20240827 Oct 28 04:39:39.349301 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 28 04:39:39.349308 kernel: pid_max: default: 32768 minimum: 301 Oct 28 04:39:39.349316 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 28 04:39:39.349323 kernel: landlock: Up and running. Oct 28 04:39:39.349330 kernel: SELinux: Initializing. Oct 28 04:39:39.349337 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:39:39.349344 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 28 04:39:39.349352 kernel: rcu: Hierarchical SRCU implementation. Oct 28 04:39:39.349359 kernel: rcu: Max phase no-delay instances is 400. Oct 28 04:39:39.349367 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 28 04:39:39.349374 kernel: Remapping and enabling EFI services. Oct 28 04:39:39.349381 kernel: smp: Bringing up secondary CPUs ... Oct 28 04:39:39.349388 kernel: Detected PIPT I-cache on CPU1 Oct 28 04:39:39.349395 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 28 04:39:39.349404 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Oct 28 04:39:39.349411 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:39:39.349422 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 28 04:39:39.349431 kernel: Detected PIPT I-cache on CPU2 Oct 28 04:39:39.349439 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 28 04:39:39.349446 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Oct 28 04:39:39.349454 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:39:39.349461 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 28 04:39:39.349469 kernel: Detected PIPT I-cache on CPU3 Oct 28 04:39:39.349478 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 28 04:39:39.349485 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Oct 28 04:39:39.349493 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 28 04:39:39.349503 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 28 04:39:39.349511 kernel: smp: Brought up 1 node, 4 CPUs Oct 28 04:39:39.349520 kernel: SMP: Total of 4 processors activated. Oct 28 04:39:39.349527 kernel: CPU: All CPU(s) started at EL1 Oct 28 04:39:39.349535 kernel: CPU features: detected: 32-bit EL0 Support Oct 28 04:39:39.349542 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 28 04:39:39.349550 kernel: CPU features: detected: Common not Private translations Oct 28 04:39:39.349557 kernel: CPU features: detected: CRC32 instructions Oct 28 04:39:39.349564 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 28 04:39:39.349573 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 28 04:39:39.349581 kernel: CPU features: detected: LSE atomic instructions Oct 28 04:39:39.349588 kernel: CPU features: detected: Privileged Access Never Oct 28 04:39:39.349595 kernel: CPU features: detected: RAS Extension Support Oct 28 04:39:39.349603 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 28 04:39:39.349610 kernel: alternatives: applying system-wide alternatives Oct 28 04:39:39.349618 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Oct 28 04:39:39.349626 kernel: Memory: 2448292K/2572288K available (11136K kernel code, 2456K rwdata, 9084K rodata, 12992K init, 1038K bss, 101660K reserved, 16384K cma-reserved) Oct 28 04:39:39.349634 kernel: devtmpfs: initialized Oct 28 04:39:39.349642 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 28 04:39:39.349650 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 28 04:39:39.349657 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 28 04:39:39.349665 kernel: 0 pages in range for non-PLT usage Oct 28 04:39:39.349672 kernel: 515056 pages in range for PLT usage Oct 28 04:39:39.349679 kernel: pinctrl core: initialized pinctrl subsystem Oct 28 04:39:39.349688 kernel: SMBIOS 3.0.0 present. Oct 28 04:39:39.349695 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 28 04:39:39.349703 kernel: DMI: Memory slots populated: 1/1 Oct 28 04:39:39.349710 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 28 04:39:39.349718 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 28 04:39:39.349725 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 28 04:39:39.349733 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 28 04:39:39.349741 kernel: audit: initializing netlink subsys (disabled) Oct 28 04:39:39.349749 kernel: audit: type=2000 audit(0.026:1): state=initialized audit_enabled=0 res=1 Oct 28 04:39:39.349756 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 28 04:39:39.349764 kernel: cpuidle: using governor menu Oct 28 04:39:39.349771 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 28 04:39:39.349779 kernel: ASID allocator initialised with 32768 entries Oct 28 04:39:39.349786 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 28 04:39:39.349795 kernel: Serial: AMBA PL011 UART driver Oct 28 04:39:39.349802 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 28 04:39:39.349810 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 28 04:39:39.349818 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 28 04:39:39.349825 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 28 04:39:39.349832 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 28 04:39:39.349840 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 28 04:39:39.349847 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 28 04:39:39.349856 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 28 04:39:39.349863 kernel: ACPI: Added _OSI(Module Device) Oct 28 04:39:39.349870 kernel: ACPI: Added _OSI(Processor Device) Oct 28 04:39:39.349878 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 28 04:39:39.349900 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 28 04:39:39.349908 kernel: ACPI: Interpreter enabled Oct 28 04:39:39.349916 kernel: ACPI: Using GIC for interrupt routing Oct 28 04:39:39.349925 kernel: ACPI: MCFG table detected, 1 entries Oct 28 04:39:39.349933 kernel: ACPI: CPU0 has been hot-added Oct 28 04:39:39.349940 kernel: ACPI: CPU1 has been hot-added Oct 28 04:39:39.349947 kernel: ACPI: CPU2 has been hot-added Oct 28 04:39:39.349955 kernel: ACPI: CPU3 has been hot-added Oct 28 04:39:39.349962 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 28 04:39:39.349969 kernel: printk: legacy console [ttyAMA0] enabled Oct 28 04:39:39.349978 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 28 04:39:39.350135 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 28 04:39:39.350229 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 28 04:39:39.350310 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 28 04:39:39.350389 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 28 04:39:39.350467 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 28 04:39:39.350479 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 28 04:39:39.350487 kernel: PCI host bridge to bus 0000:00 Oct 28 04:39:39.350574 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 28 04:39:39.350647 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 28 04:39:39.350719 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 28 04:39:39.350790 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 28 04:39:39.350902 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Oct 28 04:39:39.350999 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 28 04:39:39.351084 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Oct 28 04:39:39.351175 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Oct 28 04:39:39.351256 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Oct 28 04:39:39.351337 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Oct 28 04:39:39.351417 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Oct 28 04:39:39.351495 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Oct 28 04:39:39.351568 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 28 04:39:39.351638 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 28 04:39:39.351710 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 28 04:39:39.351721 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 28 04:39:39.351729 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 28 04:39:39.351736 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 28 04:39:39.351744 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 28 04:39:39.351751 kernel: iommu: Default domain type: Translated Oct 28 04:39:39.351759 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 28 04:39:39.351766 kernel: efivars: Registered efivars operations Oct 28 04:39:39.351775 kernel: vgaarb: loaded Oct 28 04:39:39.351783 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 28 04:39:39.351790 kernel: VFS: Disk quotas dquot_6.6.0 Oct 28 04:39:39.351798 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 28 04:39:39.351805 kernel: pnp: PnP ACPI init Oct 28 04:39:39.351923 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 28 04:39:39.351936 kernel: pnp: PnP ACPI: found 1 devices Oct 28 04:39:39.351946 kernel: NET: Registered PF_INET protocol family Oct 28 04:39:39.351953 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 28 04:39:39.351961 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 28 04:39:39.351968 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 28 04:39:39.351976 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 28 04:39:39.351984 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 28 04:39:39.351991 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 28 04:39:39.352000 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:39:39.352008 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 28 04:39:39.352015 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 28 04:39:39.352023 kernel: PCI: CLS 0 bytes, default 64 Oct 28 04:39:39.352030 kernel: kvm [1]: HYP mode not available Oct 28 04:39:39.352038 kernel: Initialise system trusted keyrings Oct 28 04:39:39.352045 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 28 04:39:39.352054 kernel: Key type asymmetric registered Oct 28 04:39:39.352062 kernel: Asymmetric key parser 'x509' registered Oct 28 04:39:39.352069 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 28 04:39:39.352077 kernel: io scheduler mq-deadline registered Oct 28 04:39:39.352084 kernel: io scheduler kyber registered Oct 28 04:39:39.352092 kernel: io scheduler bfq registered Oct 28 04:39:39.352105 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 28 04:39:39.352117 kernel: ACPI: button: Power Button [PWRB] Oct 28 04:39:39.352134 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 28 04:39:39.352251 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 28 04:39:39.352263 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 28 04:39:39.352271 kernel: thunder_xcv, ver 1.0 Oct 28 04:39:39.352278 kernel: thunder_bgx, ver 1.0 Oct 28 04:39:39.352286 kernel: nicpf, ver 1.0 Oct 28 04:39:39.352295 kernel: nicvf, ver 1.0 Oct 28 04:39:39.352387 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 28 04:39:39.352465 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-28T04:39:38 UTC (1761626378) Oct 28 04:39:39.352475 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 28 04:39:39.352483 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 28 04:39:39.352490 kernel: watchdog: NMI not fully supported Oct 28 04:39:39.352500 kernel: watchdog: Hard watchdog permanently disabled Oct 28 04:39:39.352507 kernel: NET: Registered PF_INET6 protocol family Oct 28 04:39:39.352515 kernel: Segment Routing with IPv6 Oct 28 04:39:39.352522 kernel: In-situ OAM (IOAM) with IPv6 Oct 28 04:39:39.352530 kernel: NET: Registered PF_PACKET protocol family Oct 28 04:39:39.352537 kernel: Key type dns_resolver registered Oct 28 04:39:39.352545 kernel: registered taskstats version 1 Oct 28 04:39:39.352552 kernel: Loading compiled-in X.509 certificates Oct 28 04:39:39.352561 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: 26b98883ef58589f904405bf68dab5f3eec1fa06' Oct 28 04:39:39.352569 kernel: Demotion targets for Node 0: null Oct 28 04:39:39.352576 kernel: Key type .fscrypt registered Oct 28 04:39:39.352584 kernel: Key type fscrypt-provisioning registered Oct 28 04:39:39.352591 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 28 04:39:39.352599 kernel: ima: Allocated hash algorithm: sha1 Oct 28 04:39:39.352607 kernel: ima: No architecture policies found Oct 28 04:39:39.352616 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 28 04:39:39.352623 kernel: clk: Disabling unused clocks Oct 28 04:39:39.352631 kernel: PM: genpd: Disabling unused power domains Oct 28 04:39:39.352638 kernel: Freeing unused kernel memory: 12992K Oct 28 04:39:39.352646 kernel: Run /init as init process Oct 28 04:39:39.352653 kernel: with arguments: Oct 28 04:39:39.352660 kernel: /init Oct 28 04:39:39.352669 kernel: with environment: Oct 28 04:39:39.352676 kernel: HOME=/ Oct 28 04:39:39.352684 kernel: TERM=linux Oct 28 04:39:39.352784 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 28 04:39:39.352862 kernel: virtio_blk virtio1: [vda] 16515072 512-byte logical blocks (8.46 GB/7.88 GiB) Oct 28 04:39:39.352872 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 28 04:39:39.352895 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352903 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352911 kernel: SCSI subsystem initialized Oct 28 04:39:39.352918 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352926 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 28 04:39:39.352934 kernel: device-mapper: uevent: version 1.0.3 Oct 28 04:39:39.352941 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 28 04:39:39.352950 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 28 04:39:39.352958 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352965 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352973 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.352980 kernel: raid6: neonx8 gen() 15708 MB/s Oct 28 04:39:39.352988 kernel: raid6: neonx4 gen() 15777 MB/s Oct 28 04:39:39.352995 kernel: raid6: neonx2 gen() 13179 MB/s Oct 28 04:39:39.353002 kernel: raid6: neonx1 gen() 10397 MB/s Oct 28 04:39:39.353011 kernel: raid6: int64x8 gen() 6905 MB/s Oct 28 04:39:39.353018 kernel: raid6: int64x4 gen() 7330 MB/s Oct 28 04:39:39.353026 kernel: raid6: int64x2 gen() 6099 MB/s Oct 28 04:39:39.353033 kernel: raid6: int64x1 gen() 5049 MB/s Oct 28 04:39:39.353041 kernel: raid6: using algorithm neonx4 gen() 15777 MB/s Oct 28 04:39:39.353048 kernel: raid6: .... xor() 12344 MB/s, rmw enabled Oct 28 04:39:39.353056 kernel: raid6: using neon recovery algorithm Oct 28 04:39:39.353065 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.353072 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.353079 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.353087 kernel: Lockdown: modprobe: unsigned module loading is restricted; see man kernel_lockdown.7 Oct 28 04:39:39.353094 kernel: xor: measuring software checksum speed Oct 28 04:39:39.353102 kernel: 8regs : 21539 MB/sec Oct 28 04:39:39.353109 kernel: 32regs : 20929 MB/sec Oct 28 04:39:39.353117 kernel: arm64_neon : 27927 MB/sec Oct 28 04:39:39.353125 kernel: xor: using function: arm64_neon (27927 MB/sec) Oct 28 04:39:39.353140 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 28 04:39:39.353147 kernel: BTRFS: device fsid caa7e5e1-1ce1-458b-ad52-fda248cb60f9 devid 1 transid 36 /dev/mapper/usr (253:0) scanned by mount (205) Oct 28 04:39:39.353156 kernel: BTRFS info (device dm-0): first mount of filesystem caa7e5e1-1ce1-458b-ad52-fda248cb60f9 Oct 28 04:39:39.353163 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:39:39.353171 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 28 04:39:39.353179 kernel: BTRFS info (device dm-0): enabling free space tree Oct 28 04:39:39.353188 kernel: loop: module loaded Oct 28 04:39:39.353196 kernel: loop0: detected capacity change from 0 to 91480 Oct 28 04:39:39.353203 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 28 04:39:39.353212 systemd[1]: Successfully made /usr/ read-only. Oct 28 04:39:39.353223 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 28 04:39:39.353231 systemd[1]: Detected virtualization kvm. Oct 28 04:39:39.353241 systemd[1]: Detected architecture arm64. Oct 28 04:39:39.353249 systemd[1]: Running in initrd. Oct 28 04:39:39.353256 systemd[1]: No hostname configured, using default hostname. Oct 28 04:39:39.353265 systemd[1]: Hostname set to . Oct 28 04:39:39.353273 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 28 04:39:39.353281 systemd[1]: Queued start job for default target initrd.target. Oct 28 04:39:39.353288 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 28 04:39:39.353298 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:39:39.353306 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:39:39.353315 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 28 04:39:39.353323 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 28 04:39:39.353332 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 28 04:39:39.353341 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 28 04:39:39.353349 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:39:39.353357 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:39:39.353366 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 28 04:39:39.353373 systemd[1]: Reached target paths.target - Path Units. Oct 28 04:39:39.353381 systemd[1]: Reached target slices.target - Slice Units. Oct 28 04:39:39.353389 systemd[1]: Reached target swap.target - Swaps. Oct 28 04:39:39.353399 systemd[1]: Reached target timers.target - Timer Units. Oct 28 04:39:39.353410 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 28 04:39:39.353418 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 28 04:39:39.353433 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 28 04:39:39.353443 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 28 04:39:39.353453 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:39:39.353461 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 28 04:39:39.353470 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:39:39.353478 systemd[1]: Reached target sockets.target - Socket Units. Oct 28 04:39:39.353486 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 28 04:39:39.353495 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 28 04:39:39.353503 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 28 04:39:39.353513 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 28 04:39:39.353522 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). Oct 28 04:39:39.353530 systemd[1]: Starting systemd-fsck-usr.service... Oct 28 04:39:39.353539 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 28 04:39:39.353547 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 28 04:39:39.353555 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:39:39.353565 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 28 04:39:39.353574 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:39:39.353582 systemd[1]: Finished systemd-fsck-usr.service. Oct 28 04:39:39.353590 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 28 04:39:39.353618 systemd-journald[344]: Collecting audit messages is disabled. Oct 28 04:39:39.353638 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 28 04:39:39.353646 kernel: Bridge firewalling registered Oct 28 04:39:39.353656 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 28 04:39:39.353665 systemd-journald[344]: Journal started Oct 28 04:39:39.353683 systemd-journald[344]: Runtime Journal (/run/log/journal/0e7082ca3ce442b186f89eb0956b5133) is 6M, max 48.5M, 42.4M free. Oct 28 04:39:39.352722 systemd-modules-load[345]: Inserted module 'br_netfilter' Oct 28 04:39:39.358629 systemd[1]: Started systemd-journald.service - Journal Service. Oct 28 04:39:39.361003 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:39:39.363031 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 28 04:39:39.367021 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 28 04:39:39.368646 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 28 04:39:39.370391 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 28 04:39:39.382791 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 28 04:39:39.391829 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:39:39.395048 systemd-tmpfiles[370]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 28 04:39:39.395960 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:39:39.398908 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 28 04:39:39.400796 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:39:39.402154 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 28 04:39:39.413427 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 28 04:39:39.427788 dracut-cmdline[390]: 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=1f35b74acbf2082d1ccaf19af5ba856ed6811e7fe1caa7e6e44e2aaa205180aa Oct 28 04:39:39.449759 systemd-resolved[384]: Positive Trust Anchors: Oct 28 04:39:39.449777 systemd-resolved[384]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:39:39.449781 systemd-resolved[384]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 28 04:39:39.449812 systemd-resolved[384]: 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 Oct 28 04:39:39.473857 systemd-resolved[384]: Defaulting to hostname 'linux'. Oct 28 04:39:39.474905 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 28 04:39:39.475873 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:39:39.512912 kernel: Loading iSCSI transport class v2.0-870. Oct 28 04:39:39.527933 kernel: iscsi: registered transport (tcp) Oct 28 04:39:39.542924 kernel: iscsi: registered transport (qla4xxx) Oct 28 04:39:39.542972 kernel: QLogic iSCSI HBA Driver Oct 28 04:39:39.564971 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 28 04:39:39.581977 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:39:39.584196 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 28 04:39:39.630543 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 28 04:39:39.632984 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 28 04:39:39.634686 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 28 04:39:39.680352 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 28 04:39:39.683431 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:39:39.713805 systemd-udevd[628]: Using default interface naming scheme 'v257'. Oct 28 04:39:39.722734 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:39:39.726334 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 28 04:39:39.751041 dracut-pre-trigger[685]: rd.md=0: removing MD RAID activation Oct 28 04:39:39.767293 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 28 04:39:39.772482 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 28 04:39:39.792042 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 28 04:39:39.794387 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 28 04:39:39.824983 systemd-networkd[762]: lo: Link UP Oct 28 04:39:39.824992 systemd-networkd[762]: lo: Gained carrier Oct 28 04:39:39.825435 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 28 04:39:39.827050 systemd[1]: Reached target network.target - Network. Oct 28 04:39:39.840936 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:39:39.844827 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 28 04:39:39.893871 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 28 04:39:39.905568 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 28 04:39:39.916310 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 28 04:39:39.923592 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 28 04:39:39.929037 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 28 04:39:39.937639 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:39:39.937757 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:39:39.940644 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:39:39.943344 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:39:39.945452 systemd-networkd[762]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:39:39.945456 systemd-networkd[762]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 28 04:39:39.947739 systemd-networkd[762]: eth0: Link UP Oct 28 04:39:39.947917 systemd-networkd[762]: eth0: Gained carrier Oct 28 04:39:39.947927 systemd-networkd[762]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:39:39.959966 systemd-networkd[762]: eth0: DHCPv4 address 10.0.0.58/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 28 04:39:39.960324 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 28 04:39:39.964732 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 28 04:39:39.970054 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:39:39.971704 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 28 04:39:39.975325 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 28 04:39:39.981122 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:39:40.005436 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 28 04:39:40.996752 disk-uuid[810]: Warning: The kernel is still using the old partition table. Oct 28 04:39:40.996752 disk-uuid[810]: The new table will be used at the next reboot or after you Oct 28 04:39:40.996752 disk-uuid[810]: run partprobe(8) or kpartx(8) Oct 28 04:39:40.996752 disk-uuid[810]: The operation has completed successfully. Oct 28 04:39:41.007285 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 28 04:39:41.007398 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 28 04:39:41.009727 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 28 04:39:41.067906 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (841) Oct 28 04:39:41.071334 kernel: BTRFS info (device vda6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:39:41.071379 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:39:41.076993 kernel: BTRFS info (device vda6): turning on async discard Oct 28 04:39:41.077040 kernel: BTRFS info (device vda6): enabling free space tree Oct 28 04:39:41.083172 kernel: BTRFS info (device vda6): last unmount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:39:41.084953 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 28 04:39:41.087027 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 28 04:39:41.195247 ignition[860]: Ignition 2.22.0 Oct 28 04:39:41.195259 ignition[860]: Stage: fetch-offline Oct 28 04:39:41.195303 ignition[860]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:41.195312 ignition[860]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:41.195469 ignition[860]: parsed url from cmdline: "" Oct 28 04:39:41.195472 ignition[860]: no config URL provided Oct 28 04:39:41.195477 ignition[860]: reading system config file "/usr/lib/ignition/user.ign" Oct 28 04:39:41.195485 ignition[860]: no config at "/usr/lib/ignition/user.ign" Oct 28 04:39:41.195520 ignition[860]: op(1): [started] loading QEMU firmware config module Oct 28 04:39:41.195524 ignition[860]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 28 04:39:41.200742 ignition[860]: op(1): [finished] loading QEMU firmware config module Oct 28 04:39:41.206860 ignition[860]: parsing config with SHA512: 63ca691df36c74c4a5ced45dbc0b00e374f6facc2a59e372d0a8ae0e9ca66138ce01aa8b242a99a0f193fe7c72f87a9634e69e4da835eab9e2ecd2cfb37d3a22 Oct 28 04:39:41.213047 unknown[860]: fetched base config from "system" Oct 28 04:39:41.213058 unknown[860]: fetched user config from "qemu" Oct 28 04:39:41.213231 ignition[860]: fetch-offline: fetch-offline passed Oct 28 04:39:41.215991 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 28 04:39:41.213316 ignition[860]: Ignition finished successfully Oct 28 04:39:41.217639 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 28 04:39:41.218422 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 28 04:39:41.261312 ignition[872]: Ignition 2.22.0 Oct 28 04:39:41.261330 ignition[872]: Stage: kargs Oct 28 04:39:41.261471 ignition[872]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:41.261479 ignition[872]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:41.264285 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 28 04:39:41.261974 ignition[872]: kargs: kargs passed Oct 28 04:39:41.266697 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 28 04:39:41.262017 ignition[872]: Ignition finished successfully Oct 28 04:39:41.304325 ignition[880]: Ignition 2.22.0 Oct 28 04:39:41.304342 ignition[880]: Stage: disks Oct 28 04:39:41.304495 ignition[880]: no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:41.304503 ignition[880]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:41.306837 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 28 04:39:41.305086 ignition[880]: disks: disks passed Oct 28 04:39:41.308992 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 28 04:39:41.305145 ignition[880]: Ignition finished successfully Oct 28 04:39:41.310780 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 28 04:39:41.312534 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 28 04:39:41.314841 systemd[1]: Reached target sysinit.target - System Initialization. Oct 28 04:39:41.316503 systemd[1]: Reached target basic.target - Basic System. Oct 28 04:39:41.319482 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 28 04:39:41.363682 systemd-fsck[889]: ROOT: clean, 15/456736 files, 38230/456704 blocks Oct 28 04:39:41.368514 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 28 04:39:41.371326 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 28 04:39:41.445916 kernel: EXT4-fs (vda9): mounted filesystem 8fca153a-dda8-4620-af0a-8ec5cf72e73c r/w with ordered data mode. Quota mode: none. Oct 28 04:39:41.446482 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 28 04:39:41.447693 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 28 04:39:41.450485 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 28 04:39:41.452179 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 28 04:39:41.453075 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 28 04:39:41.453108 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 28 04:39:41.453142 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 28 04:39:41.466368 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 28 04:39:41.469093 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 28 04:39:41.475586 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (897) Oct 28 04:39:41.475609 kernel: BTRFS info (device vda6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:39:41.475619 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:39:41.475629 kernel: BTRFS info (device vda6): turning on async discard Oct 28 04:39:41.475639 kernel: BTRFS info (device vda6): enabling free space tree Oct 28 04:39:41.476696 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 28 04:39:41.529281 initrd-setup-root[921]: cut: /sysroot/etc/passwd: No such file or directory Oct 28 04:39:41.532773 initrd-setup-root[928]: cut: /sysroot/etc/group: No such file or directory Oct 28 04:39:41.537630 initrd-setup-root[935]: cut: /sysroot/etc/shadow: No such file or directory Oct 28 04:39:41.541834 initrd-setup-root[942]: cut: /sysroot/etc/gshadow: No such file or directory Oct 28 04:39:41.617006 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 28 04:39:41.619336 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 28 04:39:41.620995 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 28 04:39:41.638258 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 28 04:39:41.640914 kernel: BTRFS info (device vda6): last unmount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:39:41.657275 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 28 04:39:41.672153 ignition[1011]: INFO : Ignition 2.22.0 Oct 28 04:39:41.672153 ignition[1011]: INFO : Stage: mount Oct 28 04:39:41.675040 ignition[1011]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:41.675040 ignition[1011]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:41.675040 ignition[1011]: INFO : mount: mount passed Oct 28 04:39:41.675040 ignition[1011]: INFO : Ignition finished successfully Oct 28 04:39:41.676542 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 28 04:39:41.679274 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 28 04:39:41.870049 systemd-networkd[762]: eth0: Gained IPv6LL Oct 28 04:39:42.447995 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 28 04:39:42.473901 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1024) Oct 28 04:39:42.475963 kernel: BTRFS info (device vda6): first mount of filesystem 52a6d1c0-1d9b-4b64-8a3d-40978d54767d Oct 28 04:39:42.475983 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 28 04:39:42.478901 kernel: BTRFS info (device vda6): turning on async discard Oct 28 04:39:42.478936 kernel: BTRFS info (device vda6): enabling free space tree Oct 28 04:39:42.480548 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 28 04:39:42.509888 ignition[1042]: INFO : Ignition 2.22.0 Oct 28 04:39:42.509888 ignition[1042]: INFO : Stage: files Oct 28 04:39:42.511603 ignition[1042]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:42.511603 ignition[1042]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:42.511603 ignition[1042]: DEBUG : files: compiled without relabeling support, skipping Oct 28 04:39:42.511603 ignition[1042]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 28 04:39:42.511603 ignition[1042]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 28 04:39:42.517809 ignition[1042]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 28 04:39:42.517809 ignition[1042]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 28 04:39:42.517809 ignition[1042]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 28 04:39:42.514789 unknown[1042]: wrote ssh authorized keys file for user: core Oct 28 04:39:42.522847 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 28 04:39:42.522847 ignition[1042]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 28 04:39:42.522847 ignition[1042]: INFO : files: op(4): [started] processing unit "docker.service" Oct 28 04:39:42.522847 ignition[1042]: INFO : files: op(4): [finished] processing unit "docker.service" Oct 28 04:39:42.522847 ignition[1042]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Oct 28 04:39:42.522847 ignition[1042]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 28 04:39:42.532840 ignition[1042]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 28 04:39:42.532840 ignition[1042]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Oct 28 04:39:42.532840 ignition[1042]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Oct 28 04:39:42.545064 ignition[1042]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 28 04:39:42.548593 ignition[1042]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 28 04:39:42.550970 ignition[1042]: INFO : files: files passed Oct 28 04:39:42.550970 ignition[1042]: INFO : Ignition finished successfully Oct 28 04:39:42.551827 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 28 04:39:42.554126 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 28 04:39:42.556007 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 28 04:39:42.574631 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 28 04:39:42.574742 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 28 04:39:42.578424 initrd-setup-root-after-ignition[1072]: grep: /sysroot/oem/oem-release: No such file or directory Oct 28 04:39:42.580573 initrd-setup-root-after-ignition[1074]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:39:42.580573 initrd-setup-root-after-ignition[1074]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:39:42.584868 initrd-setup-root-after-ignition[1078]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 28 04:39:42.585660 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 28 04:39:42.588581 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 28 04:39:42.591474 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 28 04:39:42.623758 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 28 04:39:42.623921 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 28 04:39:42.626373 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 28 04:39:42.628396 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 28 04:39:42.630464 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 28 04:39:42.631354 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 28 04:39:42.648192 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 28 04:39:42.651054 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 28 04:39:42.672346 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 28 04:39:42.672543 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:39:42.674833 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:39:42.676894 systemd[1]: Stopped target timers.target - Timer Units. Oct 28 04:39:42.678724 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 28 04:39:42.678865 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 28 04:39:42.681553 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 28 04:39:42.683668 systemd[1]: Stopped target basic.target - Basic System. Oct 28 04:39:42.685398 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 28 04:39:42.687184 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 28 04:39:42.689177 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 28 04:39:42.691156 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 28 04:39:42.693061 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 28 04:39:42.694949 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 28 04:39:42.697104 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 28 04:39:42.698930 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 28 04:39:42.700726 systemd[1]: Stopped target swap.target - Swaps. Oct 28 04:39:42.702305 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 28 04:39:42.702442 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 28 04:39:42.704733 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:39:42.707093 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:39:42.709185 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 28 04:39:42.712974 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:39:42.714232 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 28 04:39:42.714383 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 28 04:39:42.717607 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 28 04:39:42.717751 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 28 04:39:42.719946 systemd[1]: Stopped target paths.target - Path Units. Oct 28 04:39:42.721868 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 28 04:39:42.721998 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:39:42.724197 systemd[1]: Stopped target slices.target - Slice Units. Oct 28 04:39:42.725704 systemd[1]: Stopped target sockets.target - Socket Units. Oct 28 04:39:42.727691 systemd[1]: iscsid.socket: Deactivated successfully. Oct 28 04:39:42.727782 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 28 04:39:42.729921 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 28 04:39:42.730007 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 28 04:39:42.731800 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 28 04:39:42.731938 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 28 04:39:42.733994 systemd[1]: ignition-files.service: Deactivated successfully. Oct 28 04:39:42.734098 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 28 04:39:42.736602 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 28 04:39:42.738141 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 28 04:39:42.738264 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:39:42.759278 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 28 04:39:42.760156 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 28 04:39:42.760297 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:39:42.762280 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 28 04:39:42.762392 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:39:42.764470 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 28 04:39:42.764568 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 28 04:39:42.771019 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 28 04:39:42.771141 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 28 04:39:42.775369 ignition[1099]: INFO : Ignition 2.22.0 Oct 28 04:39:42.775369 ignition[1099]: INFO : Stage: umount Oct 28 04:39:42.778757 ignition[1099]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 28 04:39:42.778757 ignition[1099]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 28 04:39:42.778757 ignition[1099]: INFO : umount: umount passed Oct 28 04:39:42.778757 ignition[1099]: INFO : Ignition finished successfully Oct 28 04:39:42.776531 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 28 04:39:42.777971 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 28 04:39:42.779926 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 28 04:39:42.781179 systemd[1]: Stopped target network.target - Network. Oct 28 04:39:42.783294 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 28 04:39:42.783354 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 28 04:39:42.785026 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 28 04:39:42.785079 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 28 04:39:42.786929 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 28 04:39:42.786978 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 28 04:39:42.788923 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 28 04:39:42.788968 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 28 04:39:42.791032 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 28 04:39:42.792947 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 28 04:39:42.795183 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 28 04:39:42.795268 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 28 04:39:42.797590 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 28 04:39:42.797677 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 28 04:39:42.801367 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 28 04:39:42.801473 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 28 04:39:42.805269 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 28 04:39:42.805364 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 28 04:39:42.809640 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 28 04:39:42.811081 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 28 04:39:42.811136 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:39:42.813995 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 28 04:39:42.814823 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 28 04:39:42.814904 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 28 04:39:42.817215 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 28 04:39:42.817259 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:39:42.819150 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 28 04:39:42.819196 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 28 04:39:42.821025 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:39:42.841469 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 28 04:39:42.841639 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:39:42.843876 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 28 04:39:42.843942 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 28 04:39:42.845808 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 28 04:39:42.845844 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:39:42.847817 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 28 04:39:42.847874 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 28 04:39:42.850943 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 28 04:39:42.851001 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 28 04:39:42.853810 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 28 04:39:42.853859 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 28 04:39:42.856750 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 28 04:39:42.857812 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 28 04:39:42.857879 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:39:42.859967 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 28 04:39:42.860011 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:39:42.861922 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 28 04:39:42.861968 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:39:42.864772 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 28 04:39:42.870053 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 28 04:39:42.875744 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 28 04:39:42.875853 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 28 04:39:42.879185 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 28 04:39:42.881711 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 28 04:39:42.909984 systemd[1]: Switching root. Oct 28 04:39:42.931298 systemd-journald[344]: Journal stopped Oct 28 04:39:43.614981 systemd-journald[344]: Received SIGTERM from PID 1 (systemd). Oct 28 04:39:43.615038 kernel: SELinux: policy capability network_peer_controls=1 Oct 28 04:39:43.615055 kernel: SELinux: policy capability open_perms=1 Oct 28 04:39:43.615067 kernel: SELinux: policy capability extended_socket_class=1 Oct 28 04:39:43.615080 kernel: SELinux: policy capability always_check_network=0 Oct 28 04:39:43.615090 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 28 04:39:43.615101 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 28 04:39:43.615136 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 28 04:39:43.615152 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 28 04:39:43.615163 kernel: SELinux: policy capability userspace_initial_context=0 Oct 28 04:39:43.615173 kernel: audit: type=1403 audit(1761626383.011:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 28 04:39:43.615187 systemd[1]: Successfully loaded SELinux policy in 62.340ms. Oct 28 04:39:43.615205 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 6.059ms. Oct 28 04:39:43.615220 systemd[1]: systemd 257.7 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Oct 28 04:39:43.615232 systemd[1]: Detected virtualization kvm. Oct 28 04:39:43.615244 systemd[1]: Detected architecture arm64. Oct 28 04:39:43.615254 systemd[1]: Detected first boot. Oct 28 04:39:43.615265 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 28 04:39:43.615276 zram_generator::config[1149]: No configuration found. Oct 28 04:39:43.615288 kernel: NET: Registered PF_VSOCK protocol family Oct 28 04:39:43.615300 systemd[1]: Populated /etc with preset unit settings. Oct 28 04:39:43.615311 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 28 04:39:43.615324 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 28 04:39:43.615336 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 28 04:39:43.615348 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 28 04:39:43.615359 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 28 04:39:43.615370 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 28 04:39:43.615384 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 28 04:39:43.615395 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 28 04:39:43.615407 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 28 04:39:43.615418 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 28 04:39:43.615429 systemd[1]: Created slice user.slice - User and Session Slice. Oct 28 04:39:43.615441 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 28 04:39:43.615452 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 28 04:39:43.615464 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 28 04:39:43.615474 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 28 04:39:43.615485 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 28 04:39:43.615496 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 28 04:39:43.615509 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 28 04:39:43.615520 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 28 04:39:43.615530 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 28 04:39:43.615542 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 28 04:39:43.615556 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 28 04:39:43.615568 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 28 04:39:43.615581 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 28 04:39:43.615592 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 28 04:39:43.615602 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 28 04:39:43.615613 systemd[1]: Reached target slices.target - Slice Units. Oct 28 04:39:43.615624 systemd[1]: Reached target swap.target - Swaps. Oct 28 04:39:43.615635 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 28 04:39:43.615646 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 28 04:39:43.615657 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 28 04:39:43.615669 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 28 04:39:43.615680 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 28 04:39:43.615691 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 28 04:39:43.615702 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 28 04:39:43.615714 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 28 04:39:43.615724 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 28 04:39:43.615736 systemd[1]: Mounting media.mount - External Media Directory... Oct 28 04:39:43.615748 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 28 04:39:43.615759 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 28 04:39:43.615770 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 28 04:39:43.615782 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). Oct 28 04:39:43.615794 systemd[1]: Reached target machines.target - Containers. Oct 28 04:39:43.615804 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 28 04:39:43.615817 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:39:43.615828 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 28 04:39:43.615839 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 28 04:39:43.615850 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 28 04:39:43.615860 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 28 04:39:43.615871 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 28 04:39:43.615896 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 28 04:39:43.615912 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 28 04:39:43.615923 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 28 04:39:43.615934 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 28 04:39:43.615945 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 28 04:39:43.615956 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 28 04:39:43.615968 systemd[1]: Stopped systemd-fsck-usr.service. Oct 28 04:39:43.615979 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). Oct 28 04:39:43.615992 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 28 04:39:43.616003 kernel: fuse: init (API version 7.41) Oct 28 04:39:43.616012 kernel: ACPI: bus type drm_connector registered Oct 28 04:39:43.616023 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 28 04:39:43.616035 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 28 04:39:43.616046 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 28 04:39:43.616057 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 28 04:39:43.616070 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 28 04:39:43.616081 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 28 04:39:43.616091 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 28 04:39:43.616103 systemd[1]: Mounted media.mount - External Media Directory. Oct 28 04:39:43.616120 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 28 04:39:43.616159 systemd-journald[1213]: Collecting audit messages is disabled. Oct 28 04:39:43.616181 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 28 04:39:43.616193 systemd-journald[1213]: Journal started Oct 28 04:39:43.616213 systemd-journald[1213]: Runtime Journal (/run/log/journal/0e7082ca3ce442b186f89eb0956b5133) is 6M, max 48.5M, 42.4M free. Oct 28 04:39:43.384523 systemd[1]: Queued start job for default target multi-user.target. Oct 28 04:39:43.394792 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 28 04:39:43.395234 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 28 04:39:43.618219 systemd[1]: Started systemd-journald.service - Journal Service. Oct 28 04:39:43.619241 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 28 04:39:43.620576 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 28 04:39:43.623933 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 28 04:39:43.625441 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 28 04:39:43.625611 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 28 04:39:43.627100 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 28 04:39:43.627292 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 28 04:39:43.628645 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:39:43.628799 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 28 04:39:43.631342 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 28 04:39:43.631527 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 28 04:39:43.633072 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 28 04:39:43.633252 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 28 04:39:43.634742 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 28 04:39:43.634910 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 28 04:39:43.636304 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 28 04:39:43.637847 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 28 04:39:43.640356 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 28 04:39:43.642038 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 28 04:39:43.654426 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 28 04:39:43.657753 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 28 04:39:43.659556 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 28 04:39:43.662002 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 28 04:39:43.664448 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 28 04:39:43.665841 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 28 04:39:43.665891 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 28 04:39:43.667818 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 28 04:39:43.669404 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:39:43.683814 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 28 04:39:43.686157 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 28 04:39:43.687466 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 28 04:39:43.688386 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 28 04:39:43.689816 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 28 04:39:43.691449 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 28 04:39:43.695985 systemd-journald[1213]: Time spent on flushing to /var/log/journal/0e7082ca3ce442b186f89eb0956b5133 is 12.862ms for 848 entries. Oct 28 04:39:43.695985 systemd-journald[1213]: System Journal (/var/log/journal/0e7082ca3ce442b186f89eb0956b5133) is 8M, max 163.5M, 155.5M free. Oct 28 04:39:43.726644 systemd-journald[1213]: Received client request to flush runtime journal. Oct 28 04:39:43.696488 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 28 04:39:43.702046 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 28 04:39:43.704870 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 28 04:39:43.706297 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 28 04:39:43.715970 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 28 04:39:43.720091 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 28 04:39:43.722381 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 28 04:39:43.729908 kernel: loop1: detected capacity change from 0 to 100192 Oct 28 04:39:43.734332 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 28 04:39:43.736586 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 28 04:39:43.749590 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 28 04:39:43.759433 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 28 04:39:43.764910 kernel: loop2: detected capacity change from 0 to 119400 Oct 28 04:39:43.762529 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 28 04:39:43.767024 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 28 04:39:43.777672 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 28 04:39:43.784964 kernel: loop3: detected capacity change from 0 to 100192 Oct 28 04:39:43.790937 kernel: loop4: detected capacity change from 0 to 119400 Oct 28 04:39:43.794354 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Oct 28 04:39:43.794370 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Oct 28 04:39:43.800016 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 28 04:39:43.800204 (sd-merge)[1282]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw'. Oct 28 04:39:43.803306 (sd-merge)[1282]: Merged extensions into '/usr'. Oct 28 04:39:43.805842 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 28 04:39:43.807377 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 28 04:39:43.811164 systemd[1]: Starting ensure-sysext.service... Oct 28 04:39:43.819293 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 28 04:39:43.824359 systemd[1]: Reload requested from client PID 1289 ('systemctl') (unit ensure-sysext.service)... Oct 28 04:39:43.824373 systemd[1]: Reloading... Oct 28 04:39:43.836086 systemd-tmpfiles[1290]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 28 04:39:43.836137 systemd-tmpfiles[1290]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 28 04:39:43.836388 systemd-tmpfiles[1290]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 28 04:39:43.836576 systemd-tmpfiles[1290]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 28 04:39:43.837228 systemd-tmpfiles[1290]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 28 04:39:43.837415 systemd-tmpfiles[1290]: ACLs are not supported, ignoring. Oct 28 04:39:43.837469 systemd-tmpfiles[1290]: ACLs are not supported, ignoring. Oct 28 04:39:43.842494 systemd-tmpfiles[1290]: Detected autofs mount point /boot during canonicalization of boot. Oct 28 04:39:43.842506 systemd-tmpfiles[1290]: Skipping /boot Oct 28 04:39:43.848409 systemd-tmpfiles[1290]: Detected autofs mount point /boot during canonicalization of boot. Oct 28 04:39:43.848425 systemd-tmpfiles[1290]: Skipping /boot Oct 28 04:39:43.883403 systemd-resolved[1277]: Positive Trust Anchors: Oct 28 04:39:43.883422 systemd-resolved[1277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 28 04:39:43.883426 systemd-resolved[1277]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 28 04:39:43.883458 systemd-resolved[1277]: 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 Oct 28 04:39:43.884919 zram_generator::config[1322]: No configuration found. Oct 28 04:39:43.889800 systemd-resolved[1277]: Defaulting to hostname 'linux'. Oct 28 04:39:44.016773 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 28 04:39:44.017232 systemd[1]: Reloading finished in 192 ms. Oct 28 04:39:44.052492 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 28 04:39:44.073014 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 28 04:39:44.079776 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 28 04:39:44.082353 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 28 04:39:44.084284 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 28 04:39:44.086455 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 28 04:39:44.092959 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 28 04:39:44.095545 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 28 04:39:44.099307 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:39:44.101314 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 28 04:39:44.104582 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 28 04:39:44.108275 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 28 04:39:44.110047 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:39:44.110188 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). Oct 28 04:39:44.117387 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 28 04:39:44.119928 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:39:44.120095 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:39:44.120194 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). Oct 28 04:39:44.123097 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 28 04:39:44.125220 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 28 04:39:44.127230 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 28 04:39:44.127377 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 28 04:39:44.130486 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 28 04:39:44.130781 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 28 04:39:44.133012 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 28 04:39:44.138702 systemd[1]: Finished ensure-sysext.service. Oct 28 04:39:44.141417 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 28 04:39:44.144590 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 28 04:39:44.146001 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 28 04:39:44.147524 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 28 04:39:44.147570 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). Oct 28 04:39:44.147610 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 28 04:39:44.147648 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 28 04:39:44.149408 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 28 04:39:44.158396 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 28 04:39:44.160545 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 28 04:39:44.162460 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 28 04:39:44.162643 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 28 04:39:44.165282 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). Oct 28 04:39:44.175132 augenrules[1398]: No rules Oct 28 04:39:44.177384 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:39:44.177600 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 28 04:39:44.182480 systemd-udevd[1389]: Using default interface naming scheme 'v257'. Oct 28 04:39:44.201956 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 28 04:39:44.206340 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 28 04:39:44.209633 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 28 04:39:44.211456 systemd[1]: Reached target time-set.target - System Time Set. Oct 28 04:39:44.249844 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 28 04:39:44.296859 systemd-networkd[1410]: lo: Link UP Oct 28 04:39:44.296872 systemd-networkd[1410]: lo: Gained carrier Oct 28 04:39:44.297836 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 28 04:39:44.299211 systemd[1]: Reached target network.target - Network. Oct 28 04:39:44.299843 systemd-networkd[1410]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:39:44.299853 systemd-networkd[1410]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 28 04:39:44.301249 systemd-networkd[1410]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:39:44.301376 systemd-networkd[1410]: eth0: Link UP Oct 28 04:39:44.301568 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 28 04:39:44.301792 systemd-networkd[1410]: eth0: Gained carrier Oct 28 04:39:44.301866 systemd-networkd[1410]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 28 04:39:44.305313 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 28 04:39:44.318138 systemd-networkd[1410]: eth0: DHCPv4 address 10.0.0.58/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 28 04:39:44.318671 systemd-timesyncd[1382]: Network configuration changed, trying to establish connection. Oct 28 04:39:44.319404 systemd-timesyncd[1382]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 28 04:39:44.319450 systemd-timesyncd[1382]: Initial clock synchronization to Tue 2025-10-28 04:39:44.461762 UTC. Oct 28 04:39:44.328236 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 28 04:39:44.331474 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 28 04:39:44.335489 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 28 04:39:44.358605 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 28 04:39:44.414699 ldconfig[1359]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 28 04:39:44.422307 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 28 04:39:44.423871 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 28 04:39:44.432281 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 28 04:39:44.455977 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 28 04:39:44.470065 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 28 04:39:44.472839 systemd[1]: Reached target sysinit.target - System Initialization. Oct 28 04:39:44.474050 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 28 04:39:44.475295 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 28 04:39:44.476699 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 28 04:39:44.477938 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 28 04:39:44.479172 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 28 04:39:44.480456 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 28 04:39:44.480493 systemd[1]: Reached target paths.target - Path Units. Oct 28 04:39:44.481448 systemd[1]: Reached target timers.target - Timer Units. Oct 28 04:39:44.483534 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 28 04:39:44.486182 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 28 04:39:44.489242 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 28 04:39:44.490649 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 28 04:39:44.491942 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 28 04:39:44.495006 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 28 04:39:44.496313 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 28 04:39:44.498205 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 28 04:39:44.499324 systemd[1]: Reached target sockets.target - Socket Units. Oct 28 04:39:44.500273 systemd[1]: Reached target basic.target - Basic System. Oct 28 04:39:44.501200 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 28 04:39:44.501238 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 28 04:39:44.502260 systemd[1]: Starting containerd.service - containerd container runtime... Oct 28 04:39:44.504399 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 28 04:39:44.506378 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 28 04:39:44.508516 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 28 04:39:44.510590 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 28 04:39:44.511654 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). Oct 28 04:39:44.514039 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 28 04:39:44.515859 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 28 04:39:44.517013 jq[1469]: false Oct 28 04:39:44.518174 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 28 04:39:44.523098 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 28 04:39:44.524207 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 28 04:39:44.524637 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 28 04:39:44.525792 extend-filesystems[1470]: Found /dev/vda6 Oct 28 04:39:44.526165 systemd[1]: Starting update-engine.service - Update Engine... Oct 28 04:39:44.529146 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 28 04:39:44.529917 extend-filesystems[1470]: Found /dev/vda9 Oct 28 04:39:44.535095 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 28 04:39:44.535260 extend-filesystems[1470]: Checking size of /dev/vda9 Oct 28 04:39:44.536612 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 28 04:39:44.536781 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 28 04:39:44.537115 systemd[1]: motdgen.service: Deactivated successfully. Oct 28 04:39:44.537290 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 28 04:39:44.538831 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 28 04:39:44.539626 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 28 04:39:44.541367 jq[1482]: true Oct 28 04:39:44.552948 jq[1494]: true Oct 28 04:39:44.559203 extend-filesystems[1470]: Resized partition /dev/vda9 Oct 28 04:39:44.562228 extend-filesystems[1512]: resize2fs 1.47.3 (8-Jul-2025) Oct 28 04:39:44.563673 update_engine[1481]: I20251028 04:39:44.562492 1481 main.cc:92] Flatcar Update Engine starting Oct 28 04:39:44.569315 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 474107 blocks Oct 28 04:39:44.581324 kernel: EXT4-fs (vda9): resized filesystem to 474107 Oct 28 04:39:44.577037 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 28 04:39:44.576753 dbus-daemon[1467]: [system] SELinux support is enabled Oct 28 04:39:44.582420 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). Oct 28 04:39:44.584097 extend-filesystems[1512]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 28 04:39:44.584097 extend-filesystems[1512]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 28 04:39:44.584097 extend-filesystems[1512]: The filesystem on /dev/vda9 is now 474107 (4k) blocks long. Oct 28 04:39:44.582938 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 28 04:39:44.602525 update_engine[1481]: I20251028 04:39:44.598939 1481 update_check_scheduler.cc:74] Next update check in 9m6s Oct 28 04:39:44.602552 extend-filesystems[1470]: Resized filesystem in /dev/vda9 Oct 28 04:39:44.585067 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). Oct 28 04:39:44.585082 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 28 04:39:44.586446 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 28 04:39:44.586635 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 28 04:39:44.597756 systemd[1]: Started update-engine.service - Update Engine. Oct 28 04:39:44.602374 systemd-logind[1477]: Watching system buttons on /dev/input/event0 (Power Button) Oct 28 04:39:44.602578 systemd-logind[1477]: New seat seat0. Oct 28 04:39:44.603735 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 28 04:39:44.606473 systemd[1]: Started systemd-logind.service - User Login Management. Oct 28 04:39:44.610996 bash[1527]: Updated "/home/core/.ssh/authorized_keys" Oct 28 04:39:44.613967 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 28 04:39:44.619837 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 28 04:39:44.673941 locksmithd[1529]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 28 04:39:44.732311 containerd[1504]: time="2025-10-28T04:39:44Z" 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 Oct 28 04:39:44.732866 containerd[1504]: time="2025-10-28T04:39:44.732833480Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 28 04:39:44.743139 containerd[1504]: time="2025-10-28T04:39:44.743081040Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.52µs" Oct 28 04:39:44.743139 containerd[1504]: time="2025-10-28T04:39:44.743122440Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 28 04:39:44.743139 containerd[1504]: time="2025-10-28T04:39:44.743141240Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 28 04:39:44.743314 containerd[1504]: time="2025-10-28T04:39:44.743297000Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 28 04:39:44.743373 containerd[1504]: time="2025-10-28T04:39:44.743315560Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 28 04:39:44.743373 containerd[1504]: time="2025-10-28T04:39:44.743338680Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743405 containerd[1504]: time="2025-10-28T04:39:44.743386520Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743405 containerd[1504]: time="2025-10-28T04:39:44.743397160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743626 containerd[1504]: time="2025-10-28T04:39:44.743593320Z" 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 Oct 28 04:39:44.743626 containerd[1504]: time="2025-10-28T04:39:44.743613480Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743626 containerd[1504]: time="2025-10-28T04:39:44.743624760Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743685 containerd[1504]: time="2025-10-28T04:39:44.743632720Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743715 containerd[1504]: time="2025-10-28T04:39:44.743700120Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743924 containerd[1504]: time="2025-10-28T04:39:44.743907200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 28 04:39:44.743953 containerd[1504]: time="2025-10-28T04:39:44.743939720Z" 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 Oct 28 04:39:44.743973 containerd[1504]: time="2025-10-28T04:39:44.743954080Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 28 04:39:44.743996 containerd[1504]: time="2025-10-28T04:39:44.743986000Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 28 04:39:44.744217 containerd[1504]: time="2025-10-28T04:39:44.744198360Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 28 04:39:44.744280 containerd[1504]: time="2025-10-28T04:39:44.744265920Z" level=info msg="metadata content store policy set" policy=shared Oct 28 04:39:44.750954 containerd[1504]: time="2025-10-28T04:39:44.750915840Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 28 04:39:44.751025 containerd[1504]: time="2025-10-28T04:39:44.750990840Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 28 04:39:44.751025 containerd[1504]: time="2025-10-28T04:39:44.751006480Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 28 04:39:44.751025 containerd[1504]: time="2025-10-28T04:39:44.751018360Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751029480Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751040040Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751053720Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751066960Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751077400Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751087000Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 28 04:39:44.751099 containerd[1504]: time="2025-10-28T04:39:44.751096800Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 28 04:39:44.751258 containerd[1504]: time="2025-10-28T04:39:44.751114920Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 28 04:39:44.751258 containerd[1504]: time="2025-10-28T04:39:44.751245840Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 28 04:39:44.751292 containerd[1504]: time="2025-10-28T04:39:44.751271960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 28 04:39:44.751292 containerd[1504]: time="2025-10-28T04:39:44.751286200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 28 04:39:44.751339 containerd[1504]: time="2025-10-28T04:39:44.751301600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 28 04:39:44.751339 containerd[1504]: time="2025-10-28T04:39:44.751325880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 28 04:39:44.751339 containerd[1504]: time="2025-10-28T04:39:44.751335920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 28 04:39:44.751389 containerd[1504]: time="2025-10-28T04:39:44.751347000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 28 04:39:44.751389 containerd[1504]: time="2025-10-28T04:39:44.751357640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 28 04:39:44.751389 containerd[1504]: time="2025-10-28T04:39:44.751368760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 28 04:39:44.751442 containerd[1504]: time="2025-10-28T04:39:44.751395760Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 28 04:39:44.751442 containerd[1504]: time="2025-10-28T04:39:44.751407960Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 28 04:39:44.751670 containerd[1504]: time="2025-10-28T04:39:44.751648560Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 28 04:39:44.751695 containerd[1504]: time="2025-10-28T04:39:44.751671240Z" level=info msg="Start snapshots syncer" Oct 28 04:39:44.751717 containerd[1504]: time="2025-10-28T04:39:44.751706080Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 28 04:39:44.751976 containerd[1504]: time="2025-10-28T04:39:44.751936120Z" 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\"}" Oct 28 04:39:44.752074 containerd[1504]: time="2025-10-28T04:39:44.751993240Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 28 04:39:44.752074 containerd[1504]: time="2025-10-28T04:39:44.752061840Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 28 04:39:44.752200 containerd[1504]: time="2025-10-28T04:39:44.752179960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 28 04:39:44.752224 containerd[1504]: time="2025-10-28T04:39:44.752206680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 28 04:39:44.752242 containerd[1504]: time="2025-10-28T04:39:44.752224040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 28 04:39:44.752242 containerd[1504]: time="2025-10-28T04:39:44.752234720Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 28 04:39:44.752279 containerd[1504]: time="2025-10-28T04:39:44.752247880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 28 04:39:44.752279 containerd[1504]: time="2025-10-28T04:39:44.752257880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 28 04:39:44.752279 containerd[1504]: time="2025-10-28T04:39:44.752267920Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 28 04:39:44.752331 containerd[1504]: time="2025-10-28T04:39:44.752299960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 28 04:39:44.752331 containerd[1504]: time="2025-10-28T04:39:44.752311560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 28 04:39:44.752331 containerd[1504]: time="2025-10-28T04:39:44.752322240Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 28 04:39:44.752378 containerd[1504]: time="2025-10-28T04:39:44.752356120Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 28 04:39:44.752378 containerd[1504]: time="2025-10-28T04:39:44.752372440Z" 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 Oct 28 04:39:44.752411 containerd[1504]: time="2025-10-28T04:39:44.752381400Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:39:44.752411 containerd[1504]: time="2025-10-28T04:39:44.752390960Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:39:44.752411 containerd[1504]: time="2025-10-28T04:39:44.752398440Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 28 04:39:44.752462 containerd[1504]: time="2025-10-28T04:39:44.752411640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 28 04:39:44.752462 containerd[1504]: time="2025-10-28T04:39:44.752422480Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 28 04:39:44.752508 containerd[1504]: time="2025-10-28T04:39:44.752497440Z" level=info msg="runtime interface created" Oct 28 04:39:44.752508 containerd[1504]: time="2025-10-28T04:39:44.752505320Z" level=info msg="created NRI interface" Oct 28 04:39:44.752546 containerd[1504]: time="2025-10-28T04:39:44.752514000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 28 04:39:44.752546 containerd[1504]: time="2025-10-28T04:39:44.752525840Z" level=info msg="Connect containerd service" Oct 28 04:39:44.752578 containerd[1504]: time="2025-10-28T04:39:44.752550000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 28 04:39:44.753273 containerd[1504]: time="2025-10-28T04:39:44.753247400Z" 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" Oct 28 04:39:44.824846 containerd[1504]: time="2025-10-28T04:39:44.824548880Z" level=info msg="Start subscribing containerd event" Oct 28 04:39:44.824846 containerd[1504]: time="2025-10-28T04:39:44.824729720Z" level=info msg="Start recovering state" Oct 28 04:39:44.824846 containerd[1504]: time="2025-10-28T04:39:44.824577600Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 28 04:39:44.824846 containerd[1504]: time="2025-10-28T04:39:44.824834400Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 28 04:39:44.825264 containerd[1504]: time="2025-10-28T04:39:44.825074000Z" level=info msg="Start event monitor" Oct 28 04:39:44.825264 containerd[1504]: time="2025-10-28T04:39:44.825121640Z" level=info msg="Start cni network conf syncer for default" Oct 28 04:39:44.825264 containerd[1504]: time="2025-10-28T04:39:44.825133480Z" level=info msg="Start streaming server" Oct 28 04:39:44.825790 containerd[1504]: time="2025-10-28T04:39:44.825758360Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 28 04:39:44.825790 containerd[1504]: time="2025-10-28T04:39:44.825781560Z" level=info msg="runtime interface starting up..." Oct 28 04:39:44.825860 containerd[1504]: time="2025-10-28T04:39:44.825793880Z" level=info msg="starting plugins..." Oct 28 04:39:44.825860 containerd[1504]: time="2025-10-28T04:39:44.825816760Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 28 04:39:44.826916 containerd[1504]: time="2025-10-28T04:39:44.825965000Z" level=info msg="containerd successfully booted in 0.094009s" Oct 28 04:39:44.826979 systemd[1]: Started containerd.service - containerd container runtime. Oct 28 04:39:45.680623 sshd_keygen[1491]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 28 04:39:45.699709 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 28 04:39:45.703506 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 28 04:39:45.722454 systemd[1]: issuegen.service: Deactivated successfully. Oct 28 04:39:45.722682 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 28 04:39:45.725532 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 28 04:39:45.748534 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 28 04:39:45.752180 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 28 04:39:45.754579 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 28 04:39:45.756142 systemd[1]: Reached target getty.target - Login Prompts. Oct 28 04:39:46.158087 systemd-networkd[1410]: eth0: Gained IPv6LL Oct 28 04:39:46.160326 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 28 04:39:46.162194 systemd[1]: Reached target network-online.target - Network is Online. Oct 28 04:39:46.166338 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 28 04:39:46.168424 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 28 04:39:46.206301 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 28 04:39:46.214521 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 28 04:39:46.214751 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 28 04:39:46.216483 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 28 04:39:46.216610 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 28 04:39:46.217916 systemd[1]: Startup finished in 1.191s (kernel) + 3.886s (initrd) + 3.268s (userspace) = 8.347s. Oct 28 04:39:50.833795 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 28 04:39:50.834788 systemd[1]: Started sshd@0-10.0.0.58:22-10.0.0.1:33828.service - OpenSSH per-connection server daemon (10.0.0.1:33828). Oct 28 04:39:50.902307 sshd[1594]: Accepted publickey for core from 10.0.0.1 port 33828 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:50.904481 sshd-session[1594]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:50.910816 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 28 04:39:50.911756 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 28 04:39:50.919298 systemd-logind[1477]: New session 1 of user core. Oct 28 04:39:50.927846 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 28 04:39:50.930583 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 28 04:39:50.966845 (systemd)[1599]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 28 04:39:50.970137 systemd-logind[1477]: New session c1 of user core. Oct 28 04:39:51.078128 systemd[1599]: Queued start job for default target default.target. Oct 28 04:39:51.095763 systemd[1599]: Created slice app.slice - User Application Slice. Oct 28 04:39:51.095789 systemd[1599]: Reached target paths.target - Paths. Oct 28 04:39:51.095960 systemd[1599]: Reached target timers.target - Timers. Oct 28 04:39:51.097158 systemd[1599]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 28 04:39:51.106074 systemd[1599]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 28 04:39:51.106130 systemd[1599]: Reached target sockets.target - Sockets. Oct 28 04:39:51.106173 systemd[1599]: Reached target basic.target - Basic System. Oct 28 04:39:51.106204 systemd[1599]: Reached target default.target - Main User Target. Oct 28 04:39:51.106228 systemd[1599]: Startup finished in 130ms. Oct 28 04:39:51.106404 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 28 04:39:51.109374 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 28 04:39:51.123146 systemd[1]: Started sshd@1-10.0.0.58:22-10.0.0.1:33832.service - OpenSSH per-connection server daemon (10.0.0.1:33832). Oct 28 04:39:51.177364 sshd[1610]: Accepted publickey for core from 10.0.0.1 port 33832 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.178849 sshd-session[1610]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.183115 systemd-logind[1477]: New session 2 of user core. Oct 28 04:39:51.197401 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 28 04:39:51.206769 sshd[1613]: Connection closed by 10.0.0.1 port 33832 Oct 28 04:39:51.207163 sshd-session[1610]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:51.210747 systemd[1]: sshd@1-10.0.0.58:22-10.0.0.1:33832.service: Deactivated successfully. Oct 28 04:39:51.212099 systemd[1]: session-2.scope: Deactivated successfully. Oct 28 04:39:51.214406 systemd-logind[1477]: Session 2 logged out. Waiting for processes to exit. Oct 28 04:39:51.215642 systemd[1]: Started sshd@2-10.0.0.58:22-10.0.0.1:33834.service - OpenSSH per-connection server daemon (10.0.0.1:33834). Oct 28 04:39:51.216796 systemd-logind[1477]: Removed session 2. Oct 28 04:39:51.270258 sshd[1619]: Accepted publickey for core from 10.0.0.1 port 33834 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.271382 sshd-session[1619]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.275969 systemd-logind[1477]: New session 3 of user core. Oct 28 04:39:51.294137 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 28 04:39:51.301440 sshd[1622]: Connection closed by 10.0.0.1 port 33834 Oct 28 04:39:51.301832 sshd-session[1619]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:51.307438 systemd[1]: sshd@2-10.0.0.58:22-10.0.0.1:33834.service: Deactivated successfully. Oct 28 04:39:51.309040 systemd[1]: session-3.scope: Deactivated successfully. Oct 28 04:39:51.311408 systemd-logind[1477]: Session 3 logged out. Waiting for processes to exit. Oct 28 04:39:51.313561 systemd[1]: Started sshd@3-10.0.0.58:22-10.0.0.1:33846.service - OpenSSH per-connection server daemon (10.0.0.1:33846). Oct 28 04:39:51.314038 systemd-logind[1477]: Removed session 3. Oct 28 04:39:51.367132 sshd[1628]: Accepted publickey for core from 10.0.0.1 port 33846 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.368686 sshd-session[1628]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.372462 systemd-logind[1477]: New session 4 of user core. Oct 28 04:39:51.389085 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 28 04:39:51.399972 sshd[1631]: Connection closed by 10.0.0.1 port 33846 Oct 28 04:39:51.399830 sshd-session[1628]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:51.412702 systemd[1]: sshd@3-10.0.0.58:22-10.0.0.1:33846.service: Deactivated successfully. Oct 28 04:39:51.415125 systemd[1]: session-4.scope: Deactivated successfully. Oct 28 04:39:51.416450 systemd-logind[1477]: Session 4 logged out. Waiting for processes to exit. Oct 28 04:39:51.418187 systemd[1]: Started sshd@4-10.0.0.58:22-10.0.0.1:33850.service - OpenSSH per-connection server daemon (10.0.0.1:33850). Oct 28 04:39:51.419014 systemd-logind[1477]: Removed session 4. Oct 28 04:39:51.478661 sshd[1637]: Accepted publickey for core from 10.0.0.1 port 33850 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.479916 sshd-session[1637]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.485410 systemd-logind[1477]: New session 5 of user core. Oct 28 04:39:51.491123 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 28 04:39:51.508753 sudo[1642]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 28 04:39:51.509297 sudo[1642]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:39:51.526832 sudo[1642]: pam_unix(sudo:session): session closed for user root Oct 28 04:39:51.528687 sshd[1641]: Connection closed by 10.0.0.1 port 33850 Oct 28 04:39:51.529138 sshd-session[1637]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:51.542995 systemd[1]: sshd@4-10.0.0.58:22-10.0.0.1:33850.service: Deactivated successfully. Oct 28 04:39:51.545388 systemd[1]: session-5.scope: Deactivated successfully. Oct 28 04:39:51.546148 systemd-logind[1477]: Session 5 logged out. Waiting for processes to exit. Oct 28 04:39:51.550093 systemd[1]: Started sshd@5-10.0.0.58:22-10.0.0.1:33866.service - OpenSSH per-connection server daemon (10.0.0.1:33866). Oct 28 04:39:51.550791 systemd-logind[1477]: Removed session 5. Oct 28 04:39:51.603359 sshd[1648]: Accepted publickey for core from 10.0.0.1 port 33866 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.604751 sshd-session[1648]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.609358 systemd-logind[1477]: New session 6 of user core. Oct 28 04:39:51.615071 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 28 04:39:51.626814 sudo[1653]: 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 Oct 28 04:39:51.627524 sudo[1653]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:39:51.632846 sudo[1653]: pam_unix(sudo:session): session closed for user root Oct 28 04:39:51.639403 sudo[1652]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 28 04:39:51.639660 sudo[1652]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:39:51.648323 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 28 04:39:51.685301 augenrules[1675]: No rules Oct 28 04:39:51.686589 systemd[1]: audit-rules.service: Deactivated successfully. Oct 28 04:39:51.687945 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 28 04:39:51.689565 sudo[1652]: pam_unix(sudo:session): session closed for user root Oct 28 04:39:51.691406 sshd[1651]: Connection closed by 10.0.0.1 port 33866 Oct 28 04:39:51.691835 sshd-session[1648]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:51.704046 systemd[1]: sshd@5-10.0.0.58:22-10.0.0.1:33866.service: Deactivated successfully. Oct 28 04:39:51.705476 systemd[1]: session-6.scope: Deactivated successfully. Oct 28 04:39:51.706288 systemd-logind[1477]: Session 6 logged out. Waiting for processes to exit. Oct 28 04:39:51.709242 systemd[1]: Started sshd@6-10.0.0.58:22-10.0.0.1:33878.service - OpenSSH per-connection server daemon (10.0.0.1:33878). Oct 28 04:39:51.709881 systemd-logind[1477]: Removed session 6. Oct 28 04:39:51.761869 sshd[1684]: Accepted publickey for core from 10.0.0.1 port 33878 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:51.763093 sshd-session[1684]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:51.767674 systemd-logind[1477]: New session 7 of user core. Oct 28 04:39:51.783117 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 28 04:39:51.796322 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 28 04:39:51.815210 (dockerd)[1689]: 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 Oct 28 04:39:52.016268 dockerd[1689]: time="2025-10-28T04:39:52.016132401Z" level=info msg="Starting up" Oct 28 04:39:52.017766 dockerd[1689]: time="2025-10-28T04:39:52.017735030Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 28 04:39:52.027979 dockerd[1689]: time="2025-10-28T04:39:52.027939723Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 28 04:39:52.065556 dockerd[1689]: time="2025-10-28T04:39:52.065505811Z" level=info msg="Loading containers: start." Oct 28 04:39:52.073941 kernel: Initializing XFRM netlink socket Oct 28 04:39:52.265084 systemd-networkd[1410]: docker0: Link UP Oct 28 04:39:52.269000 dockerd[1689]: time="2025-10-28T04:39:52.268878658Z" level=info msg="Loading containers: done." Oct 28 04:39:52.282175 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck55734840-merged.mount: Deactivated successfully. Oct 28 04:39:52.285869 dockerd[1689]: time="2025-10-28T04:39:52.285484535Z" 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 Oct 28 04:39:52.285869 dockerd[1689]: time="2025-10-28T04:39:52.285574160Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 28 04:39:52.285869 dockerd[1689]: time="2025-10-28T04:39:52.285721269Z" level=info msg="Initializing buildkit" Oct 28 04:39:52.311128 dockerd[1689]: time="2025-10-28T04:39:52.311076320Z" level=info msg="Completed buildkit initialization" Oct 28 04:39:52.315938 dockerd[1689]: time="2025-10-28T04:39:52.315881995Z" level=info msg="Daemon has completed initialization" Oct 28 04:39:52.316202 dockerd[1689]: time="2025-10-28T04:39:52.316088921Z" level=info msg="API listen on /run/docker.sock" Oct 28 04:39:52.316203 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 28 04:39:52.325188 sshd[1687]: Connection closed by 10.0.0.1 port 33878 Oct 28 04:39:52.325839 sshd-session[1684]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:52.344004 systemd[1]: sshd@6-10.0.0.58:22-10.0.0.1:33878.service: Deactivated successfully. Oct 28 04:39:52.345573 systemd[1]: session-7.scope: Deactivated successfully. Oct 28 04:39:52.346334 systemd-logind[1477]: Session 7 logged out. Waiting for processes to exit. Oct 28 04:39:52.348420 systemd[1]: Started sshd@7-10.0.0.58:22-10.0.0.1:33890.service - OpenSSH per-connection server daemon (10.0.0.1:33890). Oct 28 04:39:52.349122 systemd-logind[1477]: Removed session 7. Oct 28 04:39:52.406256 sshd[1906]: Accepted publickey for core from 10.0.0.1 port 33890 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:52.407493 sshd-session[1906]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:52.411390 systemd-logind[1477]: New session 8 of user core. Oct 28 04:39:52.423078 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 28 04:39:53.520716 systemd[1]: var-lib-docker-overlay2-170967002c712bf99faa42b621b82d1dadadb0b85c8ba54ac4d30e6cc7b10ca8\x2dinit-merged.mount: Deactivated successfully. Oct 28 04:39:53.557613 containerd[1504]: time="2025-10-28T04:39:53.557549747Z" level=info msg="connecting to shim 0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c" address="unix:///run/containerd/s/30c14f3329f0882f24ddfc8824cfb14edc0057d2d4c55fff05c5d6271a105e9c" namespace=moby protocol=ttrpc version=3 Oct 28 04:39:53.581051 systemd[1]: Started docker-0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c.scope - libcontainer container 0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c. Oct 28 04:39:53.593045 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 28 04:39:53.613492 kernel: docker0: port 1(veth52c626d) entered blocking state Oct 28 04:39:53.613586 kernel: docker0: port 1(veth52c626d) entered disabled state Oct 28 04:39:53.613603 kernel: veth52c626d: entered allmulticast mode Oct 28 04:39:53.615905 kernel: veth52c626d: entered promiscuous mode Oct 28 04:39:53.616710 systemd-networkd[1410]: veth52c626d: Link UP Oct 28 04:39:53.622902 kernel: eth0: renamed from veth028272e Oct 28 04:39:53.624376 kernel: docker0: port 1(veth52c626d) entered blocking state Oct 28 04:39:53.624409 kernel: docker0: port 1(veth52c626d) entered forwarding state Oct 28 04:39:53.624440 systemd-networkd[1410]: veth52c626d: Gained carrier Oct 28 04:39:53.624848 systemd-networkd[1410]: docker0: Gained carrier Oct 28 04:39:53.648459 sshd[1909]: Connection closed by 10.0.0.1 port 33890 Oct 28 04:39:53.647936 sshd-session[1906]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:53.663789 systemd[1]: sshd@7-10.0.0.58:22-10.0.0.1:33890.service: Deactivated successfully. Oct 28 04:39:53.665206 systemd[1]: session-8.scope: Deactivated successfully. Oct 28 04:39:53.665825 systemd-logind[1477]: Session 8 logged out. Waiting for processes to exit. Oct 28 04:39:53.667988 systemd[1]: Started sshd@8-10.0.0.58:22-10.0.0.1:33900.service - OpenSSH per-connection server daemon (10.0.0.1:33900). Oct 28 04:39:53.669456 systemd-logind[1477]: Removed session 8. Oct 28 04:39:53.728911 sshd[1984]: Accepted publickey for core from 10.0.0.1 port 33900 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:53.730212 sshd-session[1984]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:53.734850 systemd-logind[1477]: New session 9 of user core. Oct 28 04:39:53.745071 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 28 04:39:53.757662 sshd[1987]: Connection closed by 10.0.0.1 port 33900 Oct 28 04:39:53.757938 sshd-session[1984]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:53.767696 systemd[1]: sshd@8-10.0.0.58:22-10.0.0.1:33900.service: Deactivated successfully. Oct 28 04:39:53.770069 systemd[1]: session-9.scope: Deactivated successfully. Oct 28 04:39:53.771175 systemd-logind[1477]: Session 9 logged out. Waiting for processes to exit. Oct 28 04:39:53.772737 systemd[1]: Started sshd@9-10.0.0.58:22-10.0.0.1:33908.service - OpenSSH per-connection server daemon (10.0.0.1:33908). Oct 28 04:39:53.773533 systemd-logind[1477]: Removed session 9. Oct 28 04:39:53.821801 sshd[1993]: Accepted publickey for core from 10.0.0.1 port 33908 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:53.822952 sshd-session[1993]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:53.826818 systemd-logind[1477]: New session 10 of user core. Oct 28 04:39:53.841026 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 28 04:39:53.850930 sudo[1997]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1504 Oct 28 04:39:53.851188 sudo[1997]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:39:53.854700 dockerd[1689]: time="2025-10-28T04:39:53.854561564Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 28 04:39:53.854700 dockerd[1689]: time="2025-10-28T04:39:53.854600168Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 28 04:39:53.854700 dockerd[1689]: time="2025-10-28T04:39:53.854576081Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 28 04:39:53.855015 containerd[1504]: time="2025-10-28T04:39:53.854376627Z" level=info msg="Stop CRI service" Oct 28 04:39:53.855015 containerd[1504]: time="2025-10-28T04:39:53.854769824Z" level=info msg="Stop CRI service" Oct 28 04:39:53.855015 containerd[1504]: time="2025-10-28T04:39:53.854819929Z" level=info msg="Event monitor stopped" Oct 28 04:39:53.855015 containerd[1504]: time="2025-10-28T04:39:53.854825639Z" level=info msg="Stream server stopped" Oct 28 04:39:53.855097 dockerd[1689]: time="2025-10-28T04:39:53.854769945Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 28 04:39:53.855058 sudo[1997]: pam_unix(sudo:session): session closed for user root Oct 28 04:39:53.856393 sshd[1996]: Connection closed by 10.0.0.1 port 33908 Oct 28 04:39:53.856801 sshd-session[1993]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:53.867663 systemd[1]: containerd.service: Deactivated successfully. Oct 28 04:39:53.867879 systemd[1]: containerd.service: Unit process 1934 (containerd-shim) remains running after unit stopped. Oct 28 04:39:53.868183 systemd[1]: containerd.service: Consumed 284ms CPU time, 121.4M memory peak. Oct 28 04:39:53.868637 systemd[1]: sshd@9-10.0.0.58:22-10.0.0.1:33908.service: Deactivated successfully. Oct 28 04:39:53.870136 systemd[1]: session-10.scope: Deactivated successfully. Oct 28 04:39:53.871357 systemd-logind[1477]: Session 10 logged out. Waiting for processes to exit. Oct 28 04:39:53.873773 systemd[1]: Started sshd@10-10.0.0.58:22-10.0.0.1:33918.service - OpenSSH per-connection server daemon (10.0.0.1:33918). Oct 28 04:39:53.874330 systemd-logind[1477]: Removed session 10. Oct 28 04:39:53.926634 sshd[2004]: Accepted publickey for core from 10.0.0.1 port 33918 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:39:53.927760 sshd-session[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:39:53.931319 systemd-logind[1477]: New session 11 of user core. Oct 28 04:39:53.945093 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 28 04:39:53.956927 sshd[2007]: Connection closed by 10.0.0.1 port 33918 Oct 28 04:39:53.957033 sshd-session[2004]: pam_unix(sshd:session): session closed for user core Oct 28 04:39:53.960303 systemd[1]: sshd@10-10.0.0.58:22-10.0.0.1:33918.service: Deactivated successfully. Oct 28 04:39:53.963136 systemd[1]: session-11.scope: Deactivated successfully. Oct 28 04:39:53.963742 systemd-logind[1477]: Session 11 logged out. Waiting for processes to exit. Oct 28 04:39:53.964576 systemd-logind[1477]: Removed session 11. Oct 28 04:39:54.798057 systemd-networkd[1410]: docker0: Gained IPv6LL Oct 28 04:39:55.182056 systemd-networkd[1410]: veth52c626d: Gained IPv6LL Oct 28 04:39:59.123258 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Oct 28 04:39:59.123665 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 28 04:39:59.123920 dockerd[1689]: time="2025-10-28T04:39:59.123825026Z" level=info msg="Processing signal 'terminated'" Oct 28 04:40:00.002126 systemd[1]: Started sshd@11-10.0.0.58:22-10.0.0.1:48394.service - OpenSSH per-connection server daemon (10.0.0.1:48394). Oct 28 04:40:00.065182 sshd[2013]: Accepted publickey for core from 10.0.0.1 port 48394 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:00.066340 sshd-session[2013]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:00.069746 systemd-logind[1477]: New session 12 of user core. Oct 28 04:40:00.079103 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 28 04:40:00.091855 sshd[2016]: Connection closed by 10.0.0.1 port 48394 Oct 28 04:40:00.092143 sshd-session[2013]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:00.095537 systemd[1]: sshd@11-10.0.0.58:22-10.0.0.1:48394.service: Deactivated successfully. Oct 28 04:40:00.097375 systemd[1]: session-12.scope: Deactivated successfully. Oct 28 04:40:00.098726 systemd-logind[1477]: Session 12 logged out. Waiting for processes to exit. Oct 28 04:40:00.100423 systemd-logind[1477]: Removed session 12. Oct 28 04:40:06.121145 systemd[1]: Started sshd@12-10.0.0.58:22-10.0.0.1:48400.service - OpenSSH per-connection server daemon (10.0.0.1:48400). Oct 28 04:40:06.164571 sshd[2022]: Accepted publickey for core from 10.0.0.1 port 48400 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:06.165946 sshd-session[2022]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:06.177479 systemd-logind[1477]: New session 13 of user core. Oct 28 04:40:06.193073 systemd[1]: Started session-13.scope - Session 13 of User core. Oct 28 04:40:06.212617 sshd[2025]: Connection closed by 10.0.0.1 port 48400 Oct 28 04:40:06.211619 sshd-session[2022]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:06.218680 systemd[1]: sshd@12-10.0.0.58:22-10.0.0.1:48400.service: Deactivated successfully. Oct 28 04:40:06.220531 systemd[1]: session-13.scope: Deactivated successfully. Oct 28 04:40:06.222567 systemd-logind[1477]: Session 13 logged out. Waiting for processes to exit. Oct 28 04:40:06.223449 systemd-logind[1477]: Removed session 13. Oct 28 04:40:12.236607 systemd[1]: Started sshd@13-10.0.0.58:22-10.0.0.1:37702.service - OpenSSH per-connection server daemon (10.0.0.1:37702). Oct 28 04:40:12.279893 sshd[2031]: Accepted publickey for core from 10.0.0.1 port 37702 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:12.281206 sshd-session[2031]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:12.285709 systemd-logind[1477]: New session 14 of user core. Oct 28 04:40:12.297080 systemd[1]: Started session-14.scope - Session 14 of User core. Oct 28 04:40:12.310029 sshd[2034]: Connection closed by 10.0.0.1 port 37702 Oct 28 04:40:12.309970 sshd-session[2031]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:12.313482 systemd[1]: sshd@13-10.0.0.58:22-10.0.0.1:37702.service: Deactivated successfully. Oct 28 04:40:12.314863 systemd[1]: session-14.scope: Deactivated successfully. Oct 28 04:40:12.315545 systemd-logind[1477]: Session 14 logged out. Waiting for processes to exit. Oct 28 04:40:12.316318 systemd-logind[1477]: Removed session 14. Oct 28 04:40:14.124468 dockerd[1689]: time="2025-10-28T04:40:14.124407880Z" level=error msg="Force shutdown daemon" Oct 28 04:40:14.124830 dockerd[1689]: time="2025-10-28T04:40:14.124540421Z" level=info msg="Daemon shutdown complete" Oct 28 04:40:14.127261 systemd[1]: docker.service: Deactivated successfully. Oct 28 04:40:14.127561 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 28 04:40:14.127629 systemd[1]: docker.service: Consumed 892ms CPU time, 121.3M memory peak. Oct 28 04:40:14.128041 systemd[1]: docker.socket: Deactivated successfully. Oct 28 04:40:14.128367 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 28 04:40:14.128404 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 28 04:40:14.129812 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 28 04:40:14.129985 systemd[1]: containerd.service: Found left-over process 1934 (containerd-shim) in control group while starting unit. Ignoring. Oct 28 04:40:14.129987 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 28 04:40:14.135296 systemd[1]: Starting containerd.service - containerd container runtime... Oct 28 04:40:14.135684 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 28 04:40:14.146692 systemd[1]: containerd.service: Found left-over process 1934 (containerd-shim) in control group while starting unit. Ignoring. Oct 28 04:40:14.146704 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 28 04:40:14.164965 containerd[2045]: time="2025-10-28T04:40:14Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 28 04:40:14.165412 containerd[2045]: time="2025-10-28T04:40:14.165377120Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 28 04:40:14.173716 containerd[2045]: time="2025-10-28T04:40:14.173477961Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="12.056µs" Oct 28 04:40:14.173716 containerd[2045]: time="2025-10-28T04:40:14.173531474Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 28 04:40:14.173716 containerd[2045]: time="2025-10-28T04:40:14.173559513Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 28 04:40:14.173716 containerd[2045]: time="2025-10-28T04:40:14.173605656Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 28 04:40:14.173716 containerd[2045]: time="2025-10-28T04:40:14.173624081Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 28 04:40:14.174050 containerd[2045]: time="2025-10-28T04:40:14.174017619Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174095 containerd[2045]: time="2025-10-28T04:40:14.174075619Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174118 containerd[2045]: time="2025-10-28T04:40:14.174097088Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174379 containerd[2045]: time="2025-10-28T04:40:14.174334653Z" 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 Oct 28 04:40:14.174379 containerd[2045]: time="2025-10-28T04:40:14.174359887Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174379 containerd[2045]: time="2025-10-28T04:40:14.174376310Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174445 containerd[2045]: time="2025-10-28T04:40:14.174386123Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174445 containerd[2045]: time="2025-10-28T04:40:14.174419489Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174541 containerd[2045]: time="2025-10-28T04:40:14.174519946Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 28 04:40:14.174574 containerd[2045]: time="2025-10-28T04:40:14.174551910Z" 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 Oct 28 04:40:14.174574 containerd[2045]: time="2025-10-28T04:40:14.174566730Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 28 04:40:14.174622 containerd[2045]: time="2025-10-28T04:40:14.174606385Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 28 04:40:14.175048 containerd[2045]: time="2025-10-28T04:40:14.175007053Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 28 04:40:14.175048 containerd[2045]: time="2025-10-28T04:40:14.175046627Z" level=info msg="metadata content store policy set" policy=shared Oct 28 04:40:14.175216 containerd[2045]: time="2025-10-28T04:40:14.175198915Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 28 04:40:14.175266 containerd[2045]: time="2025-10-28T04:40:14.175234564Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 28 04:40:14.175266 containerd[2045]: time="2025-10-28T04:40:14.175246981Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 28 04:40:14.175336 containerd[2045]: time="2025-10-28T04:40:14.175277943Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 28 04:40:14.175336 containerd[2045]: time="2025-10-28T04:40:14.175293004Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 28 04:40:14.175336 containerd[2045]: time="2025-10-28T04:40:14.175304580Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 28 04:40:14.175336 containerd[2045]: time="2025-10-28T04:40:14.175316997Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 28 04:40:14.175336 containerd[2045]: time="2025-10-28T04:40:14.175328693Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 28 04:40:14.175436 containerd[2045]: time="2025-10-28T04:40:14.175338706Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 28 04:40:14.175436 containerd[2045]: time="2025-10-28T04:40:14.175349000Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 28 04:40:14.175436 containerd[2045]: time="2025-10-28T04:40:14.175358333Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 28 04:40:14.175436 containerd[2045]: time="2025-10-28T04:40:14.175377079Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 28 04:40:14.175606 containerd[2045]: time="2025-10-28T04:40:14.175583561Z" level=info msg="connecting to shim 0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c" address="unix:///run/containerd/s/30c14f3329f0882f24ddfc8824cfb14edc0057d2d4c55fff05c5d6271a105e9c" namespace=moby protocol=ttrpc version=3 Oct 28 04:40:14.182860 containerd[2045]: time="2025-10-28T04:40:14.182808043Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 28 04:40:14.182860 containerd[2045]: time="2025-10-28T04:40:14.182865522Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182896484Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182916352Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182928688Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182938902Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182954684Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 28 04:40:14.182974 containerd[2045]: time="2025-10-28T04:40:14.182966140Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 28 04:40:14.183095 containerd[2045]: time="2025-10-28T04:40:14.182978557Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 28 04:40:14.183095 containerd[2045]: time="2025-10-28T04:40:14.182998144Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 28 04:40:14.183095 containerd[2045]: time="2025-10-28T04:40:14.183010801Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 28 04:40:14.183095 containerd[2045]: time="2025-10-28T04:40:14.183077172Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 28 04:40:14.183095 containerd[2045]: time="2025-10-28T04:40:14.183092232Z" level=info msg="Start snapshots syncer" Oct 28 04:40:14.183197 containerd[2045]: time="2025-10-28T04:40:14.183124677Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 28 04:40:14.183375 containerd[2045]: time="2025-10-28T04:40:14.183337648Z" 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\"}" Oct 28 04:40:14.183520 containerd[2045]: time="2025-10-28T04:40:14.183390160Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 28 04:40:14.183520 containerd[2045]: time="2025-10-28T04:40:14.183459735Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 28 04:40:14.183561 containerd[2045]: time="2025-10-28T04:40:14.183512367Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 28 04:40:14.183561 containerd[2045]: time="2025-10-28T04:40:14.183542608Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 28 04:40:14.183561 containerd[2045]: time="2025-10-28T04:40:14.183553263Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 28 04:40:14.183610 containerd[2045]: time="2025-10-28T04:40:14.183563397Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 28 04:40:14.183610 containerd[2045]: time="2025-10-28T04:40:14.183574252Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 28 04:40:14.183610 containerd[2045]: time="2025-10-28T04:40:14.183584225Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 28 04:40:14.183610 containerd[2045]: time="2025-10-28T04:40:14.183595481Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 28 04:40:14.183677 containerd[2045]: time="2025-10-28T04:40:14.183625522Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 28 04:40:14.183677 containerd[2045]: time="2025-10-28T04:40:14.183638860Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 28 04:40:14.183677 containerd[2045]: time="2025-10-28T04:40:14.183652238Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 28 04:40:14.183726 containerd[2045]: time="2025-10-28T04:40:14.183682840Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 28 04:40:14.183726 containerd[2045]: time="2025-10-28T04:40:14.183697941Z" 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 Oct 28 04:40:14.183726 containerd[2045]: time="2025-10-28T04:40:14.183706833Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:14.183726 containerd[2045]: time="2025-10-28T04:40:14.183716446Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:14.183726 containerd[2045]: time="2025-10-28T04:40:14.183724297Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183742602Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183755580Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183772923Z" level=info msg="runtime interface created" Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183778010Z" level=info msg="created NRI interface" Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183786181Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 28 04:40:14.183812 containerd[2045]: time="2025-10-28T04:40:14.183801402Z" level=info msg="Connect containerd service" Oct 28 04:40:14.183920 containerd[2045]: time="2025-10-28T04:40:14.183828880Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 28 04:40:14.184538 containerd[2045]: time="2025-10-28T04:40:14.184447005Z" 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" Oct 28 04:40:14.194894 containerd[2045]: time="2025-10-28T04:40:14.194834094Z" level=info msg="Start subscribing containerd event" Oct 28 04:40:14.195019 containerd[2045]: time="2025-10-28T04:40:14.194915966Z" level=info msg="Start recovering state" Oct 28 04:40:14.195019 containerd[2045]: time="2025-10-28T04:40:14.194961989Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 28 04:40:14.195019 containerd[2045]: time="2025-10-28T04:40:14.195015502Z" level=info msg="Start event monitor" Oct 28 04:40:14.195075 containerd[2045]: time="2025-10-28T04:40:14.195018866Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 28 04:40:14.195075 containerd[2045]: time="2025-10-28T04:40:14.195029321Z" level=info msg="Start cni network conf syncer for default" Oct 28 04:40:14.195075 containerd[2045]: time="2025-10-28T04:40:14.195059522Z" level=info msg="Start streaming server" Oct 28 04:40:14.195128 containerd[2045]: time="2025-10-28T04:40:14.195076505Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 28 04:40:14.195128 containerd[2045]: time="2025-10-28T04:40:14.195086519Z" level=info msg="runtime interface starting up..." Oct 28 04:40:14.195128 containerd[2045]: time="2025-10-28T04:40:14.195092647Z" level=info msg="starting plugins..." Oct 28 04:40:14.195128 containerd[2045]: time="2025-10-28T04:40:14.195102060Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 28 04:40:14.196947 containerd[2045]: time="2025-10-28T04:40:14.195237365Z" level=info msg="containerd successfully booted in 0.030475s" Oct 28 04:40:14.195371 systemd[1]: Started containerd.service - containerd container runtime. Oct 28 04:40:14.198081 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 28 04:40:14.207216 (dockerd)[2073]: 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 Oct 28 04:40:14.235176 dockerd[2073]: time="2025-10-28T04:40:14.235118197Z" level=info msg="Starting up" Oct 28 04:40:14.235748 dockerd[2073]: time="2025-10-28T04:40:14.235728272Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 28 04:40:14.245561 dockerd[2073]: time="2025-10-28T04:40:14.245484337Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 28 04:40:14.261519 dockerd[2073]: time="2025-10-28T04:40:14.261485745Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 28 04:40:14.269035 dockerd[2073]: time="2025-10-28T04:40:14.268837401Z" level=info msg="Loading containers: start." Oct 28 04:40:18.332693 systemd[1]: Started sshd@14-10.0.0.58:22-10.0.0.1:37710.service - OpenSSH per-connection server daemon (10.0.0.1:37710). Oct 28 04:40:18.383312 sshd[2107]: Accepted publickey for core from 10.0.0.1 port 37710 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:18.384206 sshd-session[2107]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:18.389679 systemd-logind[1477]: New session 15 of user core. Oct 28 04:40:18.402031 systemd[1]: Started session-15.scope - Session 15 of User core. Oct 28 04:40:18.424765 sshd[2110]: Connection closed by 10.0.0.1 port 37710 Oct 28 04:40:18.425098 sshd-session[2107]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:18.434155 systemd[1]: sshd@14-10.0.0.58:22-10.0.0.1:37710.service: Deactivated successfully. Oct 28 04:40:18.436530 systemd[1]: session-15.scope: Deactivated successfully. Oct 28 04:40:18.438027 systemd-logind[1477]: Session 15 logged out. Waiting for processes to exit. Oct 28 04:40:18.439153 systemd-logind[1477]: Removed session 15. Oct 28 04:40:18.442197 systemd[1]: Started sshd@15-10.0.0.58:22-10.0.0.1:37716.service - OpenSSH per-connection server daemon (10.0.0.1:37716). Oct 28 04:40:18.492494 sshd[2116]: Accepted publickey for core from 10.0.0.1 port 37716 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:18.493293 sshd-session[2116]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:18.496951 systemd-logind[1477]: New session 16 of user core. Oct 28 04:40:18.514298 systemd[1]: Started session-16.scope - Session 16 of User core. Oct 28 04:40:18.528627 sshd[2119]: Connection closed by 10.0.0.1 port 37716 Oct 28 04:40:18.530301 sshd-session[2116]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:18.544080 systemd[1]: sshd@15-10.0.0.58:22-10.0.0.1:37716.service: Deactivated successfully. Oct 28 04:40:18.547312 systemd[1]: session-16.scope: Deactivated successfully. Oct 28 04:40:18.550379 systemd-logind[1477]: Session 16 logged out. Waiting for processes to exit. Oct 28 04:40:18.551573 systemd[1]: Started sshd@16-10.0.0.58:22-10.0.0.1:37732.service - OpenSSH per-connection server daemon (10.0.0.1:37732). Oct 28 04:40:18.553312 systemd-logind[1477]: Removed session 16. Oct 28 04:40:18.608904 sshd[2125]: Accepted publickey for core from 10.0.0.1 port 37732 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:18.610353 sshd-session[2125]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:18.614988 systemd-logind[1477]: New session 17 of user core. Oct 28 04:40:18.626571 systemd[1]: Started session-17.scope - Session 17 of User core. Oct 28 04:40:24.290620 dockerd[2073]: time="2025-10-28T04:40:24.290561316Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c Oct 28 04:40:24.300675 systemd[1]: docker-0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c.scope: Deactivated successfully. Oct 28 04:40:24.313383 dockerd[2073]: time="2025-10-28T04:40:24.313301601Z" level=info msg="ignoring event" container=0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 28 04:40:24.313899 containerd[2045]: time="2025-10-28T04:40:24.313500704Z" level=info msg="shim disconnected" id=0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c namespace=moby Oct 28 04:40:24.313899 containerd[2045]: time="2025-10-28T04:40:24.313584404Z" level=warning msg="cleaning up after shim disconnected" id=0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c namespace=moby Oct 28 04:40:24.313899 containerd[2045]: time="2025-10-28T04:40:24.313625633Z" level=info msg="cleaning up dead shim" namespace=moby Oct 28 04:40:24.326147 systemd[1]: var-lib-docker-overlay2-170967002c712bf99faa42b621b82d1dadadb0b85c8ba54ac4d30e6cc7b10ca8-merged.mount: Deactivated successfully. Oct 28 04:40:24.826385 systemd[1]: run-docker-netns-bb574b2c2399.mount: Deactivated successfully. Oct 28 04:40:24.830358 systemd-networkd[1410]: veth52c626d: Link DOWN Oct 28 04:40:24.832008 kernel: docker0: port 1(veth52c626d) entered disabled state Oct 28 04:40:24.830367 systemd-networkd[1410]: veth52c626d: Lost carrier Oct 28 04:40:24.834644 kernel: veth52c626d (unregistering): left allmulticast mode Oct 28 04:40:24.834714 kernel: veth52c626d (unregistering): left promiscuous mode Oct 28 04:40:24.835504 kernel: docker0: port 1(veth52c626d) entered disabled state Oct 28 04:40:24.836932 systemd-networkd[1410]: docker0: Lost carrier Oct 28 04:40:24.838755 dockerd[2073]: time="2025-10-28T04:40:24.837373052Z" level=info msg="Removing stale sandbox bb574b2c23996e5d08ea306310d3f2c0bdb3f4eb0f173513b3b2b78735bf3d9d (0a4ad608a83c34cc6670d6fa9f5d110691ab2eeecb8086a4d5ccf0f63f25aa2c)" Oct 28 04:40:24.840951 dockerd[2073]: time="2025-10-28T04:40:24.840923921Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 28 04:40:24.841111 dockerd[2073]: time="2025-10-28T04:40:24.841090961Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 38989f604bd9fe460c797c2eb28349ea83094df045e2fe4cc5d51a317a8b44bb 864e90b6b04c84e2d945f46a3bfd401095588d472888d7d90a6c9b77558bb738], retrying...." Oct 28 04:40:24.844072 systemd[1]: run-docker-netns-bb574b2c2399.mount: Deactivated successfully. Oct 28 04:40:25.055558 dockerd[2073]: time="2025-10-28T04:40:25.055488421Z" level=warning msg="error locating sandbox id bb574b2c23996e5d08ea306310d3f2c0bdb3f4eb0f173513b3b2b78735bf3d9d: sandbox bb574b2c23996e5d08ea306310d3f2c0bdb3f4eb0f173513b3b2b78735bf3d9d not found" Oct 28 04:40:25.055659 dockerd[2073]: time="2025-10-28T04:40:25.055634439Z" level=info msg="Loading containers: done." Oct 28 04:40:25.068821 dockerd[2073]: time="2025-10-28T04:40:25.068767117Z" 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 Oct 28 04:40:25.069008 dockerd[2073]: time="2025-10-28T04:40:25.068854056Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 28 04:40:25.069008 dockerd[2073]: time="2025-10-28T04:40:25.068920941Z" level=info msg="Initializing buildkit" Oct 28 04:40:25.088703 dockerd[2073]: time="2025-10-28T04:40:25.088572647Z" level=info msg="Completed buildkit initialization" Oct 28 04:40:25.093428 dockerd[2073]: time="2025-10-28T04:40:25.093384846Z" level=info msg="Daemon has completed initialization" Oct 28 04:40:25.093534 dockerd[2073]: time="2025-10-28T04:40:25.093462018Z" level=info msg="API listen on /run/docker.sock" Oct 28 04:40:25.094303 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 28 04:40:25.106975 sshd[2128]: Connection closed by 10.0.0.1 port 37732 Oct 28 04:40:25.107531 sshd-session[2125]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:25.120375 systemd[1]: sshd@16-10.0.0.58:22-10.0.0.1:37732.service: Deactivated successfully. Oct 28 04:40:25.123634 systemd[1]: session-17.scope: Deactivated successfully. Oct 28 04:40:25.126340 systemd-logind[1477]: Session 17 logged out. Waiting for processes to exit. Oct 28 04:40:25.128686 systemd[1]: Started sshd@17-10.0.0.58:22-10.0.0.1:47232.service - OpenSSH per-connection server daemon (10.0.0.1:47232). Oct 28 04:40:25.129467 systemd-logind[1477]: Removed session 17. Oct 28 04:40:25.198171 sshd[2379]: Accepted publickey for core from 10.0.0.1 port 47232 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:25.199416 sshd-session[2379]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:25.205129 systemd-logind[1477]: New session 18 of user core. Oct 28 04:40:25.215076 systemd[1]: Started session-18.scope - Session 18 of User core. Oct 28 04:40:25.290923 containerd[2045]: time="2025-10-28T04:40:25.289726869Z" level=info msg="connecting to shim 9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163" address="unix:///run/containerd/s/8c2c101f85f8ccd5a7346e864a5cbf3e0ba2b48d557cc853818fe7e1aa29f7e2" namespace=moby protocol=ttrpc version=3 Oct 28 04:40:25.319116 systemd[1]: Started docker-9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163.scope - libcontainer container 9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163. Oct 28 04:40:25.331549 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 28 04:40:25.346558 kernel: docker0: port 1(veth306fd7e) entered blocking state Oct 28 04:40:25.346648 kernel: docker0: port 1(veth306fd7e) entered disabled state Oct 28 04:40:25.346678 kernel: veth306fd7e: entered allmulticast mode Oct 28 04:40:25.346962 kernel: veth306fd7e: entered promiscuous mode Oct 28 04:40:25.347714 systemd-networkd[1410]: veth306fd7e: Link UP Oct 28 04:40:25.356003 kernel: eth0: renamed from veth4df8e4e Oct 28 04:40:25.356272 kernel: docker0: port 1(veth306fd7e) entered blocking state Oct 28 04:40:25.357600 kernel: docker0: port 1(veth306fd7e) entered forwarding state Oct 28 04:40:25.357878 systemd-networkd[1410]: veth306fd7e: Gained carrier Oct 28 04:40:25.358634 systemd-networkd[1410]: docker0: Gained carrier Oct 28 04:40:25.376411 sshd[2382]: Connection closed by 10.0.0.1 port 47232 Oct 28 04:40:25.376898 sshd-session[2379]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:25.385875 systemd[1]: sshd@17-10.0.0.58:22-10.0.0.1:47232.service: Deactivated successfully. Oct 28 04:40:25.387389 systemd[1]: session-18.scope: Deactivated successfully. Oct 28 04:40:25.388176 systemd-logind[1477]: Session 18 logged out. Waiting for processes to exit. Oct 28 04:40:25.391555 systemd[1]: Started sshd@18-10.0.0.58:22-10.0.0.1:47234.service - OpenSSH per-connection server daemon (10.0.0.1:47234). Oct 28 04:40:25.392224 systemd-logind[1477]: Removed session 18. Oct 28 04:40:25.443790 sshd[2449]: Accepted publickey for core from 10.0.0.1 port 47234 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:25.445019 sshd-session[2449]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:25.448966 systemd-logind[1477]: New session 19 of user core. Oct 28 04:40:25.458102 systemd[1]: Started session-19.scope - Session 19 of User core. Oct 28 04:40:25.471051 sshd[2452]: Connection closed by 10.0.0.1 port 47234 Oct 28 04:40:25.471515 sshd-session[2449]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:25.493025 systemd[1]: sshd@18-10.0.0.58:22-10.0.0.1:47234.service: Deactivated successfully. Oct 28 04:40:25.494613 systemd[1]: session-19.scope: Deactivated successfully. Oct 28 04:40:25.495411 systemd-logind[1477]: Session 19 logged out. Waiting for processes to exit. Oct 28 04:40:25.498111 systemd[1]: Started sshd@19-10.0.0.58:22-10.0.0.1:47238.service - OpenSSH per-connection server daemon (10.0.0.1:47238). Oct 28 04:40:25.499961 systemd-logind[1477]: Removed session 19. Oct 28 04:40:25.556616 sshd[2458]: Accepted publickey for core from 10.0.0.1 port 47238 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:25.558208 sshd-session[2458]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:25.562699 systemd-logind[1477]: New session 20 of user core. Oct 28 04:40:25.574071 systemd[1]: Started session-20.scope - Session 20 of User core. Oct 28 04:40:25.585619 sudo[2462]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2045 Oct 28 04:40:25.585872 sudo[2462]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 28 04:40:25.588772 sudo[2462]: pam_unix(sudo:session): session closed for user root Oct 28 04:40:25.590586 sshd[2461]: Connection closed by 10.0.0.1 port 47238 Oct 28 04:40:25.591357 dockerd[2073]: time="2025-10-28T04:40:25.590877911Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 28 04:40:25.591357 dockerd[2073]: time="2025-10-28T04:40:25.590928505Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 28 04:40:25.590934 sshd-session[2458]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:25.595152 dockerd[2073]: time="2025-10-28T04:40:25.595121207Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 28 04:40:25.595204 dockerd[2073]: time="2025-10-28T04:40:25.595152708Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 28 04:40:25.602856 systemd[1]: containerd.service: Deactivated successfully. Oct 28 04:40:25.602952 systemd[1]: containerd.service: Unit process 2399 (containerd-shim) remains running after unit stopped. Oct 28 04:40:25.603144 systemd[1]: containerd.service: Consumed 175ms CPU time, 121.6M memory peak. Oct 28 04:40:25.603640 systemd[1]: sshd@19-10.0.0.58:22-10.0.0.1:47238.service: Deactivated successfully. Oct 28 04:40:25.606598 systemd[1]: session-20.scope: Deactivated successfully. Oct 28 04:40:25.608770 systemd-logind[1477]: Session 20 logged out. Waiting for processes to exit. Oct 28 04:40:25.611340 systemd[1]: Started sshd@20-10.0.0.58:22-10.0.0.1:47244.service - OpenSSH per-connection server daemon (10.0.0.1:47244). Oct 28 04:40:25.612040 systemd-logind[1477]: Removed session 20. Oct 28 04:40:25.678991 sshd[2469]: Accepted publickey for core from 10.0.0.1 port 47244 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:25.680186 sshd-session[2469]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:25.684935 systemd-logind[1477]: New session 21 of user core. Oct 28 04:40:25.702082 systemd[1]: Started session-21.scope - Session 21 of User core. Oct 28 04:40:25.714768 sshd[2472]: Connection closed by 10.0.0.1 port 47244 Oct 28 04:40:25.714645 sshd-session[2469]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:25.718400 systemd[1]: sshd@20-10.0.0.58:22-10.0.0.1:47244.service: Deactivated successfully. Oct 28 04:40:25.720141 systemd[1]: session-21.scope: Deactivated successfully. Oct 28 04:40:25.720781 systemd-logind[1477]: Session 21 logged out. Waiting for processes to exit. Oct 28 04:40:25.721702 systemd-logind[1477]: Removed session 21. Oct 28 04:40:27.374034 systemd-networkd[1410]: veth306fd7e: Gained IPv6LL Oct 28 04:40:29.875651 update_engine[1481]: I20251028 04:40:29.875540 1481 update_attempter.cc:509] Updating boot flags... Oct 28 04:40:30.742685 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Oct 28 04:40:30.743055 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 28 04:40:30.743444 dockerd[2073]: time="2025-10-28T04:40:30.743181121Z" level=info msg="Processing signal 'terminated'" Oct 28 04:40:31.728870 systemd[1]: Started sshd@21-10.0.0.58:22-10.0.0.1:49730.service - OpenSSH per-connection server daemon (10.0.0.1:49730). Oct 28 04:40:31.791581 sshd[2496]: Accepted publickey for core from 10.0.0.1 port 49730 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:31.792759 sshd-session[2496]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:31.796213 systemd-logind[1477]: New session 22 of user core. Oct 28 04:40:31.815166 systemd[1]: Started session-22.scope - Session 22 of User core. Oct 28 04:40:31.826832 sshd[2499]: Connection closed by 10.0.0.1 port 49730 Oct 28 04:40:31.827128 sshd-session[2496]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:31.831392 systemd[1]: sshd@21-10.0.0.58:22-10.0.0.1:49730.service: Deactivated successfully. Oct 28 04:40:31.832919 systemd[1]: session-22.scope: Deactivated successfully. Oct 28 04:40:31.833527 systemd-logind[1477]: Session 22 logged out. Waiting for processes to exit. Oct 28 04:40:31.834611 systemd-logind[1477]: Removed session 22. Oct 28 04:40:32.744692 dockerd[2073]: time="2025-10-28T04:40:32.744628530Z" level=error msg="Error sending stop (signal 15) to container" container=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 error="Cannot kill container 9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Oct 28 04:40:32.744692 dockerd[2073]: time="2025-10-28T04:40:32.744686235Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 Oct 28 04:40:37.844465 systemd[1]: Started sshd@22-10.0.0.58:22-10.0.0.1:49776.service - OpenSSH per-connection server daemon (10.0.0.1:49776). Oct 28 04:40:37.919458 sshd[2505]: Accepted publickey for core from 10.0.0.1 port 49776 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:37.920827 sshd-session[2505]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:37.925688 systemd-logind[1477]: New session 23 of user core. Oct 28 04:40:37.937118 systemd[1]: Started session-23.scope - Session 23 of User core. Oct 28 04:40:37.949949 sshd[2508]: Connection closed by 10.0.0.1 port 49776 Oct 28 04:40:37.950155 sshd-session[2505]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:37.953867 systemd[1]: sshd@22-10.0.0.58:22-10.0.0.1:49776.service: Deactivated successfully. Oct 28 04:40:37.955532 systemd[1]: session-23.scope: Deactivated successfully. Oct 28 04:40:37.956456 systemd-logind[1477]: Session 23 logged out. Waiting for processes to exit. Oct 28 04:40:37.957365 systemd-logind[1477]: Removed session 23. Oct 28 04:40:42.747428 dockerd[2073]: time="2025-10-28T04:40:42.747128994Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 error="context deadline exceeded" Oct 28 04:40:42.747860 systemd[1]: docker-9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163.scope: Deactivated successfully. Oct 28 04:40:43.965861 systemd[1]: Started sshd@23-10.0.0.58:22-10.0.0.1:54010.service - OpenSSH per-connection server daemon (10.0.0.1:54010). Oct 28 04:40:44.031500 sshd[2514]: Accepted publickey for core from 10.0.0.1 port 54010 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:44.032492 sshd-session[2514]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:44.038574 systemd-logind[1477]: New session 24 of user core. Oct 28 04:40:44.047124 systemd[1]: Started session-24.scope - Session 24 of User core. Oct 28 04:40:44.058408 sshd[2517]: Connection closed by 10.0.0.1 port 54010 Oct 28 04:40:44.058706 sshd-session[2514]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:44.062142 systemd[1]: sshd@23-10.0.0.58:22-10.0.0.1:54010.service: Deactivated successfully. Oct 28 04:40:44.064228 systemd[1]: session-24.scope: Deactivated successfully. Oct 28 04:40:44.064901 systemd-logind[1477]: Session 24 logged out. Waiting for processes to exit. Oct 28 04:40:44.065769 systemd-logind[1477]: Removed session 24. Oct 28 04:40:45.744037 dockerd[2073]: time="2025-10-28T04:40:45.743967231Z" level=error msg="Force shutdown daemon" Oct 28 04:40:45.744414 dockerd[2073]: time="2025-10-28T04:40:45.744135102Z" level=info msg="Daemon shutdown complete" Oct 28 04:40:45.747941 systemd[1]: docker.service: Deactivated successfully. Oct 28 04:40:45.748281 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 28 04:40:45.748776 systemd[1]: docker.socket: Deactivated successfully. Oct 28 04:40:45.749164 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 28 04:40:45.749205 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 28 04:40:45.750608 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 28 04:40:45.750763 systemd[1]: containerd.service: Found left-over process 2399 (containerd-shim) in control group while starting unit. Ignoring. Oct 28 04:40:45.750772 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 28 04:40:45.758291 systemd[1]: Starting containerd.service - containerd container runtime... Oct 28 04:40:45.758756 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 28 04:40:45.769619 systemd[1]: containerd.service: Found left-over process 2399 (containerd-shim) in control group while starting unit. Ignoring. Oct 28 04:40:45.769629 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 28 04:40:45.788788 containerd[2528]: time="2025-10-28T04:40:45Z" 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 Oct 28 04:40:45.789166 containerd[2528]: time="2025-10-28T04:40:45.789136397Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 28 04:40:45.797140 containerd[2528]: time="2025-10-28T04:40:45.797094671Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.762µs" Oct 28 04:40:45.797277 containerd[2528]: time="2025-10-28T04:40:45.797261062Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 28 04:40:45.797341 containerd[2528]: time="2025-10-28T04:40:45.797327634Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 28 04:40:45.797429 containerd[2528]: time="2025-10-28T04:40:45.797414410Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 28 04:40:45.797494 containerd[2528]: time="2025-10-28T04:40:45.797478262Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 28 04:40:45.797729 containerd[2528]: time="2025-10-28T04:40:45.797709425Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:45.797817 containerd[2528]: time="2025-10-28T04:40:45.797801162Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 28 04:40:45.797905 containerd[2528]: time="2025-10-28T04:40:45.797862933Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798279 containerd[2528]: time="2025-10-28T04:40:45.798247084Z" 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 Oct 28 04:40:45.798354 containerd[2528]: time="2025-10-28T04:40:45.798334581Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798415 containerd[2528]: time="2025-10-28T04:40:45.798396472Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798463 containerd[2528]: time="2025-10-28T04:40:45.798451362Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798557 containerd[2528]: time="2025-10-28T04:40:45.798542699Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798740 containerd[2528]: time="2025-10-28T04:40:45.798721372Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 28 04:40:45.798821 containerd[2528]: time="2025-10-28T04:40:45.798806428Z" 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 Oct 28 04:40:45.798901 containerd[2528]: time="2025-10-28T04:40:45.798861438Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 28 04:40:45.798979 containerd[2528]: time="2025-10-28T04:40:45.798961137Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 28 04:40:45.799430 containerd[2528]: time="2025-10-28T04:40:45.799398658Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 28 04:40:45.799471 containerd[2528]: time="2025-10-28T04:40:45.799443226Z" level=info msg="metadata content store policy set" policy=shared Oct 28 04:40:45.799658 containerd[2528]: time="2025-10-28T04:40:45.799639422Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 28 04:40:45.799693 containerd[2528]: time="2025-10-28T04:40:45.799681030Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 28 04:40:45.799716 containerd[2528]: time="2025-10-28T04:40:45.799698753Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 28 04:40:45.799734 containerd[2528]: time="2025-10-28T04:40:45.799712036Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 28 04:40:45.799734 containerd[2528]: time="2025-10-28T04:40:45.799727839Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 28 04:40:45.799768 containerd[2528]: time="2025-10-28T04:40:45.799741961Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 28 04:40:45.799768 containerd[2528]: time="2025-10-28T04:40:45.799757724Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 28 04:40:45.799845 containerd[2528]: time="2025-10-28T04:40:45.799773167Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 28 04:40:45.799845 containerd[2528]: time="2025-10-28T04:40:45.799785929Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 28 04:40:45.799845 containerd[2528]: time="2025-10-28T04:40:45.799805293Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 28 04:40:45.799845 containerd[2528]: time="2025-10-28T04:40:45.799818775Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 28 04:40:45.799845 containerd[2528]: time="2025-10-28T04:40:45.799833618Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 28 04:40:45.800131 containerd[2528]: time="2025-10-28T04:40:45.800093386Z" level=info msg="connecting to shim 9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163" address="unix:///run/containerd/s/8c2c101f85f8ccd5a7346e864a5cbf3e0ba2b48d557cc853818fe7e1aa29f7e2" namespace=moby protocol=ttrpc version=3 Oct 28 04:40:45.806826 containerd[2528]: time="2025-10-28T04:40:45.806793227Z" level=info msg="cleaning leaked shim process" id=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 namespace=moby Oct 28 04:40:45.815635 containerd[2528]: time="2025-10-28T04:40:45.815576694Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Oct 28 04:40:45.816258 containerd[2528]: time="2025-10-28T04:40:45.816233856Z" level=info msg="shim disconnected" id=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 namespace=moby Oct 28 04:40:45.816292 containerd[2528]: time="2025-10-28T04:40:45.816260381Z" level=warning msg="cleaning up after shim disconnected" id=9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163 namespace=moby Oct 28 04:40:45.816312 containerd[2528]: time="2025-10-28T04:40:45.816291866Z" level=info msg="cleaning up dead shim" namespace=moby Oct 28 04:40:45.825304 containerd[2528]: time="2025-10-28T04:40:45.825270089Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825314298Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825332501Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825345463Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825356345Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825367027Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 28 04:40:45.825389 containerd[2528]: time="2025-10-28T04:40:45.825381430Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 28 04:40:45.825496 containerd[2528]: time="2025-10-28T04:40:45.825393432Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 28 04:40:45.825496 containerd[2528]: time="2025-10-28T04:40:45.825405995Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 28 04:40:45.825496 containerd[2528]: time="2025-10-28T04:40:45.825416957Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 28 04:40:45.825496 containerd[2528]: time="2025-10-28T04:40:45.825426918Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 28 04:40:45.825496 containerd[2528]: time="2025-10-28T04:40:45.825485769Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 28 04:40:45.825583 containerd[2528]: time="2025-10-28T04:40:45.825500372Z" level=info msg="Start snapshots syncer" Oct 28 04:40:45.825583 containerd[2528]: time="2025-10-28T04:40:45.825527537Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 28 04:40:45.825763 containerd[2528]: time="2025-10-28T04:40:45.825730735Z" 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\"}" Oct 28 04:40:45.825836 containerd[2528]: time="2025-10-28T04:40:45.825784025Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 28 04:40:45.825874 containerd[2528]: time="2025-10-28T04:40:45.825857878Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 28 04:40:45.825938 containerd[2528]: time="2025-10-28T04:40:45.825928331Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 28 04:40:45.825961 containerd[2528]: time="2025-10-28T04:40:45.825949335Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 28 04:40:45.825980 containerd[2528]: time="2025-10-28T04:40:45.825962338Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 28 04:40:45.825980 containerd[2528]: time="2025-10-28T04:40:45.825973180Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 28 04:40:45.826014 containerd[2528]: time="2025-10-28T04:40:45.825985862Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 28 04:40:45.826014 containerd[2528]: time="2025-10-28T04:40:45.825997224Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 28 04:40:45.826014 containerd[2528]: time="2025-10-28T04:40:45.826008186Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 28 04:40:45.826071 containerd[2528]: time="2025-10-28T04:40:45.826033831Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 28 04:40:45.826071 containerd[2528]: time="2025-10-28T04:40:45.826045353Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 28 04:40:45.826071 containerd[2528]: time="2025-10-28T04:40:45.826055515Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 28 04:40:45.826122 containerd[2528]: time="2025-10-28T04:40:45.826091962Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 28 04:40:45.826122 containerd[2528]: time="2025-10-28T04:40:45.826108205Z" 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 Oct 28 04:40:45.826122 containerd[2528]: time="2025-10-28T04:40:45.826117766Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826127488Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826136130Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826146412Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826156974Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826173617Z" level=info msg="runtime interface created" Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826179218Z" level=info msg="created NRI interface" Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826186859Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 28 04:40:45.826206 containerd[2528]: time="2025-10-28T04:40:45.826197221Z" level=info msg="Connect containerd service" Oct 28 04:40:45.826407 containerd[2528]: time="2025-10-28T04:40:45.826221746Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 28 04:40:45.826677 containerd[2528]: time="2025-10-28T04:40:45.826655506Z" 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" Oct 28 04:40:45.835945 containerd[2528]: time="2025-10-28T04:40:45.835898658Z" level=info msg="Start subscribing containerd event" Oct 28 04:40:45.836010 containerd[2528]: time="2025-10-28T04:40:45.835958429Z" level=info msg="Start recovering state" Oct 28 04:40:45.836053 containerd[2528]: time="2025-10-28T04:40:45.836026562Z" level=info msg="Start event monitor" Oct 28 04:40:45.836053 containerd[2528]: time="2025-10-28T04:40:45.836040084Z" level=info msg="Start cni network conf syncer for default" Oct 28 04:40:45.836088 containerd[2528]: time="2025-10-28T04:40:45.836056047Z" level=info msg="Start streaming server" Oct 28 04:40:45.836088 containerd[2528]: time="2025-10-28T04:40:45.836056807Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 28 04:40:45.836122 containerd[2528]: time="2025-10-28T04:40:45.836109097Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 28 04:40:45.836140 containerd[2528]: time="2025-10-28T04:40:45.836069770Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 28 04:40:45.836140 containerd[2528]: time="2025-10-28T04:40:45.836132261Z" level=info msg="runtime interface starting up..." Oct 28 04:40:45.836140 containerd[2528]: time="2025-10-28T04:40:45.836138382Z" level=info msg="starting plugins..." Oct 28 04:40:45.836193 containerd[2528]: time="2025-10-28T04:40:45.836148544Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 28 04:40:45.836260 containerd[2528]: time="2025-10-28T04:40:45.836237281Z" level=info msg="containerd successfully booted in 0.047618s" Oct 28 04:40:45.836366 systemd[1]: Started containerd.service - containerd container runtime. Oct 28 04:40:45.838765 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 28 04:40:45.861269 (dockerd)[2575]: 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 Oct 28 04:40:45.888706 dockerd[2575]: time="2025-10-28T04:40:45.888656549Z" level=info msg="Starting up" Oct 28 04:40:45.889186 dockerd[2575]: time="2025-10-28T04:40:45.889167964Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 28 04:40:45.902238 dockerd[2575]: time="2025-10-28T04:40:45.902185535Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 28 04:40:45.925341 dockerd[2575]: time="2025-10-28T04:40:45.925294615Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 28 04:40:45.932454 dockerd[2575]: time="2025-10-28T04:40:45.932386289Z" level=info msg="Loading containers: start." Oct 28 04:40:45.949614 systemd[1]: var-lib-docker-overlay2-c10db4f548b042845ff7bfb12a9e267bff377aea7b600bf1d2929133cd0e89a5-merged.mount: Deactivated successfully. Oct 28 04:40:46.497999 kernel: docker0: port 1(veth306fd7e) entered disabled state Oct 28 04:40:46.498101 systemd-networkd[1410]: veth306fd7e: Link DOWN Oct 28 04:40:46.498107 systemd-networkd[1410]: veth306fd7e: Lost carrier Oct 28 04:40:46.500419 kernel: veth306fd7e (unregistering): left allmulticast mode Oct 28 04:40:46.500519 kernel: veth306fd7e (unregistering): left promiscuous mode Oct 28 04:40:46.500542 kernel: docker0: port 1(veth306fd7e) entered disabled state Oct 28 04:40:46.502049 systemd-networkd[1410]: docker0: Lost carrier Oct 28 04:40:46.502760 dockerd[2575]: time="2025-10-28T04:40:46.502728435Z" level=info msg="Removing stale sandbox ef93bd6a2055c4c225fa745915b7d7a7052a1ddb5f243723bb8d1de55addc4b8 (9dfe7f61cd3a521ad2ee9de8ad3a08ab84d8d13e3253ac7cb18fb3b0cf1c8163)" Oct 28 04:40:46.506799 dockerd[2575]: time="2025-10-28T04:40:46.506749373Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 28 04:40:46.506910 dockerd[2575]: time="2025-10-28T04:40:46.506804302Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint b3a92a9ff0191258538d0c4e381fe30e2c81587306fed129d96c47196ba5b139 2a1bd4ce8258a21a9bb35e528eeb433b2cb632cf9eb57d05ee05c3f25c618bae], retrying...." Oct 28 04:40:46.662060 dockerd[2575]: time="2025-10-28T04:40:46.661990849Z" level=warning msg="error locating sandbox id bb574b2c23996e5d08ea306310d3f2c0bdb3f4eb0f173513b3b2b78735bf3d9d: sandbox bb574b2c23996e5d08ea306310d3f2c0bdb3f4eb0f173513b3b2b78735bf3d9d not found" Oct 28 04:40:46.662060 dockerd[2575]: time="2025-10-28T04:40:46.662045938Z" level=warning msg="error locating sandbox id ef93bd6a2055c4c225fa745915b7d7a7052a1ddb5f243723bb8d1de55addc4b8: sandbox ef93bd6a2055c4c225fa745915b7d7a7052a1ddb5f243723bb8d1de55addc4b8 not found" Oct 28 04:40:46.662217 dockerd[2575]: time="2025-10-28T04:40:46.662132113Z" level=info msg="Loading containers: done." Oct 28 04:40:46.672827 dockerd[2575]: time="2025-10-28T04:40:46.672730754Z" 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 Oct 28 04:40:46.673005 dockerd[2575]: time="2025-10-28T04:40:46.672855895Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 28 04:40:46.673039 dockerd[2575]: time="2025-10-28T04:40:46.673014603Z" level=info msg="Initializing buildkit" Oct 28 04:40:46.684770 dockerd[2575]: time="2025-10-28T04:40:46.684738919Z" level=info msg="Completed buildkit initialization" Oct 28 04:40:46.691457 dockerd[2575]: time="2025-10-28T04:40:46.691383873Z" level=info msg="Daemon has completed initialization" Oct 28 04:40:46.691777 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 28 04:40:46.692035 dockerd[2575]: time="2025-10-28T04:40:46.691473888Z" level=info msg="API listen on /run/docker.sock" Oct 28 04:40:46.912743 systemd[1]: run-docker-netns-ef93bd6a2055.mount: Deactivated successfully. Oct 28 04:40:50.075106 systemd[1]: Started sshd@24-10.0.0.58:22-10.0.0.1:55926.service - OpenSSH per-connection server daemon (10.0.0.1:55926). Oct 28 04:40:50.138096 sshd[2812]: Accepted publickey for core from 10.0.0.1 port 55926 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:50.139314 sshd-session[2812]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:50.143029 systemd-logind[1477]: New session 25 of user core. Oct 28 04:40:50.155059 systemd[1]: Started session-25.scope - Session 25 of User core. Oct 28 04:40:50.167457 sshd[2815]: Connection closed by 10.0.0.1 port 55926 Oct 28 04:40:50.167766 sshd-session[2812]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:50.184821 systemd[1]: sshd@24-10.0.0.58:22-10.0.0.1:55926.service: Deactivated successfully. Oct 28 04:40:50.188213 systemd[1]: session-25.scope: Deactivated successfully. Oct 28 04:40:50.188843 systemd-logind[1477]: Session 25 logged out. Waiting for processes to exit. Oct 28 04:40:50.191085 systemd[1]: Started sshd@25-10.0.0.58:22-10.0.0.1:55942.service - OpenSSH per-connection server daemon (10.0.0.1:55942). Oct 28 04:40:50.191699 systemd-logind[1477]: Removed session 25. Oct 28 04:40:50.249864 sshd[2821]: Accepted publickey for core from 10.0.0.1 port 55942 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:50.251140 sshd-session[2821]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:50.256783 systemd-logind[1477]: New session 26 of user core. Oct 28 04:40:50.262108 systemd[1]: Started session-26.scope - Session 26 of User core. Oct 28 04:40:50.274596 sshd[2824]: Connection closed by 10.0.0.1 port 55942 Oct 28 04:40:50.275162 sshd-session[2821]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:50.285698 systemd[1]: sshd@25-10.0.0.58:22-10.0.0.1:55942.service: Deactivated successfully. Oct 28 04:40:50.287105 systemd[1]: session-26.scope: Deactivated successfully. Oct 28 04:40:50.289501 systemd-logind[1477]: Session 26 logged out. Waiting for processes to exit. Oct 28 04:40:50.291709 systemd[1]: Started sshd@26-10.0.0.58:22-10.0.0.1:55952.service - OpenSSH per-connection server daemon (10.0.0.1:55952). Oct 28 04:40:50.292812 systemd-logind[1477]: Removed session 26. Oct 28 04:40:50.354699 sshd[2830]: Accepted publickey for core from 10.0.0.1 port 55952 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:50.355863 sshd-session[2830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:50.360336 systemd-logind[1477]: New session 27 of user core. Oct 28 04:40:50.376081 systemd[1]: Started session-27.scope - Session 27 of User core. Oct 28 04:40:50.391448 sshd[2833]: Connection closed by 10.0.0.1 port 55952 Oct 28 04:40:50.391750 sshd-session[2830]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:50.404782 systemd[1]: sshd@26-10.0.0.58:22-10.0.0.1:55952.service: Deactivated successfully. Oct 28 04:40:50.408353 systemd[1]: session-27.scope: Deactivated successfully. Oct 28 04:40:50.410872 systemd-logind[1477]: Session 27 logged out. Waiting for processes to exit. Oct 28 04:40:50.411735 systemd[1]: Started sshd@27-10.0.0.58:22-10.0.0.1:55958.service - OpenSSH per-connection server daemon (10.0.0.1:55958). Oct 28 04:40:50.412798 systemd-logind[1477]: Removed session 27. Oct 28 04:40:50.470129 sshd[2846]: Accepted publickey for core from 10.0.0.1 port 55958 ssh2: RSA SHA256:nAxiEu9hBWlN5Nbh4t8Lb7BhX+TiP/RIgaK2uTDALto Oct 28 04:40:50.471473 sshd-session[2846]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 28 04:40:50.475962 systemd-logind[1477]: New session 28 of user core. Oct 28 04:40:50.490147 systemd[1]: Started session-28.scope - Session 28 of User core. Oct 28 04:40:50.549061 containerd[2528]: time="2025-10-28T04:40:50.549013467Z" level=info msg="connecting to shim 43df708857cc78e41dfe3ca6feea8092d9fecb09ccfc64b97234ae1c917c6e8a" address="unix:///run/containerd/s/3d1fbd91d64a792d0058a6078972cff49e1f2b1641a7a146b29c6d295c793590" namespace=moby protocol=ttrpc version=3 Oct 28 04:40:50.574071 systemd[1]: Started docker-43df708857cc78e41dfe3ca6feea8092d9fecb09ccfc64b97234ae1c917c6e8a.scope - libcontainer container 43df708857cc78e41dfe3ca6feea8092d9fecb09ccfc64b97234ae1c917c6e8a. Oct 28 04:40:50.585021 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 28 04:40:50.600968 kernel: docker0: port 1(vethcb8e34b) entered blocking state Oct 28 04:40:50.601062 kernel: docker0: port 1(vethcb8e34b) entered disabled state Oct 28 04:40:50.601082 kernel: vethcb8e34b: entered allmulticast mode Oct 28 04:40:50.602114 kernel: vethcb8e34b: entered promiscuous mode Oct 28 04:40:50.605231 systemd-networkd[1410]: vethcb8e34b: Link UP Oct 28 04:40:50.614900 kernel: eth0: renamed from vethc482914 Oct 28 04:40:50.616862 systemd-networkd[1410]: vethcb8e34b: Gained carrier Oct 28 04:40:50.616956 kernel: docker0: port 1(vethcb8e34b) entered blocking state Oct 28 04:40:50.617370 kernel: docker0: port 1(vethcb8e34b) entered forwarding state Oct 28 04:40:50.617233 systemd-networkd[1410]: docker0: Gained carrier Oct 28 04:40:50.651168 sshd[2849]: Connection closed by 10.0.0.1 port 55958 Oct 28 04:40:50.651914 sshd-session[2846]: pam_unix(sshd:session): session closed for user core Oct 28 04:40:50.656412 systemd[1]: sshd@27-10.0.0.58:22-10.0.0.1:55958.service: Deactivated successfully. Oct 28 04:40:50.658164 systemd[1]: session-28.scope: Deactivated successfully. Oct 28 04:40:50.659031 systemd-logind[1477]: Session 28 logged out. Waiting for processes to exit. Oct 28 04:40:50.660108 systemd-logind[1477]: Removed session 28. Oct 28 04:40:51.950137 systemd-networkd[1410]: vethcb8e34b: Gained IPv6LL