Oct 27 15:55:18.345500 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 27 15:55:18.345523 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 Mon Oct 27 14:23:29 -00 2025 Oct 27 15:55:18.345531 kernel: KASLR enabled Oct 27 15:55:18.345538 kernel: efi: EFI v2.7 by EDK II Oct 27 15:55:18.345543 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Oct 27 15:55:18.345549 kernel: random: crng init done Oct 27 15:55:18.345556 kernel: secureboot: Secure boot disabled Oct 27 15:55:18.345562 kernel: ACPI: Early table checksum verification disabled Oct 27 15:55:18.345570 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 27 15:55:18.345576 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 27 15:55:18.345582 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345588 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345594 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345601 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345610 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345616 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345623 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345629 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345635 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 27 15:55:18.345642 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 27 15:55:18.345648 kernel: ACPI: Use ACPI SPCR as default console: No Oct 27 15:55:18.345687 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 27 15:55:18.345696 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Oct 27 15:55:18.345703 kernel: Zone ranges: Oct 27 15:55:18.345709 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 27 15:55:18.345716 kernel: DMA32 empty Oct 27 15:55:18.345723 kernel: Normal empty Oct 27 15:55:18.345729 kernel: Device empty Oct 27 15:55:18.345735 kernel: Movable zone start for each node Oct 27 15:55:18.345742 kernel: Early memory node ranges Oct 27 15:55:18.345748 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Oct 27 15:55:18.345754 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Oct 27 15:55:18.345761 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Oct 27 15:55:18.345767 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 27 15:55:18.345775 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 27 15:55:18.345781 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 27 15:55:18.345788 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 27 15:55:18.345796 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 27 15:55:18.345803 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 27 15:55:18.345811 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 27 15:55:18.345824 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 27 15:55:18.345831 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 27 15:55:18.345838 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 27 15:55:18.345845 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 27 15:55:18.345852 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 27 15:55:18.345860 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Oct 27 15:55:18.345867 kernel: psci: probing for conduit method from ACPI. Oct 27 15:55:18.345874 kernel: psci: PSCIv1.1 detected in firmware. Oct 27 15:55:18.345882 kernel: psci: Using standard PSCI v0.2 function IDs Oct 27 15:55:18.345889 kernel: psci: Trusted OS migration not required Oct 27 15:55:18.345895 kernel: psci: SMC Calling Convention v1.1 Oct 27 15:55:18.345902 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 27 15:55:18.345909 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Oct 27 15:55:18.345916 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Oct 27 15:55:18.345923 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 27 15:55:18.345930 kernel: Detected PIPT I-cache on CPU0 Oct 27 15:55:18.345937 kernel: CPU features: detected: GIC system register CPU interface Oct 27 15:55:18.345943 kernel: CPU features: detected: Spectre-v4 Oct 27 15:55:18.345950 kernel: CPU features: detected: Spectre-BHB Oct 27 15:55:18.345959 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 27 15:55:18.345965 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 27 15:55:18.345972 kernel: CPU features: detected: ARM erratum 1418040 Oct 27 15:55:18.345979 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 27 15:55:18.345986 kernel: alternatives: applying boot alternatives Oct 27 15:55:18.345994 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=cf4d4757176819eb734b55c931bba80385305a467f4d24de04ad3ab7e6dbe81b Oct 27 15:55:18.346001 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 27 15:55:18.346008 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 27 15:55:18.346015 kernel: Fallback order for Node 0: 0 Oct 27 15:55:18.346021 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Oct 27 15:55:18.346029 kernel: Policy zone: DMA Oct 27 15:55:18.346083 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 27 15:55:18.346092 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Oct 27 15:55:18.346099 kernel: software IO TLB: area num 4. Oct 27 15:55:18.346106 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Oct 27 15:55:18.346113 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Oct 27 15:55:18.346120 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 27 15:55:18.346127 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 27 15:55:18.346134 kernel: rcu: RCU event tracing is enabled. Oct 27 15:55:18.346141 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 27 15:55:18.346148 kernel: Trampoline variant of Tasks RCU enabled. Oct 27 15:55:18.346158 kernel: Tracing variant of Tasks RCU enabled. Oct 27 15:55:18.346165 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 27 15:55:18.346172 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 27 15:55:18.346179 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 27 15:55:18.346186 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 27 15:55:18.346193 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 27 15:55:18.346199 kernel: GICv3: 256 SPIs implemented Oct 27 15:55:18.346206 kernel: GICv3: 0 Extended SPIs implemented Oct 27 15:55:18.346213 kernel: Root IRQ handler: gic_handle_irq Oct 27 15:55:18.346220 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 27 15:55:18.346226 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Oct 27 15:55:18.346234 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 27 15:55:18.346241 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 27 15:55:18.346248 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Oct 27 15:55:18.346255 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Oct 27 15:55:18.346262 kernel: GICv3: using LPI property table @0x0000000040130000 Oct 27 15:55:18.346269 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Oct 27 15:55:18.346276 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 27 15:55:18.346283 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 27 15:55:18.346289 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 27 15:55:18.346296 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 27 15:55:18.346303 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 27 15:55:18.346311 kernel: arm-pv: using stolen time PV Oct 27 15:55:18.346319 kernel: Console: colour dummy device 80x25 Oct 27 15:55:18.346326 kernel: ACPI: Core revision 20240827 Oct 27 15:55:18.346333 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 27 15:55:18.346340 kernel: pid_max: default: 32768 minimum: 301 Oct 27 15:55:18.346348 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 27 15:55:18.346355 kernel: landlock: Up and running. Oct 27 15:55:18.346362 kernel: SELinux: Initializing. Oct 27 15:55:18.346370 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 15:55:18.346377 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 27 15:55:18.346385 kernel: rcu: Hierarchical SRCU implementation. Oct 27 15:55:18.346392 kernel: rcu: Max phase no-delay instances is 400. Oct 27 15:55:18.346400 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 27 15:55:18.346407 kernel: Remapping and enabling EFI services. Oct 27 15:55:18.346414 kernel: smp: Bringing up secondary CPUs ... Oct 27 15:55:18.346422 kernel: Detected PIPT I-cache on CPU1 Oct 27 15:55:18.346433 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 27 15:55:18.346442 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Oct 27 15:55:18.346449 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 27 15:55:18.346457 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 27 15:55:18.346464 kernel: Detected PIPT I-cache on CPU2 Oct 27 15:55:18.346472 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 27 15:55:18.346480 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Oct 27 15:55:18.346488 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 27 15:55:18.346495 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 27 15:55:18.346503 kernel: Detected PIPT I-cache on CPU3 Oct 27 15:55:18.346511 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 27 15:55:18.346518 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Oct 27 15:55:18.346526 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 27 15:55:18.346535 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 27 15:55:18.346543 kernel: smp: Brought up 1 node, 4 CPUs Oct 27 15:55:18.346550 kernel: SMP: Total of 4 processors activated. Oct 27 15:55:18.346557 kernel: CPU: All CPU(s) started at EL1 Oct 27 15:55:18.346565 kernel: CPU features: detected: 32-bit EL0 Support Oct 27 15:55:18.346573 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 27 15:55:18.346580 kernel: CPU features: detected: Common not Private translations Oct 27 15:55:18.346589 kernel: CPU features: detected: CRC32 instructions Oct 27 15:55:18.346597 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 27 15:55:18.346604 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 27 15:55:18.346612 kernel: CPU features: detected: LSE atomic instructions Oct 27 15:55:18.346619 kernel: CPU features: detected: Privileged Access Never Oct 27 15:55:18.346626 kernel: CPU features: detected: RAS Extension Support Oct 27 15:55:18.346634 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 27 15:55:18.346641 kernel: alternatives: applying system-wide alternatives Oct 27 15:55:18.346650 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Oct 27 15:55:18.346668 kernel: Memory: 2450400K/2572288K available (11136K kernel code, 2456K rwdata, 9084K rodata, 12992K init, 1038K bss, 99552K reserved, 16384K cma-reserved) Oct 27 15:55:18.346676 kernel: devtmpfs: initialized Oct 27 15:55:18.346684 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 27 15:55:18.346692 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 27 15:55:18.346699 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 27 15:55:18.346706 kernel: 0 pages in range for non-PLT usage Oct 27 15:55:18.346716 kernel: 515056 pages in range for PLT usage Oct 27 15:55:18.346723 kernel: pinctrl core: initialized pinctrl subsystem Oct 27 15:55:18.346731 kernel: SMBIOS 3.0.0 present. Oct 27 15:55:18.346738 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 27 15:55:18.346746 kernel: DMI: Memory slots populated: 1/1 Oct 27 15:55:18.346753 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 27 15:55:18.346761 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 27 15:55:18.346770 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 27 15:55:18.346777 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 27 15:55:18.346785 kernel: audit: initializing netlink subsys (disabled) Oct 27 15:55:18.346792 kernel: audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 Oct 27 15:55:18.346800 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 27 15:55:18.346807 kernel: cpuidle: using governor menu Oct 27 15:55:18.346814 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 27 15:55:18.346823 kernel: ASID allocator initialised with 32768 entries Oct 27 15:55:18.346890 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 27 15:55:18.346899 kernel: Serial: AMBA PL011 UART driver Oct 27 15:55:18.346907 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 27 15:55:18.346914 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 27 15:55:18.346922 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 27 15:55:18.346929 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 27 15:55:18.346940 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 27 15:55:18.346947 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 27 15:55:18.346955 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 27 15:55:18.346962 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 27 15:55:18.346970 kernel: ACPI: Added _OSI(Module Device) Oct 27 15:55:18.346977 kernel: ACPI: Added _OSI(Processor Device) Oct 27 15:55:18.346985 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 27 15:55:18.346992 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 27 15:55:18.347001 kernel: ACPI: Interpreter enabled Oct 27 15:55:18.347008 kernel: ACPI: Using GIC for interrupt routing Oct 27 15:55:18.347016 kernel: ACPI: MCFG table detected, 1 entries Oct 27 15:55:18.347023 kernel: ACPI: CPU0 has been hot-added Oct 27 15:55:18.347031 kernel: ACPI: CPU1 has been hot-added Oct 27 15:55:18.347038 kernel: ACPI: CPU2 has been hot-added Oct 27 15:55:18.347046 kernel: ACPI: CPU3 has been hot-added Oct 27 15:55:18.347054 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 27 15:55:18.347069 kernel: printk: legacy console [ttyAMA0] enabled Oct 27 15:55:18.347077 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 27 15:55:18.347233 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 27 15:55:18.347364 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 27 15:55:18.347449 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 27 15:55:18.347584 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 27 15:55:18.347681 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 27 15:55:18.347707 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 27 15:55:18.347715 kernel: PCI host bridge to bus 0000:00 Oct 27 15:55:18.347812 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 27 15:55:18.347887 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 27 15:55:18.347962 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 27 15:55:18.348032 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 27 15:55:18.348143 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Oct 27 15:55:18.348295 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 27 15:55:18.348388 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Oct 27 15:55:18.348473 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Oct 27 15:55:18.348553 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Oct 27 15:55:18.348634 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Oct 27 15:55:18.348747 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Oct 27 15:55:18.348831 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Oct 27 15:55:18.348905 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 27 15:55:18.348980 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 27 15:55:18.349051 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 27 15:55:18.349069 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 27 15:55:18.349148 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 27 15:55:18.349158 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 27 15:55:18.349166 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 27 15:55:18.349173 kernel: iommu: Default domain type: Translated Oct 27 15:55:18.349185 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 27 15:55:18.349192 kernel: efivars: Registered efivars operations Oct 27 15:55:18.349200 kernel: vgaarb: loaded Oct 27 15:55:18.349208 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 27 15:55:18.349215 kernel: VFS: Disk quotas dquot_6.6.0 Oct 27 15:55:18.349235 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 27 15:55:18.349243 kernel: pnp: PnP ACPI init Oct 27 15:55:18.349354 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 27 15:55:18.349365 kernel: pnp: PnP ACPI: found 1 devices Oct 27 15:55:18.349373 kernel: NET: Registered PF_INET protocol family Oct 27 15:55:18.349381 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 27 15:55:18.349388 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 27 15:55:18.349396 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 27 15:55:18.349404 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 27 15:55:18.349413 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 27 15:55:18.349421 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 27 15:55:18.349428 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 15:55:18.349436 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 27 15:55:18.349443 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 27 15:55:18.349451 kernel: PCI: CLS 0 bytes, default 64 Oct 27 15:55:18.349458 kernel: kvm [1]: HYP mode not available Oct 27 15:55:18.349467 kernel: Initialise system trusted keyrings Oct 27 15:55:18.349474 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 27 15:55:18.349482 kernel: Key type asymmetric registered Oct 27 15:55:18.349489 kernel: Asymmetric key parser 'x509' registered Oct 27 15:55:18.349497 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 27 15:55:18.349504 kernel: io scheduler mq-deadline registered Oct 27 15:55:18.349512 kernel: io scheduler kyber registered Oct 27 15:55:18.349520 kernel: io scheduler bfq registered Oct 27 15:55:18.349528 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 27 15:55:18.349535 kernel: ACPI: button: Power Button [PWRB] Oct 27 15:55:18.349543 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 27 15:55:18.349625 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 27 15:55:18.349635 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 27 15:55:18.349643 kernel: thunder_xcv, ver 1.0 Oct 27 15:55:18.349652 kernel: thunder_bgx, ver 1.0 Oct 27 15:55:18.349688 kernel: nicpf, ver 1.0 Oct 27 15:55:18.349696 kernel: nicvf, ver 1.0 Oct 27 15:55:18.349795 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 27 15:55:18.349874 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-27T15:55:17 UTC (1761580517) Oct 27 15:55:18.349884 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 27 15:55:18.349894 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 27 15:55:18.349901 kernel: watchdog: NMI not fully supported Oct 27 15:55:18.349909 kernel: watchdog: Hard watchdog permanently disabled Oct 27 15:55:18.349916 kernel: NET: Registered PF_INET6 protocol family Oct 27 15:55:18.349924 kernel: Segment Routing with IPv6 Oct 27 15:55:18.349931 kernel: In-situ OAM (IOAM) with IPv6 Oct 27 15:55:18.349939 kernel: NET: Registered PF_PACKET protocol family Oct 27 15:55:18.349946 kernel: Key type dns_resolver registered Oct 27 15:55:18.349955 kernel: registered taskstats version 1 Oct 27 15:55:18.349963 kernel: Loading compiled-in X.509 certificates Oct 27 15:55:18.350017 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: b7eb95b1f4c0ed887c9dfc0f9ad78fb6499418b6' Oct 27 15:55:18.350025 kernel: Demotion targets for Node 0: null Oct 27 15:55:18.350032 kernel: Key type .fscrypt registered Oct 27 15:55:18.350040 kernel: Key type fscrypt-provisioning registered Oct 27 15:55:18.350047 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 27 15:55:18.350064 kernel: ima: Allocated hash algorithm: sha1 Oct 27 15:55:18.350072 kernel: ima: No architecture policies found Oct 27 15:55:18.350080 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 27 15:55:18.350087 kernel: clk: Disabling unused clocks Oct 27 15:55:18.350095 kernel: PM: genpd: Disabling unused power domains Oct 27 15:55:18.350102 kernel: Freeing unused kernel memory: 12992K Oct 27 15:55:18.350110 kernel: Run /init as init process Oct 27 15:55:18.350119 kernel: with arguments: Oct 27 15:55:18.350126 kernel: /init Oct 27 15:55:18.350133 kernel: with environment: Oct 27 15:55:18.350141 kernel: HOME=/ Oct 27 15:55:18.350148 kernel: TERM=linux Oct 27 15:55:18.350258 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 27 15:55:18.350338 kernel: virtio_blk virtio1: [vda] 16515072 512-byte logical blocks (8.46 GB/7.88 GiB) Oct 27 15:55:18.350350 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 27 15:55:18.350358 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350366 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350373 kernel: SCSI subsystem initialized Oct 27 15:55:18.350381 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350388 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 27 15:55:18.350398 kernel: device-mapper: uevent: version 1.0.3 Oct 27 15:55:18.350405 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 27 15:55:18.350413 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 27 15:55:18.350421 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350428 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350435 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350442 kernel: raid6: neonx8 gen() 15647 MB/s Oct 27 15:55:18.350451 kernel: raid6: neonx4 gen() 15706 MB/s Oct 27 15:55:18.350459 kernel: raid6: neonx2 gen() 13144 MB/s Oct 27 15:55:18.350466 kernel: raid6: neonx1 gen() 10378 MB/s Oct 27 15:55:18.350474 kernel: raid6: int64x8 gen() 6856 MB/s Oct 27 15:55:18.350481 kernel: raid6: int64x4 gen() 7312 MB/s Oct 27 15:55:18.350488 kernel: raid6: int64x2 gen() 6073 MB/s Oct 27 15:55:18.350496 kernel: raid6: int64x1 gen() 5018 MB/s Oct 27 15:55:18.350503 kernel: raid6: using algorithm neonx4 gen() 15706 MB/s Oct 27 15:55:18.350512 kernel: raid6: .... xor() 12218 MB/s, rmw enabled Oct 27 15:55:18.350520 kernel: raid6: using neon recovery algorithm Oct 27 15:55:18.350528 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350535 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350543 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350550 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350557 kernel: xor: measuring software checksum speed Oct 27 15:55:18.350564 kernel: 8regs : 21618 MB/sec Oct 27 15:55:18.350573 kernel: 32regs : 20966 MB/sec Oct 27 15:55:18.350581 kernel: arm64_neon : 27993 MB/sec Oct 27 15:55:18.350588 kernel: xor: using function: arm64_neon (27993 MB/sec) Oct 27 15:55:18.350596 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350603 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 27 15:55:18.350611 kernel: BTRFS: device fsid 5432dd1c-5f42-4aa1-bea3-a16cf7512c6d devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (205) Oct 27 15:55:18.350618 kernel: BTRFS info (device dm-0): first mount of filesystem 5432dd1c-5f42-4aa1-bea3-a16cf7512c6d Oct 27 15:55:18.350627 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 27 15:55:18.350635 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 27 15:55:18.350642 kernel: BTRFS info (device dm-0): enabling free space tree Oct 27 15:55:18.350650 kernel: Invalid ELF header magic: != \u007fELF Oct 27 15:55:18.350672 kernel: loop: module loaded Oct 27 15:55:18.350681 kernel: loop0: detected capacity change from 0 to 91464 Oct 27 15:55:18.350688 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 27 15:55:18.350697 systemd[1]: Successfully made /usr/ read-only. Oct 27 15:55:18.350710 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 27 15:55:18.350718 systemd[1]: Detected virtualization kvm. Oct 27 15:55:18.350726 systemd[1]: Detected architecture arm64. Oct 27 15:55:18.350754 systemd[1]: Running in initrd. Oct 27 15:55:18.350762 systemd[1]: No hostname configured, using default hostname. Oct 27 15:55:18.350772 systemd[1]: Hostname set to . Oct 27 15:55:18.350780 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 27 15:55:18.350788 systemd[1]: Queued start job for default target initrd.target. Oct 27 15:55:18.350796 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 27 15:55:18.350805 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 15:55:18.350813 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 15:55:18.350821 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 27 15:55:18.350830 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 15:55:18.350839 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 27 15:55:18.350848 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 27 15:55:18.350856 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 15:55:18.350864 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 15:55:18.350911 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 27 15:55:18.350919 systemd[1]: Reached target paths.target - Path Units. Oct 27 15:55:18.350934 systemd[1]: Reached target slices.target - Slice Units. Oct 27 15:55:18.350943 systemd[1]: Reached target swap.target - Swaps. Oct 27 15:55:18.350952 systemd[1]: Reached target timers.target - Timer Units. Oct 27 15:55:18.350961 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 15:55:18.350970 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 15:55:18.350978 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 27 15:55:18.350987 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 27 15:55:18.350995 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 27 15:55:18.351004 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 15:55:18.351012 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 27 15:55:18.351022 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 15:55:18.351030 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 27 15:55:18.351039 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 27 15:55:18.351047 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 15:55:18.351056 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 27 15:55:18.351072 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 27 15:55:18.351081 systemd[1]: Starting systemd-fsck-usr.service... Oct 27 15:55:18.351091 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 15:55:18.351100 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 15:55:18.351108 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 15:55:18.351117 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 27 15:55:18.351127 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 15:55:18.351135 systemd[1]: Finished systemd-fsck-usr.service. Oct 27 15:55:18.351147 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 27 15:55:18.351157 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 27 15:55:18.351188 systemd-journald[342]: Collecting audit messages is disabled. Oct 27 15:55:18.351209 kernel: Bridge firewalling registered Oct 27 15:55:18.351217 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 15:55:18.351226 systemd-journald[342]: Journal started Oct 27 15:55:18.351245 systemd-journald[342]: Runtime Journal (/run/log/journal/1ccefad717ea4599951869025024b01d) is 6M, max 48.5M, 42.4M free. Oct 27 15:55:18.345760 systemd-modules-load[343]: Inserted module 'br_netfilter' Oct 27 15:55:18.354270 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 15:55:18.356546 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 15:55:18.362862 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 15:55:18.365234 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 27 15:55:18.369164 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 27 15:55:18.370948 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 15:55:18.373398 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 15:55:18.379942 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 15:55:18.382813 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 15:55:18.389150 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 15:55:18.390700 systemd-tmpfiles[367]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 27 15:55:18.394327 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 15:55:18.397735 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 15:55:18.399797 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 27 15:55:18.421142 systemd-resolved[372]: Positive Trust Anchors: Oct 27 15:55:18.421159 systemd-resolved[372]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 15:55:18.421162 systemd-resolved[372]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 15:55:18.421193 systemd-resolved[372]: 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 27 15:55:18.433461 dracut-cmdline[386]: 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=cf4d4757176819eb734b55c931bba80385305a467f4d24de04ad3ab7e6dbe81b Oct 27 15:55:18.444940 systemd-resolved[372]: Defaulting to hostname 'linux'. Oct 27 15:55:18.445987 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 15:55:18.447162 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 15:55:18.500681 kernel: Loading iSCSI transport class v2.0-870. Oct 27 15:55:18.508885 kernel: iscsi: registered transport (tcp) Oct 27 15:55:18.522691 kernel: iscsi: registered transport (qla4xxx) Oct 27 15:55:18.522726 kernel: QLogic iSCSI HBA Driver Oct 27 15:55:18.542626 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 27 15:55:18.560868 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 27 15:55:18.563047 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 15:55:18.608250 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 27 15:55:18.610282 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 27 15:55:18.611989 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 27 15:55:18.645988 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 27 15:55:18.649479 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 15:55:18.678698 systemd-udevd[629]: Using default interface naming scheme 'v257'. Oct 27 15:55:18.687651 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 15:55:18.690606 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 27 15:55:18.714730 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 27 15:55:18.717464 dracut-pre-trigger[702]: rd.md=0: removing MD RAID activation Oct 27 15:55:18.717571 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 27 15:55:18.740926 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 15:55:18.745910 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 15:55:18.764173 systemd-networkd[739]: lo: Link UP Oct 27 15:55:18.764182 systemd-networkd[739]: lo: Gained carrier Oct 27 15:55:18.765730 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 27 15:55:18.766799 systemd[1]: Reached target network.target - Network. Oct 27 15:55:18.804327 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 15:55:18.807603 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 27 15:55:18.843864 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 27 15:55:18.854070 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 27 15:55:18.862184 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 27 15:55:18.873408 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 27 15:55:18.881787 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 27 15:55:18.883026 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 15:55:18.885386 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 15:55:18.887935 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 15:55:18.892001 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 27 15:55:18.897863 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 27 15:55:18.905027 systemd-networkd[739]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 15:55:18.905043 systemd-networkd[739]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 15:55:18.905753 systemd-networkd[739]: eth0: Link UP Oct 27 15:55:18.906112 systemd-networkd[739]: eth0: Gained carrier Oct 27 15:55:18.906122 systemd-networkd[739]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 15:55:18.908605 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 15:55:18.908746 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 15:55:18.912749 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 15:55:18.918433 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 15:55:18.924782 systemd-networkd[739]: eth0: DHCPv4 address 10.0.0.135/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 27 15:55:18.937270 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 27 15:55:18.955988 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 15:55:19.948678 disk-uuid[805]: Warning: The kernel is still using the old partition table. Oct 27 15:55:19.948678 disk-uuid[805]: The new table will be used at the next reboot or after you Oct 27 15:55:19.948678 disk-uuid[805]: run partprobe(8) or kpartx(8) Oct 27 15:55:19.948678 disk-uuid[805]: The operation has completed successfully. Oct 27 15:55:19.958652 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 27 15:55:19.958812 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 27 15:55:19.961605 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 27 15:55:19.990662 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (830) Oct 27 15:55:19.990723 kernel: BTRFS info (device vda6): first mount of filesystem 8398f3e4-ecee-42e0-96c0-96d7cb35d148 Oct 27 15:55:19.992072 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 15:55:19.994691 kernel: BTRFS info (device vda6): turning on async discard Oct 27 15:55:19.994737 kernel: BTRFS info (device vda6): enabling free space tree Oct 27 15:55:20.000684 kernel: BTRFS info (device vda6): last unmount of filesystem 8398f3e4-ecee-42e0-96c0-96d7cb35d148 Oct 27 15:55:20.000765 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 27 15:55:20.002652 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 27 15:55:20.106772 ignition[849]: Ignition 2.22.0 Oct 27 15:55:20.106788 ignition[849]: Stage: fetch-offline Oct 27 15:55:20.106822 ignition[849]: no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:20.106832 ignition[849]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:20.106921 ignition[849]: parsed url from cmdline: "" Oct 27 15:55:20.106925 ignition[849]: no config URL provided Oct 27 15:55:20.106929 ignition[849]: reading system config file "/usr/lib/ignition/user.ign" Oct 27 15:55:20.106938 ignition[849]: no config at "/usr/lib/ignition/user.ign" Oct 27 15:55:20.106974 ignition[849]: op(1): [started] loading QEMU firmware config module Oct 27 15:55:20.106979 ignition[849]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 27 15:55:20.112593 ignition[849]: op(1): [finished] loading QEMU firmware config module Oct 27 15:55:20.117124 ignition[849]: parsing config with SHA512: ba8e48b519b1d09361bd1a321529ae5e135b944237b121a719a2ec94fc8e7522c9b2eecaba8b02450081ca07b1d1214c306b0d6963637359e2afc50f27824191 Oct 27 15:55:20.122842 unknown[849]: fetched base config from "system" Oct 27 15:55:20.122856 unknown[849]: fetched user config from "qemu" Oct 27 15:55:20.123020 ignition[849]: fetch-offline: fetch-offline passed Oct 27 15:55:20.123209 ignition[849]: Ignition finished successfully Oct 27 15:55:20.126990 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 15:55:20.129310 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 27 15:55:20.130147 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 27 15:55:20.178705 ignition[864]: Ignition 2.22.0 Oct 27 15:55:20.178721 ignition[864]: Stage: kargs Oct 27 15:55:20.178857 ignition[864]: no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:20.178865 ignition[864]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:20.179373 ignition[864]: kargs: kargs passed Oct 27 15:55:20.183365 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 27 15:55:20.179416 ignition[864]: Ignition finished successfully Oct 27 15:55:20.185596 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 27 15:55:20.213448 ignition[872]: Ignition 2.22.0 Oct 27 15:55:20.213466 ignition[872]: Stage: disks Oct 27 15:55:20.213609 ignition[872]: no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:20.213617 ignition[872]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:20.214114 ignition[872]: disks: disks passed Oct 27 15:55:20.216911 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 27 15:55:20.214156 ignition[872]: Ignition finished successfully Oct 27 15:55:20.218749 systemd-networkd[739]: eth0: Gained IPv6LL Oct 27 15:55:20.218773 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 27 15:55:20.220283 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 27 15:55:20.222101 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 15:55:20.223676 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 15:55:20.225229 systemd[1]: Reached target basic.target - Basic System. Oct 27 15:55:20.227809 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 27 15:55:20.268169 systemd-fsck[882]: ROOT: clean, 15/456736 files, 38230/456704 blocks Oct 27 15:55:20.383028 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 27 15:55:20.385530 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 27 15:55:20.457669 kernel: EXT4-fs (vda9): mounted filesystem 56cabbe1-a674-443d-96ce-7c5656c41984 r/w with ordered data mode. Quota mode: none. Oct 27 15:55:20.458107 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 27 15:55:20.459389 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 27 15:55:20.462584 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 27 15:55:20.464942 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 27 15:55:20.465909 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 27 15:55:20.465940 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 27 15:55:20.465965 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 15:55:20.477065 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 27 15:55:20.479157 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 27 15:55:20.485528 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (891) Oct 27 15:55:20.485566 kernel: BTRFS info (device vda6): first mount of filesystem 8398f3e4-ecee-42e0-96c0-96d7cb35d148 Oct 27 15:55:20.485578 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 15:55:20.489286 kernel: BTRFS info (device vda6): turning on async discard Oct 27 15:55:20.489332 kernel: BTRFS info (device vda6): enabling free space tree Oct 27 15:55:20.490314 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 27 15:55:20.516381 initrd-setup-root[915]: cut: /sysroot/etc/passwd: No such file or directory Oct 27 15:55:20.519631 initrd-setup-root[922]: cut: /sysroot/etc/group: No such file or directory Oct 27 15:55:20.523635 initrd-setup-root[929]: cut: /sysroot/etc/shadow: No such file or directory Oct 27 15:55:20.526247 initrd-setup-root[936]: cut: /sysroot/etc/gshadow: No such file or directory Oct 27 15:55:20.595706 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 27 15:55:20.598165 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 27 15:55:20.599812 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 27 15:55:20.618097 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 27 15:55:20.620698 kernel: BTRFS info (device vda6): last unmount of filesystem 8398f3e4-ecee-42e0-96c0-96d7cb35d148 Oct 27 15:55:20.648838 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 27 15:55:20.664237 ignition[1006]: INFO : Ignition 2.22.0 Oct 27 15:55:20.664237 ignition[1006]: INFO : Stage: mount Oct 27 15:55:20.666373 ignition[1006]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:20.666373 ignition[1006]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:20.666373 ignition[1006]: INFO : mount: mount passed Oct 27 15:55:20.666373 ignition[1006]: INFO : Ignition finished successfully Oct 27 15:55:20.666741 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 27 15:55:20.669153 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 27 15:55:21.459585 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 27 15:55:21.491563 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1017) Oct 27 15:55:21.491608 kernel: BTRFS info (device vda6): first mount of filesystem 8398f3e4-ecee-42e0-96c0-96d7cb35d148 Oct 27 15:55:21.491621 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 27 15:55:21.495684 kernel: BTRFS info (device vda6): turning on async discard Oct 27 15:55:21.495713 kernel: BTRFS info (device vda6): enabling free space tree Oct 27 15:55:21.496625 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 27 15:55:21.529268 ignition[1034]: INFO : Ignition 2.22.0 Oct 27 15:55:21.529268 ignition[1034]: INFO : Stage: files Oct 27 15:55:21.530993 ignition[1034]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:21.530993 ignition[1034]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:21.530993 ignition[1034]: DEBUG : files: compiled without relabeling support, skipping Oct 27 15:55:21.534382 ignition[1034]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 27 15:55:21.534382 ignition[1034]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 27 15:55:21.534382 ignition[1034]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 27 15:55:21.534382 ignition[1034]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 27 15:55:21.539850 ignition[1034]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 27 15:55:21.539850 ignition[1034]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 15:55:21.539850 ignition[1034]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 27 15:55:21.539850 ignition[1034]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Oct 27 15:55:21.539850 ignition[1034]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 27 15:55:21.534437 unknown[1034]: wrote ssh authorized keys file for user: core Oct 27 15:55:21.549096 ignition[1034]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 27 15:55:21.549096 ignition[1034]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Oct 27 15:55:21.549096 ignition[1034]: INFO : files: op(6): [started] processing unit "docker.service" Oct 27 15:55:21.549096 ignition[1034]: INFO : files: op(6): [finished] processing unit "docker.service" Oct 27 15:55:21.549096 ignition[1034]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Oct 27 15:55:21.558043 ignition[1034]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 27 15:55:21.561449 ignition[1034]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 27 15:55:21.563858 ignition[1034]: INFO : files: files passed Oct 27 15:55:21.563858 ignition[1034]: INFO : Ignition finished successfully Oct 27 15:55:21.564623 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 27 15:55:21.566877 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 27 15:55:21.568642 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 27 15:55:21.585977 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 27 15:55:21.586100 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 27 15:55:21.589635 initrd-setup-root-after-ignition[1065]: grep: /sysroot/oem/oem-release: No such file or directory Oct 27 15:55:21.590917 initrd-setup-root-after-ignition[1067]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 15:55:21.590917 initrd-setup-root-after-ignition[1067]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 27 15:55:21.595282 initrd-setup-root-after-ignition[1071]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 27 15:55:21.594101 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 15:55:21.598092 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 27 15:55:21.599850 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 27 15:55:21.631853 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 27 15:55:21.632809 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 27 15:55:21.635247 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 27 15:55:21.636322 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 27 15:55:21.638341 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 27 15:55:21.639252 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 27 15:55:21.666581 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 15:55:21.669267 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 27 15:55:21.699947 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 27 15:55:21.700165 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 27 15:55:21.702334 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 15:55:21.704481 systemd[1]: Stopped target timers.target - Timer Units. Oct 27 15:55:21.706310 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 27 15:55:21.706442 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 27 15:55:21.708829 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 27 15:55:21.710685 systemd[1]: Stopped target basic.target - Basic System. Oct 27 15:55:21.712313 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 27 15:55:21.713959 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 27 15:55:21.715813 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 27 15:55:21.717717 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 27 15:55:21.719891 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 27 15:55:21.721687 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 27 15:55:21.723755 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 27 15:55:21.725778 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 27 15:55:21.727581 systemd[1]: Stopped target swap.target - Swaps. Oct 27 15:55:21.729130 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 27 15:55:21.729266 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 27 15:55:21.731609 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 27 15:55:21.733549 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 15:55:21.735453 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 27 15:55:21.735568 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 15:55:21.737575 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 27 15:55:21.737730 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 27 15:55:21.740492 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 27 15:55:21.740616 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 27 15:55:21.742756 systemd[1]: Stopped target paths.target - Path Units. Oct 27 15:55:21.744354 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 27 15:55:21.748791 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 15:55:21.750147 systemd[1]: Stopped target slices.target - Slice Units. Oct 27 15:55:21.752347 systemd[1]: Stopped target sockets.target - Socket Units. Oct 27 15:55:21.753808 systemd[1]: iscsid.socket: Deactivated successfully. Oct 27 15:55:21.753899 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 27 15:55:21.755363 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 27 15:55:21.755443 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 27 15:55:21.756898 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 27 15:55:21.757012 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 27 15:55:21.758717 systemd[1]: ignition-files.service: Deactivated successfully. Oct 27 15:55:21.758821 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 27 15:55:21.761186 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 27 15:55:21.762740 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 27 15:55:21.762874 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 15:55:21.765641 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 27 15:55:21.767232 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 27 15:55:21.767356 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 15:55:21.769251 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 27 15:55:21.769362 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 15:55:21.771050 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 27 15:55:21.771161 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 27 15:55:21.776812 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 27 15:55:21.779892 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 27 15:55:21.790320 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 27 15:55:21.794455 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 27 15:55:21.794565 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 27 15:55:21.808600 ignition[1091]: INFO : Ignition 2.22.0 Oct 27 15:55:21.808600 ignition[1091]: INFO : Stage: umount Oct 27 15:55:21.811241 ignition[1091]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 27 15:55:21.811241 ignition[1091]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 27 15:55:21.811241 ignition[1091]: INFO : umount: umount passed Oct 27 15:55:21.811241 ignition[1091]: INFO : Ignition finished successfully Oct 27 15:55:21.812318 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 27 15:55:21.812442 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 27 15:55:21.814508 systemd[1]: Stopped target network.target - Network. Oct 27 15:55:21.815888 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 27 15:55:21.815952 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 27 15:55:21.817625 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 27 15:55:21.817696 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 27 15:55:21.819433 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 27 15:55:21.819485 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 27 15:55:21.821319 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 27 15:55:21.821363 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 27 15:55:21.823026 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 27 15:55:21.823078 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 27 15:55:21.824867 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 27 15:55:21.826601 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 27 15:55:21.830195 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 27 15:55:21.830302 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 27 15:55:21.836227 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 27 15:55:21.837642 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 27 15:55:21.841032 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 27 15:55:21.842761 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 27 15:55:21.842797 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 27 15:55:21.845346 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 27 15:55:21.846343 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 27 15:55:21.846408 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 27 15:55:21.848548 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 27 15:55:21.848598 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 27 15:55:21.850337 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 27 15:55:21.850386 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 27 15:55:21.852347 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 15:55:21.870964 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 27 15:55:21.877691 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 15:55:21.880541 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 27 15:55:21.880647 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 27 15:55:21.882891 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 27 15:55:21.882956 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 27 15:55:21.884154 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 27 15:55:21.884185 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 27 15:55:21.885921 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 27 15:55:21.885978 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 27 15:55:21.888468 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 27 15:55:21.888519 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 27 15:55:21.891074 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 27 15:55:21.891122 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 27 15:55:21.894594 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 27 15:55:21.895860 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 27 15:55:21.895919 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 27 15:55:21.898027 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 27 15:55:21.898081 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 15:55:21.900308 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 27 15:55:21.900353 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 15:55:21.914624 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 27 15:55:21.914768 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 27 15:55:21.917098 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 27 15:55:21.919646 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 27 15:55:21.950893 systemd[1]: Switching root. Oct 27 15:55:21.975838 systemd-journald[342]: Journal stopped Oct 27 15:55:22.657120 systemd-journald[342]: Received SIGTERM from PID 1 (systemd). Oct 27 15:55:22.657167 kernel: SELinux: policy capability network_peer_controls=1 Oct 27 15:55:22.657182 kernel: SELinux: policy capability open_perms=1 Oct 27 15:55:22.657194 kernel: SELinux: policy capability extended_socket_class=1 Oct 27 15:55:22.657206 kernel: SELinux: policy capability always_check_network=0 Oct 27 15:55:22.657216 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 27 15:55:22.657227 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 27 15:55:22.657240 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 27 15:55:22.657250 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 27 15:55:22.657260 kernel: SELinux: policy capability userspace_initial_context=0 Oct 27 15:55:22.657270 kernel: audit: type=1403 audit(1761580522.058:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 27 15:55:22.657283 systemd[1]: Successfully loaded SELinux policy in 46.668ms. Oct 27 15:55:22.657301 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.604ms. Oct 27 15:55:22.657313 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 27 15:55:22.657324 systemd[1]: Detected virtualization kvm. Oct 27 15:55:22.657334 systemd[1]: Detected architecture arm64. Oct 27 15:55:22.657345 systemd[1]: Detected first boot. Oct 27 15:55:22.657355 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 27 15:55:22.657367 zram_generator::config[1136]: No configuration found. Oct 27 15:55:22.657378 kernel: NET: Registered PF_VSOCK protocol family Oct 27 15:55:22.657388 systemd[1]: Populated /etc with preset unit settings. Oct 27 15:55:22.657399 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 27 15:55:22.657409 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 27 15:55:22.657421 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 27 15:55:22.657433 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 27 15:55:22.657444 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 27 15:55:22.657455 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 27 15:55:22.657466 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 27 15:55:22.657477 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 27 15:55:22.657487 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 27 15:55:22.657498 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 27 15:55:22.657511 systemd[1]: Created slice user.slice - User and Session Slice. Oct 27 15:55:22.657523 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 27 15:55:22.657534 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 27 15:55:22.657545 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 27 15:55:22.657555 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 27 15:55:22.657567 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 27 15:55:22.657578 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 27 15:55:22.657588 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 27 15:55:22.657599 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 27 15:55:22.657610 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 27 15:55:22.657621 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 27 15:55:22.657632 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 27 15:55:22.657643 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 27 15:55:22.657680 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 27 15:55:22.657702 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 27 15:55:22.657714 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 27 15:55:22.657724 systemd[1]: Reached target slices.target - Slice Units. Oct 27 15:55:22.657735 systemd[1]: Reached target swap.target - Swaps. Oct 27 15:55:22.657748 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 27 15:55:22.657758 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 27 15:55:22.657774 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 27 15:55:22.657785 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 27 15:55:22.657796 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 27 15:55:22.657807 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 27 15:55:22.657818 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 27 15:55:22.657830 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 27 15:55:22.657841 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 27 15:55:22.657852 systemd[1]: Mounting media.mount - External Media Directory... Oct 27 15:55:22.657863 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 27 15:55:22.657874 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 27 15:55:22.657885 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 27 15:55:22.657897 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 27 15:55:22.657909 systemd[1]: Reached target machines.target - Containers. Oct 27 15:55:22.657920 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 27 15:55:22.657934 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 27 15:55:22.657947 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 27 15:55:22.657959 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 27 15:55:22.657971 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 27 15:55:22.657982 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 27 15:55:22.657993 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 27 15:55:22.658011 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 27 15:55:22.658024 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 27 15:55:22.658035 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 27 15:55:22.658045 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 27 15:55:22.658056 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 27 15:55:22.658068 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 27 15:55:22.658079 systemd[1]: Stopped systemd-fsck-usr.service. Oct 27 15:55:22.658090 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 27 15:55:22.658101 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 27 15:55:22.658111 kernel: fuse: init (API version 7.41) Oct 27 15:55:22.658121 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 27 15:55:22.658133 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 27 15:55:22.658145 kernel: ACPI: bus type drm_connector registered Oct 27 15:55:22.658155 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 27 15:55:22.658166 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 27 15:55:22.658177 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 27 15:55:22.658209 systemd-journald[1208]: Collecting audit messages is disabled. Oct 27 15:55:22.658231 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 27 15:55:22.658243 systemd-journald[1208]: Journal started Oct 27 15:55:22.658263 systemd-journald[1208]: Runtime Journal (/run/log/journal/1ccefad717ea4599951869025024b01d) is 6M, max 48.5M, 42.4M free. Oct 27 15:55:22.658783 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 27 15:55:22.444185 systemd[1]: Queued start job for default target multi-user.target. Oct 27 15:55:22.459686 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 27 15:55:22.460148 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 27 15:55:22.666690 systemd[1]: Started systemd-journald.service - Journal Service. Oct 27 15:55:22.667625 systemd[1]: Mounted media.mount - External Media Directory. Oct 27 15:55:22.668736 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 27 15:55:22.670042 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 27 15:55:22.671199 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 27 15:55:22.673694 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 27 15:55:22.675061 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 27 15:55:22.676575 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 27 15:55:22.677844 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 27 15:55:22.679249 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 27 15:55:22.679421 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 27 15:55:22.680862 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 27 15:55:22.681024 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 27 15:55:22.682393 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 27 15:55:22.682545 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 27 15:55:22.684060 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 27 15:55:22.684214 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 27 15:55:22.685629 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 27 15:55:22.685835 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 27 15:55:22.687264 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 27 15:55:22.688778 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 27 15:55:22.691079 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 27 15:55:22.692921 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 27 15:55:22.706035 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 27 15:55:22.707563 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 27 15:55:22.709946 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 27 15:55:22.712075 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 27 15:55:22.713328 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 27 15:55:22.713365 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 27 15:55:22.715288 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 27 15:55:22.716704 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 27 15:55:22.727588 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 27 15:55:22.729805 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 27 15:55:22.731032 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 27 15:55:22.731982 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 27 15:55:22.733313 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 27 15:55:22.736817 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 27 15:55:22.738238 systemd-journald[1208]: Time spent on flushing to /var/log/journal/1ccefad717ea4599951869025024b01d is 15.562ms for 852 entries. Oct 27 15:55:22.738238 systemd-journald[1208]: System Journal (/var/log/journal/1ccefad717ea4599951869025024b01d) is 8M, max 163.5M, 155.5M free. Oct 27 15:55:22.772095 systemd-journald[1208]: Received client request to flush runtime journal. Oct 27 15:55:22.772153 kernel: loop1: detected capacity change from 0 to 100624 Oct 27 15:55:22.738948 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 27 15:55:22.742709 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 27 15:55:22.746723 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 27 15:55:22.749217 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 27 15:55:22.750608 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 27 15:55:22.753016 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 27 15:55:22.756419 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 27 15:55:22.760969 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 27 15:55:22.764833 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 27 15:55:22.775189 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 27 15:55:22.782144 kernel: loop2: detected capacity change from 0 to 109744 Oct 27 15:55:22.783624 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 27 15:55:22.786638 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 27 15:55:22.789496 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 27 15:55:22.800514 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 27 15:55:22.801966 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 27 15:55:22.811749 kernel: loop3: detected capacity change from 0 to 100624 Oct 27 15:55:22.815282 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Oct 27 15:55:22.815299 systemd-tmpfiles[1269]: ACLs are not supported, ignoring. Oct 27 15:55:22.818687 kernel: loop4: detected capacity change from 0 to 109744 Oct 27 15:55:22.818646 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 27 15:55:22.825973 (sd-merge)[1275]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw'. Oct 27 15:55:22.828794 (sd-merge)[1275]: Merged extensions into '/usr'. Oct 27 15:55:22.835747 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 27 15:55:22.838403 systemd[1]: Starting ensure-sysext.service... Oct 27 15:55:22.840055 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 27 15:55:22.842954 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 27 15:55:22.862701 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 27 15:55:22.862797 systemd[1]: Reload requested from client PID 1278 ('systemctl') (unit ensure-sysext.service)... Oct 27 15:55:22.862810 systemd[1]: Reloading... Oct 27 15:55:22.863116 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 27 15:55:22.863349 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 27 15:55:22.863544 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 27 15:55:22.864448 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 27 15:55:22.864840 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Oct 27 15:55:22.864965 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Oct 27 15:55:22.869162 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Oct 27 15:55:22.869292 systemd-tmpfiles[1283]: Skipping /boot Oct 27 15:55:22.875386 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Oct 27 15:55:22.875492 systemd-tmpfiles[1283]: Skipping /boot Oct 27 15:55:22.910038 systemd-resolved[1268]: Positive Trust Anchors: Oct 27 15:55:22.910056 systemd-resolved[1268]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 27 15:55:22.910060 systemd-resolved[1268]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 27 15:55:22.910091 systemd-resolved[1268]: 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 27 15:55:22.916681 zram_generator::config[1321]: No configuration found. Oct 27 15:55:22.918780 systemd-resolved[1268]: Defaulting to hostname 'linux'. Oct 27 15:55:23.050105 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 27 15:55:23.050491 systemd[1]: Reloading finished in 187 ms. Oct 27 15:55:23.081247 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 27 15:55:23.098798 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 27 15:55:23.104788 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 27 15:55:23.107355 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 15:55:23.109328 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 27 15:55:23.122092 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 27 15:55:23.124775 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 27 15:55:23.126980 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 27 15:55:23.130737 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 27 15:55:23.131893 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 27 15:55:23.134007 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 27 15:55:23.136926 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 27 15:55:23.138381 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 27 15:55:23.138516 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 27 15:55:23.139537 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 27 15:55:23.141025 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 27 15:55:23.143832 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 27 15:55:23.145693 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 27 15:55:23.148538 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 27 15:55:23.148749 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 27 15:55:23.156092 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 27 15:55:23.157609 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 27 15:55:23.164987 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 27 15:55:23.170124 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 27 15:55:23.171533 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 27 15:55:23.171729 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 27 15:55:23.177968 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 27 15:55:23.189277 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 27 15:55:23.192100 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 27 15:55:23.193822 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 27 15:55:23.193984 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 27 15:55:23.195817 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 27 15:55:23.196032 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 27 15:55:23.200039 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 27 15:55:23.200194 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 27 15:55:23.206148 augenrules[1387]: No rules Oct 27 15:55:23.207726 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 27 15:55:23.209873 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 15:55:23.210081 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 15:55:23.213902 systemd[1]: Finished ensure-sysext.service. Oct 27 15:55:23.217280 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 27 15:55:23.218646 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 27 15:55:23.219886 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 27 15:55:23.219943 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 27 15:55:23.219981 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 27 15:55:23.220038 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 27 15:55:23.221742 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 27 15:55:23.230512 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 27 15:55:23.231886 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 27 15:55:23.232344 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 27 15:55:23.232507 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 27 15:55:23.265018 systemd-udevd[1399]: Using default interface naming scheme 'v257'. Oct 27 15:55:23.271949 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 27 15:55:23.273856 systemd[1]: Reached target time-set.target - System Time Set. Oct 27 15:55:23.285422 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 27 15:55:23.289902 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 27 15:55:23.371855 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 27 15:55:23.374955 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 27 15:55:23.376163 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 27 15:55:23.408701 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 27 15:55:23.410113 systemd-networkd[1411]: lo: Link UP Oct 27 15:55:23.410124 systemd-networkd[1411]: lo: Gained carrier Oct 27 15:55:23.411624 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 27 15:55:23.412126 systemd-networkd[1411]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 15:55:23.412130 systemd-networkd[1411]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 27 15:55:23.412973 systemd-networkd[1411]: eth0: Link UP Oct 27 15:55:23.413124 systemd-networkd[1411]: eth0: Gained carrier Oct 27 15:55:23.413139 systemd-networkd[1411]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 27 15:55:23.413839 systemd[1]: Reached target network.target - Network. Oct 27 15:55:23.416748 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 27 15:55:23.419226 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 27 15:55:23.427755 systemd-networkd[1411]: eth0: DHCPv4 address 10.0.0.135/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 27 15:55:23.428719 systemd-timesyncd[1398]: Network configuration changed, trying to establish connection. Oct 27 15:55:23.430240 systemd-timesyncd[1398]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 27 15:55:23.430300 systemd-timesyncd[1398]: Initial clock synchronization to Mon 2025-10-27 15:55:23.508964 UTC. Oct 27 15:55:23.444442 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 27 15:55:23.458297 ldconfig[1352]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 27 15:55:23.465715 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 27 15:55:23.468212 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 27 15:55:23.493755 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 27 15:55:23.500185 systemd[1]: Reached target sysinit.target - System Initialization. Oct 27 15:55:23.501443 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 27 15:55:23.502913 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 27 15:55:23.504451 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 27 15:55:23.505849 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 27 15:55:23.507197 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 27 15:55:23.508516 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 27 15:55:23.508621 systemd[1]: Reached target paths.target - Path Units. Oct 27 15:55:23.509604 systemd[1]: Reached target timers.target - Timer Units. Oct 27 15:55:23.511477 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 27 15:55:23.514185 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 27 15:55:23.517075 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 27 15:55:23.518598 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 27 15:55:23.520030 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 27 15:55:23.523353 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 27 15:55:23.525101 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 27 15:55:23.527863 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 27 15:55:23.529309 systemd[1]: Reached target sockets.target - Socket Units. Oct 27 15:55:23.530350 systemd[1]: Reached target basic.target - Basic System. Oct 27 15:55:23.531394 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 27 15:55:23.531488 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 27 15:55:23.532681 systemd[1]: Starting containerd.service - containerd container runtime... Oct 27 15:55:23.534763 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 27 15:55:23.536763 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 27 15:55:23.538827 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 27 15:55:23.540835 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 27 15:55:23.541875 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 27 15:55:23.544841 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 27 15:55:23.545939 jq[1463]: false Oct 27 15:55:23.548880 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 27 15:55:23.551119 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 27 15:55:23.552646 extend-filesystems[1464]: Found /dev/vda6 Oct 27 15:55:23.555428 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 27 15:55:23.555958 extend-filesystems[1464]: Found /dev/vda9 Oct 27 15:55:23.559694 extend-filesystems[1464]: Checking size of /dev/vda9 Oct 27 15:55:23.558039 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 27 15:55:23.560230 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 27 15:55:23.560789 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 27 15:55:23.562708 systemd[1]: Starting update-engine.service - Update Engine... Oct 27 15:55:23.564645 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 27 15:55:23.586080 extend-filesystems[1464]: Resized partition /dev/vda9 Oct 27 15:55:23.594737 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 474107 blocks Oct 27 15:55:23.594771 kernel: EXT4-fs (vda9): resized filesystem to 474107 Oct 27 15:55:23.578193 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 27 15:55:23.594843 jq[1483]: true Oct 27 15:55:23.596185 extend-filesystems[1498]: resize2fs 1.47.3 (8-Jul-2025) Oct 27 15:55:23.580144 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 27 15:55:23.607582 update_engine[1481]: I20251027 15:55:23.606590 1481 main.cc:92] Flatcar Update Engine starting Oct 27 15:55:23.580310 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 27 15:55:23.580694 systemd[1]: motdgen.service: Deactivated successfully. Oct 27 15:55:23.580863 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 27 15:55:23.608149 jq[1499]: true Oct 27 15:55:23.582516 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 27 15:55:23.582689 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 27 15:55:23.612296 extend-filesystems[1498]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 27 15:55:23.612296 extend-filesystems[1498]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 27 15:55:23.612296 extend-filesystems[1498]: The filesystem on /dev/vda9 is now 474107 (4k) blocks long. Oct 27 15:55:23.610988 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 27 15:55:23.638135 update_engine[1481]: I20251027 15:55:23.622359 1481 update_check_scheduler.cc:74] Next update check in 11m39s Oct 27 15:55:23.638175 extend-filesystems[1464]: Resized filesystem in /dev/vda9 Oct 27 15:55:23.619117 dbus-daemon[1461]: [system] SELinux support is enabled Oct 27 15:55:23.614379 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 27 15:55:23.626166 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 27 15:55:23.642456 bash[1529]: Updated "/home/core/.ssh/authorized_keys" Oct 27 15:55:23.642744 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 27 15:55:23.648059 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 27 15:55:23.655842 systemd[1]: Started update-engine.service - Update Engine. Oct 27 15:55:23.657268 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 27 15:55:23.657357 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 27 15:55:23.657378 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 27 15:55:23.658750 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 27 15:55:23.658771 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 27 15:55:23.661871 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 27 15:55:23.670429 systemd-logind[1472]: Watching system buttons on /dev/input/event0 (Power Button) Oct 27 15:55:23.673091 systemd-logind[1472]: New seat seat0. Oct 27 15:55:23.674113 systemd[1]: Started systemd-logind.service - User Login Management. Oct 27 15:55:23.724565 locksmithd[1533]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 27 15:55:23.770403 containerd[1500]: time="2025-10-27T15:55:23Z" 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 27 15:55:23.772197 containerd[1500]: time="2025-10-27T15:55:23.772145800Z" level=info msg="starting containerd" revision=cb1076646aa3740577fafbf3d914198b7fe8e3f7 version=v2.1.4 Oct 27 15:55:23.782337 containerd[1500]: time="2025-10-27T15:55:23.782294240Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.32µs" Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782416920Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782464320Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782476520Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782623080Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782639440Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782713160Z" 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 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782725440Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782911920Z" 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 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782926240Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782936680Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.782944280Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783492 containerd[1500]: time="2025-10-27T15:55:23.783123680Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783137720Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783203960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783358160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783390600Z" 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 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783407000Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 27 15:55:23.783774 containerd[1500]: time="2025-10-27T15:55:23.783449840Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 27 15:55:23.784820 containerd[1500]: time="2025-10-27T15:55:23.784791720Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 27 15:55:23.784978 containerd[1500]: time="2025-10-27T15:55:23.784953840Z" level=info msg="metadata content store policy set" policy=shared Oct 27 15:55:23.788883 containerd[1500]: time="2025-10-27T15:55:23.788856240Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 27 15:55:23.789027 containerd[1500]: time="2025-10-27T15:55:23.789010720Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:55:23.789230 containerd[1500]: time="2025-10-27T15:55:23.789208520Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:55:23.789290 containerd[1500]: time="2025-10-27T15:55:23.789276960Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 27 15:55:23.789343 containerd[1500]: time="2025-10-27T15:55:23.789329960Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 27 15:55:23.789391 containerd[1500]: time="2025-10-27T15:55:23.789379800Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 27 15:55:23.789441 containerd[1500]: time="2025-10-27T15:55:23.789429080Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 27 15:55:23.789501 containerd[1500]: time="2025-10-27T15:55:23.789487880Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 27 15:55:23.789551 containerd[1500]: time="2025-10-27T15:55:23.789539960Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 27 15:55:23.789601 containerd[1500]: time="2025-10-27T15:55:23.789588600Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 27 15:55:23.789650 containerd[1500]: time="2025-10-27T15:55:23.789638920Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 27 15:55:23.789722 containerd[1500]: time="2025-10-27T15:55:23.789709320Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 27 15:55:23.789771 containerd[1500]: time="2025-10-27T15:55:23.789758760Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 27 15:55:23.789820 containerd[1500]: time="2025-10-27T15:55:23.789808360Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 27 15:55:23.790010 containerd[1500]: time="2025-10-27T15:55:23.789976840Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 27 15:55:23.790085 containerd[1500]: time="2025-10-27T15:55:23.790069960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 27 15:55:23.790139 containerd[1500]: time="2025-10-27T15:55:23.790126840Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 27 15:55:23.790201 containerd[1500]: time="2025-10-27T15:55:23.790188240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 27 15:55:23.790261 containerd[1500]: time="2025-10-27T15:55:23.790247400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 27 15:55:23.790318 containerd[1500]: time="2025-10-27T15:55:23.790306040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 27 15:55:23.790369 containerd[1500]: time="2025-10-27T15:55:23.790356160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 27 15:55:23.790415 containerd[1500]: time="2025-10-27T15:55:23.790404960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 27 15:55:23.790462 containerd[1500]: time="2025-10-27T15:55:23.790450960Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 27 15:55:23.790511 containerd[1500]: time="2025-10-27T15:55:23.790499640Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 27 15:55:23.790577 containerd[1500]: time="2025-10-27T15:55:23.790562840Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 27 15:55:23.790644 containerd[1500]: time="2025-10-27T15:55:23.790631120Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 27 15:55:23.790769 containerd[1500]: time="2025-10-27T15:55:23.790753640Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 27 15:55:23.790842 containerd[1500]: time="2025-10-27T15:55:23.790829040Z" level=info msg="Start snapshots syncer" Oct 27 15:55:23.790907 containerd[1500]: time="2025-10-27T15:55:23.790895800Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 27 15:55:23.791469 containerd[1500]: time="2025-10-27T15:55:23.791427880Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 27 15:55:23.791623 containerd[1500]: time="2025-10-27T15:55:23.791605680Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 27 15:55:23.791778 containerd[1500]: time="2025-10-27T15:55:23.791759960Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 27 15:55:23.791987 containerd[1500]: time="2025-10-27T15:55:23.791964640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 27 15:55:23.792097 containerd[1500]: time="2025-10-27T15:55:23.792079920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 27 15:55:23.792154 containerd[1500]: time="2025-10-27T15:55:23.792141440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 27 15:55:23.792202 containerd[1500]: time="2025-10-27T15:55:23.792191280Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 27 15:55:23.792260 containerd[1500]: time="2025-10-27T15:55:23.792247360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 27 15:55:23.792310 containerd[1500]: time="2025-10-27T15:55:23.792297880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 27 15:55:23.792361 containerd[1500]: time="2025-10-27T15:55:23.792349520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 27 15:55:23.792419 containerd[1500]: time="2025-10-27T15:55:23.792406200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 27 15:55:23.792470 containerd[1500]: time="2025-10-27T15:55:23.792458040Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 27 15:55:23.792559 containerd[1500]: time="2025-10-27T15:55:23.792545600Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 27 15:55:23.792621 containerd[1500]: time="2025-10-27T15:55:23.792605360Z" 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 27 15:55:23.792682 containerd[1500]: time="2025-10-27T15:55:23.792653600Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 15:55:23.792732 containerd[1500]: time="2025-10-27T15:55:23.792719040Z" 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 27 15:55:23.792803 containerd[1500]: time="2025-10-27T15:55:23.792779160Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 27 15:55:23.792858 containerd[1500]: time="2025-10-27T15:55:23.792844480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 27 15:55:23.792911 containerd[1500]: time="2025-10-27T15:55:23.792898080Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 27 15:55:23.792960 containerd[1500]: time="2025-10-27T15:55:23.792948960Z" level=info msg="runtime interface created" Oct 27 15:55:23.793013 containerd[1500]: time="2025-10-27T15:55:23.793002440Z" level=info msg="created NRI interface" Oct 27 15:55:23.793061 containerd[1500]: time="2025-10-27T15:55:23.793049600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 27 15:55:23.793112 containerd[1500]: time="2025-10-27T15:55:23.793100080Z" level=info msg="Connect containerd service" Oct 27 15:55:23.793187 containerd[1500]: time="2025-10-27T15:55:23.793174840Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 27 15:55:23.793978 containerd[1500]: time="2025-10-27T15:55:23.793947800Z" 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 27 15:55:23.858901 containerd[1500]: time="2025-10-27T15:55:23.858830440Z" level=info msg="Start subscribing containerd event" Oct 27 15:55:23.859057 containerd[1500]: time="2025-10-27T15:55:23.859043160Z" level=info msg="Start recovering state" Oct 27 15:55:23.859219 containerd[1500]: time="2025-10-27T15:55:23.859203880Z" level=info msg="Start event monitor" Oct 27 15:55:23.859288 containerd[1500]: time="2025-10-27T15:55:23.859274880Z" level=info msg="Start cni network conf syncer for default" Oct 27 15:55:23.859399 containerd[1500]: time="2025-10-27T15:55:23.859216800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 27 15:55:23.859430 containerd[1500]: time="2025-10-27T15:55:23.859365960Z" level=info msg="Start streaming server" Oct 27 15:55:23.859450 containerd[1500]: time="2025-10-27T15:55:23.859436480Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 27 15:55:23.859468 containerd[1500]: time="2025-10-27T15:55:23.859446600Z" level=info msg="runtime interface starting up..." Oct 27 15:55:23.859468 containerd[1500]: time="2025-10-27T15:55:23.859423600Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 27 15:55:23.859500 containerd[1500]: time="2025-10-27T15:55:23.859460600Z" level=info msg="starting plugins..." Oct 27 15:55:23.859522 containerd[1500]: time="2025-10-27T15:55:23.859500040Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 27 15:55:23.859666 containerd[1500]: time="2025-10-27T15:55:23.859616120Z" level=info msg="containerd successfully booted in 0.089564s" Oct 27 15:55:23.859779 systemd[1]: Started containerd.service - containerd container runtime. Oct 27 15:55:24.179298 sshd_keygen[1495]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 27 15:55:24.198341 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 27 15:55:24.201087 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 27 15:55:24.222121 systemd[1]: issuegen.service: Deactivated successfully. Oct 27 15:55:24.222356 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 27 15:55:24.224867 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 27 15:55:24.247754 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 27 15:55:24.250381 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 27 15:55:24.253899 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 27 15:55:24.255154 systemd[1]: Reached target getty.target - Login Prompts. Oct 27 15:55:24.698090 systemd-networkd[1411]: eth0: Gained IPv6LL Oct 27 15:55:24.700787 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 27 15:55:24.702469 systemd[1]: Reached target network-online.target - Network is Online. Oct 27 15:55:24.706042 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 27 15:55:24.708178 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 27 15:55:24.734337 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 27 15:55:24.735867 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 27 15:55:24.736747 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 27 15:55:24.738622 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 27 15:55:24.738870 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 27 15:55:24.742319 systemd[1]: Startup finished in 1.192s (kernel) + 3.960s (initrd) + 2.730s (userspace) = 7.884s. Oct 27 15:55:29.435734 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 27 15:55:29.436769 systemd[1]: Started sshd@0-10.0.0.135:22-10.0.0.1:60900.service - OpenSSH per-connection server daemon (10.0.0.1:60900). Oct 27 15:55:29.508983 sshd[1595]: Accepted publickey for core from 10.0.0.1 port 60900 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:29.510772 sshd-session[1595]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:29.516759 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 27 15:55:29.517798 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 27 15:55:29.523864 systemd-logind[1472]: New session 1 of user core. Oct 27 15:55:29.537604 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 27 15:55:29.539962 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 27 15:55:29.554732 (systemd)[1600]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 27 15:55:29.556899 systemd-logind[1472]: New session c1 of user core. Oct 27 15:55:29.656355 systemd[1600]: Queued start job for default target default.target. Oct 27 15:55:29.677524 systemd[1600]: Created slice app.slice - User Application Slice. Oct 27 15:55:29.677552 systemd[1600]: Reached target paths.target - Paths. Oct 27 15:55:29.677589 systemd[1600]: Reached target timers.target - Timers. Oct 27 15:55:29.678770 systemd[1600]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 27 15:55:29.688174 systemd[1600]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 27 15:55:29.688231 systemd[1600]: Reached target sockets.target - Sockets. Oct 27 15:55:29.688267 systemd[1600]: Reached target basic.target - Basic System. Oct 27 15:55:29.688295 systemd[1600]: Reached target default.target - Main User Target. Oct 27 15:55:29.688326 systemd[1600]: Startup finished in 126ms. Oct 27 15:55:29.688463 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 27 15:55:29.689747 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 27 15:55:29.750941 systemd[1]: Started sshd@1-10.0.0.135:22-10.0.0.1:60908.service - OpenSSH per-connection server daemon (10.0.0.1:60908). Oct 27 15:55:29.807168 sshd[1611]: Accepted publickey for core from 10.0.0.1 port 60908 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:29.808287 sshd-session[1611]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:29.811954 systemd-logind[1472]: New session 2 of user core. Oct 27 15:55:29.820836 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 27 15:55:29.871909 sshd[1614]: Connection closed by 10.0.0.1 port 60908 Oct 27 15:55:29.872326 sshd-session[1611]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:29.891615 systemd[1]: sshd@1-10.0.0.135:22-10.0.0.1:60908.service: Deactivated successfully. Oct 27 15:55:29.893188 systemd[1]: session-2.scope: Deactivated successfully. Oct 27 15:55:29.895822 systemd-logind[1472]: Session 2 logged out. Waiting for processes to exit. Oct 27 15:55:29.897762 systemd[1]: Started sshd@2-10.0.0.135:22-10.0.0.1:60912.service - OpenSSH per-connection server daemon (10.0.0.1:60912). Oct 27 15:55:29.898368 systemd-logind[1472]: Removed session 2. Oct 27 15:55:29.956390 sshd[1620]: Accepted publickey for core from 10.0.0.1 port 60912 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:29.957536 sshd-session[1620]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:29.961949 systemd-logind[1472]: New session 3 of user core. Oct 27 15:55:29.974824 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 27 15:55:30.022707 sshd[1623]: Connection closed by 10.0.0.1 port 60912 Oct 27 15:55:30.023110 sshd-session[1620]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:30.033515 systemd[1]: sshd@2-10.0.0.135:22-10.0.0.1:60912.service: Deactivated successfully. Oct 27 15:55:30.037007 systemd[1]: session-3.scope: Deactivated successfully. Oct 27 15:55:30.037752 systemd-logind[1472]: Session 3 logged out. Waiting for processes to exit. Oct 27 15:55:30.039833 systemd[1]: Started sshd@3-10.0.0.135:22-10.0.0.1:60922.service - OpenSSH per-connection server daemon (10.0.0.1:60922). Oct 27 15:55:30.040280 systemd-logind[1472]: Removed session 3. Oct 27 15:55:30.096282 sshd[1629]: Accepted publickey for core from 10.0.0.1 port 60922 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:30.097418 sshd-session[1629]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:30.101238 systemd-logind[1472]: New session 4 of user core. Oct 27 15:55:30.114837 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 27 15:55:30.166493 sshd[1632]: Connection closed by 10.0.0.1 port 60922 Oct 27 15:55:30.166355 sshd-session[1629]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:30.182587 systemd[1]: sshd@3-10.0.0.135:22-10.0.0.1:60922.service: Deactivated successfully. Oct 27 15:55:30.184941 systemd[1]: session-4.scope: Deactivated successfully. Oct 27 15:55:30.185596 systemd-logind[1472]: Session 4 logged out. Waiting for processes to exit. Oct 27 15:55:30.187628 systemd[1]: Started sshd@4-10.0.0.135:22-10.0.0.1:60926.service - OpenSSH per-connection server daemon (10.0.0.1:60926). Oct 27 15:55:30.188192 systemd-logind[1472]: Removed session 4. Oct 27 15:55:30.249315 sshd[1638]: Accepted publickey for core from 10.0.0.1 port 60926 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:30.250429 sshd-session[1638]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:30.255081 systemd-logind[1472]: New session 5 of user core. Oct 27 15:55:30.266834 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 27 15:55:30.324167 sudo[1642]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 27 15:55:30.324443 sudo[1642]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 15:55:30.336798 sudo[1642]: pam_unix(sudo:session): session closed for user root Oct 27 15:55:30.338396 sshd[1641]: Connection closed by 10.0.0.1 port 60926 Oct 27 15:55:30.338845 sshd-session[1638]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:30.348714 systemd[1]: sshd@4-10.0.0.135:22-10.0.0.1:60926.service: Deactivated successfully. Oct 27 15:55:30.350204 systemd[1]: session-5.scope: Deactivated successfully. Oct 27 15:55:30.352256 systemd-logind[1472]: Session 5 logged out. Waiting for processes to exit. Oct 27 15:55:30.354253 systemd[1]: Started sshd@5-10.0.0.135:22-10.0.0.1:60940.service - OpenSSH per-connection server daemon (10.0.0.1:60940). Oct 27 15:55:30.355044 systemd-logind[1472]: Removed session 5. Oct 27 15:55:30.402747 sshd[1648]: Accepted publickey for core from 10.0.0.1 port 60940 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:30.403972 sshd-session[1648]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:30.407623 systemd-logind[1472]: New session 6 of user core. Oct 27 15:55:30.421817 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 27 15:55:30.473289 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 27 15:55:30.473555 sudo[1653]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 15:55:30.478287 sudo[1653]: pam_unix(sudo:session): session closed for user root Oct 27 15:55:30.483720 sudo[1652]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 27 15:55:30.483966 sudo[1652]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 15:55:30.493395 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 27 15:55:30.532840 augenrules[1675]: No rules Oct 27 15:55:30.533487 systemd[1]: audit-rules.service: Deactivated successfully. Oct 27 15:55:30.535706 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 27 15:55:30.536929 sudo[1652]: pam_unix(sudo:session): session closed for user root Oct 27 15:55:30.538337 sshd[1651]: Connection closed by 10.0.0.1 port 60940 Oct 27 15:55:30.538637 sshd-session[1648]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:30.549539 systemd[1]: sshd@5-10.0.0.135:22-10.0.0.1:60940.service: Deactivated successfully. Oct 27 15:55:30.551125 systemd[1]: session-6.scope: Deactivated successfully. Oct 27 15:55:30.553210 systemd-logind[1472]: Session 6 logged out. Waiting for processes to exit. Oct 27 15:55:30.555479 systemd[1]: Started sshd@6-10.0.0.135:22-10.0.0.1:60950.service - OpenSSH per-connection server daemon (10.0.0.1:60950). Oct 27 15:55:30.556193 systemd-logind[1472]: Removed session 6. Oct 27 15:55:30.603856 sshd[1684]: Accepted publickey for core from 10.0.0.1 port 60950 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:30.604961 sshd-session[1684]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:30.608518 systemd-logind[1472]: New session 7 of user core. Oct 27 15:55:30.624813 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 27 15:55:30.678236 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 27 15:55:30.702971 (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 27 15:55:30.903078 dockerd[1689]: time="2025-10-27T15:55:30.903012184Z" level=info msg="Starting up" Oct 27 15:55:30.903952 dockerd[1689]: time="2025-10-27T15:55:30.903930124Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 27 15:55:30.914206 dockerd[1689]: time="2025-10-27T15:55:30.914172338Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 27 15:55:30.948619 dockerd[1689]: time="2025-10-27T15:55:30.948569853Z" level=info msg="Loading containers: start." Oct 27 15:55:30.956683 kernel: Initializing XFRM netlink socket Oct 27 15:55:31.145451 systemd-networkd[1411]: docker0: Link UP Oct 27 15:55:31.149283 dockerd[1689]: time="2025-10-27T15:55:31.149169750Z" level=info msg="Loading containers: done." Oct 27 15:55:31.160451 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck866039253-merged.mount: Deactivated successfully. Oct 27 15:55:31.161976 dockerd[1689]: time="2025-10-27T15:55:31.161941301Z" 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 27 15:55:31.162050 dockerd[1689]: time="2025-10-27T15:55:31.162023398Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 27 15:55:31.162112 dockerd[1689]: time="2025-10-27T15:55:31.162096265Z" level=info msg="Initializing buildkit" Oct 27 15:55:31.183739 dockerd[1689]: time="2025-10-27T15:55:31.183694039Z" level=info msg="Completed buildkit initialization" Oct 27 15:55:31.188224 dockerd[1689]: time="2025-10-27T15:55:31.188193741Z" level=info msg="Daemon has completed initialization" Oct 27 15:55:31.188278 dockerd[1689]: time="2025-10-27T15:55:31.188237718Z" level=info msg="API listen on /run/docker.sock" Oct 27 15:55:31.188407 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 27 15:55:31.196390 sshd[1687]: Connection closed by 10.0.0.1 port 60950 Oct 27 15:55:31.196819 sshd-session[1684]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:31.203533 systemd[1]: sshd@6-10.0.0.135:22-10.0.0.1:60950.service: Deactivated successfully. Oct 27 15:55:31.204993 systemd[1]: session-7.scope: Deactivated successfully. Oct 27 15:55:31.205864 systemd-logind[1472]: Session 7 logged out. Waiting for processes to exit. Oct 27 15:55:31.207978 systemd[1]: Started sshd@7-10.0.0.135:22-10.0.0.1:60958.service - OpenSSH per-connection server daemon (10.0.0.1:60958). Oct 27 15:55:31.208649 systemd-logind[1472]: Removed session 7. Oct 27 15:55:31.264885 sshd[1904]: Accepted publickey for core from 10.0.0.1 port 60958 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:31.265952 sshd-session[1904]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:31.270542 systemd-logind[1472]: New session 8 of user core. Oct 27 15:55:31.289841 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 27 15:55:32.694114 systemd[1]: var-lib-docker-overlay2-5e6b62475ec1ef422363a92af3d1484d824c79d1f9eff864012fa6eb395c22b5\x2dinit-merged.mount: Deactivated successfully. Oct 27 15:55:32.741302 containerd[1500]: time="2025-10-27T15:55:32.741235248Z" level=info msg="connecting to shim 3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac" address="unix:///run/containerd/s/b04cfcf0c6804f2d0549c12f9b35f49de8c326bf48ceeff7cd525938adf9be02" namespace=moby protocol=ttrpc version=3 Oct 27 15:55:32.765809 systemd[1]: Started docker-3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac.scope - libcontainer container 3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac. Oct 27 15:55:32.776948 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 27 15:55:32.795513 kernel: docker0: port 1(veth045ea72) entered blocking state Oct 27 15:55:32.795595 kernel: docker0: port 1(veth045ea72) entered disabled state Oct 27 15:55:32.795611 kernel: veth045ea72: entered allmulticast mode Oct 27 15:55:32.796675 kernel: veth045ea72: entered promiscuous mode Oct 27 15:55:32.796994 systemd-networkd[1411]: veth045ea72: Link UP Oct 27 15:55:32.812259 kernel: eth0: renamed from vethc4a7274 Oct 27 15:55:32.812339 kernel: docker0: port 1(veth045ea72) entered blocking state Oct 27 15:55:32.812366 kernel: docker0: port 1(veth045ea72) entered forwarding state Oct 27 15:55:32.813535 systemd-networkd[1411]: veth045ea72: Gained carrier Oct 27 15:55:32.813828 systemd-networkd[1411]: docker0: Gained carrier Oct 27 15:55:32.860958 sshd[1908]: Connection closed by 10.0.0.1 port 60958 Oct 27 15:55:32.861500 sshd-session[1904]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:32.870612 systemd[1]: sshd@7-10.0.0.135:22-10.0.0.1:60958.service: Deactivated successfully. Oct 27 15:55:32.875062 systemd[1]: session-8.scope: Deactivated successfully. Oct 27 15:55:32.875873 systemd-logind[1472]: Session 8 logged out. Waiting for processes to exit. Oct 27 15:55:32.877594 systemd-logind[1472]: Removed session 8. Oct 27 15:55:32.879054 systemd[1]: Started sshd@8-10.0.0.135:22-10.0.0.1:60974.service - OpenSSH per-connection server daemon (10.0.0.1:60974). Oct 27 15:55:32.929289 sshd[1984]: Accepted publickey for core from 10.0.0.1 port 60974 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:32.930520 sshd-session[1984]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:32.934728 systemd-logind[1472]: New session 9 of user core. Oct 27 15:55:32.944853 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 27 15:55:32.998653 sshd[1987]: Connection closed by 10.0.0.1 port 60974 Oct 27 15:55:32.999117 sshd-session[1984]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:33.018645 systemd[1]: sshd@8-10.0.0.135:22-10.0.0.1:60974.service: Deactivated successfully. Oct 27 15:55:33.021012 systemd[1]: session-9.scope: Deactivated successfully. Oct 27 15:55:33.021717 systemd-logind[1472]: Session 9 logged out. Waiting for processes to exit. Oct 27 15:55:33.024103 systemd[1]: Started sshd@9-10.0.0.135:22-10.0.0.1:60986.service - OpenSSH per-connection server daemon (10.0.0.1:60986). Oct 27 15:55:33.024783 systemd-logind[1472]: Removed session 9. Oct 27 15:55:33.086678 sshd[1993]: Accepted publickey for core from 10.0.0.1 port 60986 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:33.087809 sshd-session[1993]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:33.092093 systemd-logind[1472]: New session 10 of user core. Oct 27 15:55:33.103804 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 27 15:55:33.155956 sudo[1997]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1500 Oct 27 15:55:33.156228 sudo[1997]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 15:55:33.159396 sudo[1997]: pam_unix(sudo:session): session closed for user root Oct 27 15:55:33.160707 dockerd[1689]: time="2025-10-27T15:55:33.160245081Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 27 15:55:33.160707 dockerd[1689]: time="2025-10-27T15:55:33.160299952Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 27 15:55:33.161001 containerd[1500]: time="2025-10-27T15:55:33.160613573Z" level=info msg="Stop CRI service" Oct 27 15:55:33.161001 containerd[1500]: time="2025-10-27T15:55:33.160844849Z" level=info msg="Stop CRI service" Oct 27 15:55:33.161742 dockerd[1689]: time="2025-10-27T15:55:33.161153216Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 27 15:55:33.161742 dockerd[1689]: time="2025-10-27T15:55:33.161179408Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 27 15:55:33.161866 sshd[1996]: Connection closed by 10.0.0.1 port 60986 Oct 27 15:55:33.162096 sshd-session[1993]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:33.171589 systemd[1]: containerd.service: Deactivated successfully. Oct 27 15:55:33.171713 systemd[1]: containerd.service: Unit process 1934 (containerd-shim) remains running after unit stopped. Oct 27 15:55:33.171969 systemd[1]: containerd.service: Consumed 271ms CPU time, 106.7M memory peak. Oct 27 15:55:33.172343 systemd[1]: sshd@9-10.0.0.135:22-10.0.0.1:60986.service: Deactivated successfully. Oct 27 15:55:33.173604 systemd[1]: session-10.scope: Deactivated successfully. Oct 27 15:55:33.179761 systemd[1]: Started sshd@10-10.0.0.135:22-10.0.0.1:32770.service - OpenSSH per-connection server daemon (10.0.0.1:32770). Oct 27 15:55:33.180273 systemd-logind[1472]: Session 10 logged out. Waiting for processes to exit. Oct 27 15:55:33.181193 systemd-logind[1472]: Removed session 10. Oct 27 15:55:33.238097 sshd[2004]: Accepted publickey for core from 10.0.0.1 port 32770 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:33.239368 sshd-session[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:33.243947 systemd-logind[1472]: New session 11 of user core. Oct 27 15:55:33.253824 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 27 15:55:33.308363 sshd[2007]: Connection closed by 10.0.0.1 port 32770 Oct 27 15:55:33.308810 sshd-session[2004]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:33.312166 systemd[1]: sshd@10-10.0.0.135:22-10.0.0.1:32770.service: Deactivated successfully. Oct 27 15:55:33.313791 systemd[1]: session-11.scope: Deactivated successfully. Oct 27 15:55:33.314549 systemd-logind[1472]: Session 11 logged out. Waiting for processes to exit. Oct 27 15:55:33.315758 systemd-logind[1472]: Removed session 11. Oct 27 15:55:34.233812 systemd-networkd[1411]: docker0: Gained IPv6LL Oct 27 15:55:34.425800 systemd-networkd[1411]: veth045ea72: Gained IPv6LL Oct 27 15:55:38.334683 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Oct 27 15:55:38.335069 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 27 15:55:38.335240 dockerd[1689]: time="2025-10-27T15:55:38.335090423Z" level=info msg="Processing signal 'terminated'" Oct 27 15:55:39.349884 systemd[1]: Started sshd@11-10.0.0.135:22-10.0.0.1:43928.service - OpenSSH per-connection server daemon (10.0.0.1:43928). Oct 27 15:55:39.391316 sshd[2013]: Accepted publickey for core from 10.0.0.1 port 43928 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:39.392941 sshd-session[2013]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:39.397880 systemd-logind[1472]: New session 12 of user core. Oct 27 15:55:39.408813 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 27 15:55:39.463298 sshd[2016]: Connection closed by 10.0.0.1 port 43928 Oct 27 15:55:39.464766 sshd-session[2013]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:39.467833 systemd[1]: sshd@11-10.0.0.135:22-10.0.0.1:43928.service: Deactivated successfully. Oct 27 15:55:39.469863 systemd[1]: session-12.scope: Deactivated successfully. Oct 27 15:55:39.471345 systemd-logind[1472]: Session 12 logged out. Waiting for processes to exit. Oct 27 15:55:39.473283 systemd-logind[1472]: Removed session 12. Oct 27 15:55:45.494913 systemd[1]: Started sshd@12-10.0.0.135:22-10.0.0.1:43932.service - OpenSSH per-connection server daemon (10.0.0.1:43932). Oct 27 15:55:45.537507 sshd[2022]: Accepted publickey for core from 10.0.0.1 port 43932 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:45.538852 sshd-session[2022]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:45.543276 systemd-logind[1472]: New session 13 of user core. Oct 27 15:55:45.553860 systemd[1]: Started session-13.scope - Session 13 of User core. Oct 27 15:55:45.608305 sshd[2025]: Connection closed by 10.0.0.1 port 43932 Oct 27 15:55:45.608595 sshd-session[2022]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:45.612021 systemd[1]: sshd@12-10.0.0.135:22-10.0.0.1:43932.service: Deactivated successfully. Oct 27 15:55:45.614184 systemd[1]: session-13.scope: Deactivated successfully. Oct 27 15:55:45.614939 systemd-logind[1472]: Session 13 logged out. Waiting for processes to exit. Oct 27 15:55:45.616310 systemd-logind[1472]: Removed session 13. Oct 27 15:55:51.632897 systemd[1]: Started sshd@13-10.0.0.135:22-10.0.0.1:57272.service - OpenSSH per-connection server daemon (10.0.0.1:57272). Oct 27 15:55:51.690099 sshd[2031]: Accepted publickey for core from 10.0.0.1 port 57272 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:51.691267 sshd-session[2031]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:51.696984 systemd-logind[1472]: New session 14 of user core. Oct 27 15:55:51.710849 systemd[1]: Started session-14.scope - Session 14 of User core. Oct 27 15:55:51.765854 sshd[2034]: Connection closed by 10.0.0.1 port 57272 Oct 27 15:55:51.766320 sshd-session[2031]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:51.770803 systemd[1]: sshd@13-10.0.0.135:22-10.0.0.1:57272.service: Deactivated successfully. Oct 27 15:55:51.775109 systemd[1]: session-14.scope: Deactivated successfully. Oct 27 15:55:51.777341 systemd-logind[1472]: Session 14 logged out. Waiting for processes to exit. Oct 27 15:55:51.778651 systemd-logind[1472]: Removed session 14. Oct 27 15:55:53.336389 dockerd[1689]: time="2025-10-27T15:55:53.336291203Z" level=error msg="Force shutdown daemon" Oct 27 15:55:53.336865 dockerd[1689]: time="2025-10-27T15:55:53.336496679Z" level=info msg="Daemon shutdown complete" Oct 27 15:55:53.339576 systemd[1]: docker.service: Deactivated successfully. Oct 27 15:55:53.340755 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 27 15:55:53.340822 systemd[1]: docker.service: Consumed 861ms CPU time, 123.7M memory peak. Oct 27 15:55:53.341227 systemd[1]: docker.socket: Deactivated successfully. Oct 27 15:55:53.341501 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 27 15:55:53.341537 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 27 15:55:53.342847 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 27 15:55:53.342993 systemd[1]: containerd.service: Found left-over process 1934 (containerd-shim) in control group while starting unit. Ignoring. Oct 27 15:55:53.343001 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 27 15:55:53.350114 systemd[1]: Starting containerd.service - containerd container runtime... Oct 27 15:55:53.350532 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 27 15:55:53.361292 systemd[1]: containerd.service: Found left-over process 1934 (containerd-shim) in control group while starting unit. Ignoring. Oct 27 15:55:53.361305 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 27 15:55:53.379718 containerd[2045]: time="2025-10-27T15:55:53Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 27 15:55:53.380259 containerd[2045]: time="2025-10-27T15:55:53.380228916Z" level=info msg="starting containerd" revision=cb1076646aa3740577fafbf3d914198b7fe8e3f7 version=v2.1.4 Oct 27 15:55:53.389931 containerd[2045]: time="2025-10-27T15:55:53.389803086Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.447µs" Oct 27 15:55:53.389931 containerd[2045]: time="2025-10-27T15:55:53.389841435Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 27 15:55:53.390166 containerd[2045]: time="2025-10-27T15:55:53.390117364Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 27 15:55:53.390166 containerd[2045]: time="2025-10-27T15:55:53.390152231Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 27 15:55:53.390235 containerd[2045]: time="2025-10-27T15:55:53.390181293Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 27 15:55:53.390235 containerd[2045]: time="2025-10-27T15:55:53.390192461Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390235 containerd[2045]: time="2025-10-27T15:55:53.390210755Z" 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 27 15:55:53.390235 containerd[2045]: time="2025-10-27T15:55:53.390220322Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390431 containerd[2045]: time="2025-10-27T15:55:53.390399298Z" 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 27 15:55:53.390431 containerd[2045]: time="2025-10-27T15:55:53.390418152Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390431 containerd[2045]: time="2025-10-27T15:55:53.390428840Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390506 containerd[2045]: time="2025-10-27T15:55:53.390436886Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390573 containerd[2045]: time="2025-10-27T15:55:53.390553775Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390598 containerd[2045]: time="2025-10-27T15:55:53.390571268Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390598 containerd[2045]: time="2025-10-27T15:55:53.390591363Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390702 containerd[2045]: time="2025-10-27T15:55:53.390686515Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 27 15:55:53.390730 containerd[2045]: time="2025-10-27T15:55:53.390716058Z" 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 27 15:55:53.390730 containerd[2045]: time="2025-10-27T15:55:53.390727106Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 27 15:55:53.390771 containerd[2045]: time="2025-10-27T15:55:53.390763654Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 27 15:55:53.390969 containerd[2045]: time="2025-10-27T15:55:53.390952557Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 27 15:55:53.391003 containerd[2045]: time="2025-10-27T15:55:53.390978256Z" level=info msg="metadata content store policy set" policy=shared Oct 27 15:55:53.391133 containerd[2045]: time="2025-10-27T15:55:53.391114800Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 27 15:55:53.391169 containerd[2045]: time="2025-10-27T15:55:53.391144182Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:55:53.391224 containerd[2045]: time="2025-10-27T15:55:53.391183572Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:55:53.391224 containerd[2045]: time="2025-10-27T15:55:53.391197022Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 27 15:55:53.391224 containerd[2045]: time="2025-10-27T15:55:53.391208270Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391224002Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391241496Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391251543Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391273320Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391284408Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391294776Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391311349Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391320355Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 27 15:55:53.391349 containerd[2045]: time="2025-10-27T15:55:53.391331404Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 27 15:55:53.391606 containerd[2045]: time="2025-10-27T15:55:53.391550209Z" level=info msg="connecting to shim 3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac" address="unix:///run/containerd/s/b04cfcf0c6804f2d0549c12f9b35f49de8c326bf48ceeff7cd525938adf9be02" namespace=moby protocol=ttrpc version=3 Oct 27 15:55:53.399398 containerd[2045]: time="2025-10-27T15:55:53.399364847Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 27 15:55:53.399458 containerd[2045]: time="2025-10-27T15:55:53.399410362Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 27 15:55:53.399458 containerd[2045]: time="2025-10-27T15:55:53.399426974Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 27 15:55:53.399458 containerd[2045]: time="2025-10-27T15:55:53.399437943Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 27 15:55:53.399458 containerd[2045]: time="2025-10-27T15:55:53.399450432Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399460720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399472249Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399482576Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399504593Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399516242Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399526570Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 27 15:55:53.399564 containerd[2045]: time="2025-10-27T15:55:53.399551709Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 27 15:55:53.399709 containerd[2045]: time="2025-10-27T15:55:53.399587296Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 27 15:55:53.399709 containerd[2045]: time="2025-10-27T15:55:53.399602467Z" level=info msg="Start snapshots syncer" Oct 27 15:55:53.399709 containerd[2045]: time="2025-10-27T15:55:53.399636613Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 27 15:55:53.399901 containerd[2045]: time="2025-10-27T15:55:53.399846892Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 27 15:55:53.400004 containerd[2045]: time="2025-10-27T15:55:53.399903976Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 27 15:55:53.400004 containerd[2045]: time="2025-10-27T15:55:53.399993603Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 27 15:55:53.400050 containerd[2045]: time="2025-10-27T15:55:53.400035875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 27 15:55:53.400074 containerd[2045]: time="2025-10-27T15:55:53.400053249Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 27 15:55:53.400074 containerd[2045]: time="2025-10-27T15:55:53.400063456Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 27 15:55:53.400108 containerd[2045]: time="2025-10-27T15:55:53.400072823Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 27 15:55:53.400108 containerd[2045]: time="2025-10-27T15:55:53.400084872Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 27 15:55:53.400108 containerd[2045]: time="2025-10-27T15:55:53.400095400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 27 15:55:53.400108 containerd[2045]: time="2025-10-27T15:55:53.400105248Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 27 15:55:53.400176 containerd[2045]: time="2025-10-27T15:55:53.400114815Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 27 15:55:53.400176 containerd[2045]: time="2025-10-27T15:55:53.400124863Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 27 15:55:53.400176 containerd[2045]: time="2025-10-27T15:55:53.400159769Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 27 15:55:53.400176 containerd[2045]: time="2025-10-27T15:55:53.400172339Z" 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 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400180785Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400190392Z" 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 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400197998Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400206925Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400217893Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400229022Z" level=info msg="runtime interface created" Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400233745Z" level=info msg="created NRI interface" Oct 27 15:55:53.400247 containerd[2045]: time="2025-10-27T15:55:53.400241271Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 27 15:55:53.400377 containerd[2045]: time="2025-10-27T15:55:53.400251279Z" level=info msg="Connect containerd service" Oct 27 15:55:53.400377 containerd[2045]: time="2025-10-27T15:55:53.400269973Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 27 15:55:53.400771 containerd[2045]: time="2025-10-27T15:55:53.400743771Z" 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 27 15:55:53.418679 containerd[2045]: time="2025-10-27T15:55:53.418383610Z" level=info msg="Start subscribing containerd event" Oct 27 15:55:53.418788 containerd[2045]: time="2025-10-27T15:55:53.418766019Z" level=info msg="Start recovering state" Oct 27 15:55:53.418887 containerd[2045]: time="2025-10-27T15:55:53.418857328Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 27 15:55:53.418917 containerd[2045]: time="2025-10-27T15:55:53.418886871Z" level=info msg="Start event monitor" Oct 27 15:55:53.418941 containerd[2045]: time="2025-10-27T15:55:53.418913851Z" level=info msg="Start cni network conf syncer for default" Oct 27 15:55:53.418941 containerd[2045]: time="2025-10-27T15:55:53.418915492Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 27 15:55:53.418985 containerd[2045]: time="2025-10-27T15:55:53.418924059Z" level=info msg="Start streaming server" Oct 27 15:55:53.418985 containerd[2045]: time="2025-10-27T15:55:53.418958845Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 27 15:55:53.418985 containerd[2045]: time="2025-10-27T15:55:53.418970534Z" level=info msg="runtime interface starting up..." Oct 27 15:55:53.418985 containerd[2045]: time="2025-10-27T15:55:53.418982223Z" level=info msg="starting plugins..." Oct 27 15:55:53.419054 containerd[2045]: time="2025-10-27T15:55:53.418994072Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 27 15:55:53.419556 containerd[2045]: time="2025-10-27T15:55:53.419100513Z" level=info msg="containerd successfully booted in 0.039588s" Oct 27 15:55:53.419241 systemd[1]: Started containerd.service - containerd container runtime. Oct 27 15:55:53.421042 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 27 15:55:53.440957 (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 27 15:55:53.476327 dockerd[2073]: time="2025-10-27T15:55:53.476266683Z" level=info msg="Starting up" Oct 27 15:55:53.476849 dockerd[2073]: time="2025-10-27T15:55:53.476829869Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 27 15:55:53.486168 dockerd[2073]: time="2025-10-27T15:55:53.486060620Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 27 15:55:53.496093 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport3320119647-merged.mount: Deactivated successfully. Oct 27 15:55:53.507951 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck4208454869-merged.mount: Deactivated successfully. Oct 27 15:55:53.510871 dockerd[2073]: time="2025-10-27T15:55:53.510827295Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 27 15:55:53.519111 dockerd[2073]: time="2025-10-27T15:55:53.519072298Z" level=info msg="Loading containers: start." Oct 27 15:55:57.787429 systemd[1]: Started sshd@14-10.0.0.135:22-10.0.0.1:57276.service - OpenSSH per-connection server daemon (10.0.0.1:57276). Oct 27 15:55:57.852495 sshd[2109]: Accepted publickey for core from 10.0.0.1 port 57276 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:57.853508 sshd-session[2109]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:57.857559 systemd-logind[1472]: New session 15 of user core. Oct 27 15:55:57.871262 systemd[1]: Started session-15.scope - Session 15 of User core. Oct 27 15:55:57.924729 sshd[2112]: Connection closed by 10.0.0.1 port 57276 Oct 27 15:55:57.924996 sshd-session[2109]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:57.941726 systemd[1]: sshd@14-10.0.0.135:22-10.0.0.1:57276.service: Deactivated successfully. Oct 27 15:55:57.942974 systemd[1]: session-15.scope: Deactivated successfully. Oct 27 15:55:57.943728 systemd-logind[1472]: Session 15 logged out. Waiting for processes to exit. Oct 27 15:55:57.945605 systemd[1]: Started sshd@15-10.0.0.135:22-10.0.0.1:57284.service - OpenSSH per-connection server daemon (10.0.0.1:57284). Oct 27 15:55:57.946392 systemd-logind[1472]: Removed session 15. Oct 27 15:55:57.991043 sshd[2118]: Accepted publickey for core from 10.0.0.1 port 57284 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:57.992016 sshd-session[2118]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:57.995722 systemd-logind[1472]: New session 16 of user core. Oct 27 15:55:58.005569 systemd[1]: Started session-16.scope - Session 16 of User core. Oct 27 15:55:58.057742 sshd[2121]: Connection closed by 10.0.0.1 port 57284 Oct 27 15:55:58.057797 sshd-session[2118]: pam_unix(sshd:session): session closed for user core Oct 27 15:55:58.068470 systemd[1]: sshd@15-10.0.0.135:22-10.0.0.1:57284.service: Deactivated successfully. Oct 27 15:55:58.070847 systemd[1]: session-16.scope: Deactivated successfully. Oct 27 15:55:58.071437 systemd-logind[1472]: Session 16 logged out. Waiting for processes to exit. Oct 27 15:55:58.073920 systemd[1]: Started sshd@16-10.0.0.135:22-10.0.0.1:57298.service - OpenSSH per-connection server daemon (10.0.0.1:57298). Oct 27 15:55:58.074703 systemd-logind[1472]: Removed session 16. Oct 27 15:55:58.121345 sshd[2127]: Accepted publickey for core from 10.0.0.1 port 57298 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:55:58.122349 sshd-session[2127]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:55:58.126346 systemd-logind[1472]: New session 17 of user core. Oct 27 15:55:58.136816 systemd[1]: Started session-17.scope - Session 17 of User core. Oct 27 15:56:03.539769 dockerd[2073]: time="2025-10-27T15:56:03.539696631Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac Oct 27 15:56:03.554401 systemd[1]: docker-3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac.scope: Deactivated successfully. Oct 27 15:56:03.566597 containerd[2045]: time="2025-10-27T15:56:03.566553021Z" level=info msg="shim disconnected" id=3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac namespace=moby Oct 27 15:56:03.566879 containerd[2045]: time="2025-10-27T15:56:03.566588436Z" level=info msg="cleaning up after shim disconnected" id=3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac namespace=moby Oct 27 15:56:03.566879 containerd[2045]: time="2025-10-27T15:56:03.566700160Z" level=info msg="cleaning up dead shim" id=3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac namespace=moby Oct 27 15:56:03.579117 systemd[1]: var-lib-docker-overlay2-5e6b62475ec1ef422363a92af3d1484d824c79d1f9eff864012fa6eb395c22b5-merged.mount: Deactivated successfully. Oct 27 15:56:03.947817 systemd[1]: run-docker-netns-bd1442535355.mount: Deactivated successfully. Oct 27 15:56:03.947961 systemd-networkd[1411]: veth045ea72: Link DOWN Oct 27 15:56:03.947966 systemd-networkd[1411]: veth045ea72: Lost carrier Oct 27 15:56:03.949321 kernel: docker0: port 1(veth045ea72) entered disabled state Oct 27 15:56:03.949392 kernel: veth045ea72 (unregistering): left allmulticast mode Oct 27 15:56:03.950109 kernel: veth045ea72 (unregistering): left promiscuous mode Oct 27 15:56:03.950862 kernel: docker0: port 1(veth045ea72) entered disabled state Oct 27 15:56:03.951958 systemd-networkd[1411]: docker0: Lost carrier Oct 27 15:56:03.952970 dockerd[2073]: time="2025-10-27T15:56:03.952890234Z" level=info msg="Removing stale sandbox bd144253535590670be0138411aca92c5b2b39fc9ca21131db28a980be7157d9 (3fbe59a90382a61e1633d302315855c69f2957a2f5d7658f6a7595ba4ec4a9ac)" Oct 27 15:56:03.957110 dockerd[2073]: time="2025-10-27T15:56:03.957064132Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 27 15:56:03.957185 dockerd[2073]: time="2025-10-27T15:56:03.957112792Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 5f1cbd81e0e7911c6d0bf20ab04d30a9b0cbd3ed28ffb1981e56a9d06b063329 aa00e28fd2fcae54dd4b6a2e71d5fc6482c9a3c4d55eaf7c23af671f4e7f940c], retrying...." Oct 27 15:56:03.960448 systemd[1]: run-docker-netns-bd1442535355.mount: Deactivated successfully. Oct 27 15:56:04.144733 dockerd[2073]: time="2025-10-27T15:56:04.144671199Z" level=warning msg="error locating sandbox id bd144253535590670be0138411aca92c5b2b39fc9ca21131db28a980be7157d9: sandbox bd144253535590670be0138411aca92c5b2b39fc9ca21131db28a980be7157d9 not found" Oct 27 15:56:04.144848 dockerd[2073]: time="2025-10-27T15:56:04.144776599Z" level=info msg="Loading containers: done." Oct 27 15:56:04.156681 dockerd[2073]: time="2025-10-27T15:56:04.156624892Z" 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 27 15:56:04.156818 dockerd[2073]: time="2025-10-27T15:56:04.156721168Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 27 15:56:04.156818 dockerd[2073]: time="2025-10-27T15:56:04.156755541Z" level=info msg="Initializing buildkit" Oct 27 15:56:04.168357 dockerd[2073]: time="2025-10-27T15:56:04.168316207Z" level=info msg="Completed buildkit initialization" Oct 27 15:56:04.175066 dockerd[2073]: time="2025-10-27T15:56:04.175021664Z" level=info msg="Daemon has completed initialization" Oct 27 15:56:04.175130 dockerd[2073]: time="2025-10-27T15:56:04.175090290Z" level=info msg="API listen on /run/docker.sock" Oct 27 15:56:04.175274 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 27 15:56:04.181979 sshd[2130]: Connection closed by 10.0.0.1 port 57298 Oct 27 15:56:04.182474 sshd-session[2127]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:04.193295 systemd[1]: sshd@16-10.0.0.135:22-10.0.0.1:57298.service: Deactivated successfully. Oct 27 15:56:04.196066 systemd[1]: session-17.scope: Deactivated successfully. Oct 27 15:56:04.196889 systemd-logind[1472]: Session 17 logged out. Waiting for processes to exit. Oct 27 15:56:04.199026 systemd[1]: Started sshd@17-10.0.0.135:22-10.0.0.1:39000.service - OpenSSH per-connection server daemon (10.0.0.1:39000). Oct 27 15:56:04.200199 systemd-logind[1472]: Removed session 17. Oct 27 15:56:04.256004 sshd[2380]: Accepted publickey for core from 10.0.0.1 port 39000 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:04.257220 sshd-session[2380]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:04.261881 systemd-logind[1472]: New session 18 of user core. Oct 27 15:56:04.271816 systemd[1]: Started session-18.scope - Session 18 of User core. Oct 27 15:56:04.371678 containerd[2045]: time="2025-10-27T15:56:04.371476560Z" level=info msg="connecting to shim f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c" address="unix:///run/containerd/s/2d2ac508ec4f5a4b761573e701bd47e51e5261d24dc6c143fd74fec3c19886a8" namespace=moby protocol=ttrpc version=3 Oct 27 15:56:04.393828 systemd[1]: Started docker-f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c.scope - libcontainer container f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c. Oct 27 15:56:04.403826 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 27 15:56:04.421712 kernel: docker0: port 1(vethe6544a7) entered blocking state Oct 27 15:56:04.421800 kernel: docker0: port 1(vethe6544a7) entered disabled state Oct 27 15:56:04.421818 kernel: vethe6544a7: entered allmulticast mode Oct 27 15:56:04.422967 kernel: vethe6544a7: entered promiscuous mode Oct 27 15:56:04.425366 systemd-networkd[1411]: vethe6544a7: Link UP Oct 27 15:56:04.429675 kernel: eth0: renamed from veth2236858 Oct 27 15:56:04.431671 kernel: docker0: port 1(vethe6544a7) entered blocking state Oct 27 15:56:04.431705 kernel: docker0: port 1(vethe6544a7) entered forwarding state Oct 27 15:56:04.431694 systemd-networkd[1411]: vethe6544a7: Gained carrier Oct 27 15:56:04.431972 systemd-networkd[1411]: docker0: Gained carrier Oct 27 15:56:04.450589 sshd[2383]: Connection closed by 10.0.0.1 port 39000 Oct 27 15:56:04.449518 sshd-session[2380]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:04.460591 systemd[1]: sshd@17-10.0.0.135:22-10.0.0.1:39000.service: Deactivated successfully. Oct 27 15:56:04.463067 systemd[1]: session-18.scope: Deactivated successfully. Oct 27 15:56:04.463833 systemd-logind[1472]: Session 18 logged out. Waiting for processes to exit. Oct 27 15:56:04.466173 systemd[1]: Started sshd@18-10.0.0.135:22-10.0.0.1:39006.service - OpenSSH per-connection server daemon (10.0.0.1:39006). Oct 27 15:56:04.466794 systemd-logind[1472]: Removed session 18. Oct 27 15:56:04.519743 sshd[2450]: Accepted publickey for core from 10.0.0.1 port 39006 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:04.520848 sshd-session[2450]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:04.525307 systemd-logind[1472]: New session 19 of user core. Oct 27 15:56:04.536803 systemd[1]: Started session-19.scope - Session 19 of User core. Oct 27 15:56:04.580228 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2704725227-merged.mount: Deactivated successfully. Oct 27 15:56:04.590198 sshd[2453]: Connection closed by 10.0.0.1 port 39006 Oct 27 15:56:04.590588 sshd-session[2450]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:04.599428 systemd[1]: sshd@18-10.0.0.135:22-10.0.0.1:39006.service: Deactivated successfully. Oct 27 15:56:04.600840 systemd[1]: session-19.scope: Deactivated successfully. Oct 27 15:56:04.601492 systemd-logind[1472]: Session 19 logged out. Waiting for processes to exit. Oct 27 15:56:04.603302 systemd[1]: Started sshd@19-10.0.0.135:22-10.0.0.1:39020.service - OpenSSH per-connection server daemon (10.0.0.1:39020). Oct 27 15:56:04.604206 systemd-logind[1472]: Removed session 19. Oct 27 15:56:04.654790 sshd[2459]: Accepted publickey for core from 10.0.0.1 port 39020 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:04.655946 sshd-session[2459]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:04.659620 systemd-logind[1472]: New session 20 of user core. Oct 27 15:56:04.666797 systemd[1]: Started session-20.scope - Session 20 of User core. Oct 27 15:56:04.718585 sudo[2463]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2045 Oct 27 15:56:04.718951 sudo[2463]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 27 15:56:04.721783 sudo[2463]: pam_unix(sudo:session): session closed for user root Oct 27 15:56:04.723704 sshd[2462]: Connection closed by 10.0.0.1 port 39020 Oct 27 15:56:04.724145 sshd-session[2459]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:04.724806 dockerd[2073]: time="2025-10-27T15:56:04.724761792Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 27 15:56:04.724806 dockerd[2073]: time="2025-10-27T15:56:04.724800126Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 27 15:56:04.726292 dockerd[2073]: time="2025-10-27T15:56:04.726260870Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 27 15:56:04.726292 dockerd[2073]: time="2025-10-27T15:56:04.726286800Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 27 15:56:04.740413 systemd[1]: containerd.service: Deactivated successfully. Oct 27 15:56:04.740518 systemd[1]: containerd.service: Unit process 2401 (containerd-shim) remains running after unit stopped. Oct 27 15:56:04.740789 systemd[1]: containerd.service: Consumed 167ms CPU time, 106.7M memory peak. Oct 27 15:56:04.741141 systemd[1]: sshd@19-10.0.0.135:22-10.0.0.1:39020.service: Deactivated successfully. Oct 27 15:56:04.742506 systemd[1]: session-20.scope: Deactivated successfully. Oct 27 15:56:04.743125 systemd-logind[1472]: Session 20 logged out. Waiting for processes to exit. Oct 27 15:56:04.745518 systemd[1]: Started sshd@20-10.0.0.135:22-10.0.0.1:39028.service - OpenSSH per-connection server daemon (10.0.0.1:39028). Oct 27 15:56:04.746075 systemd-logind[1472]: Removed session 20. Oct 27 15:56:04.802313 sshd[2470]: Accepted publickey for core from 10.0.0.1 port 39028 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:04.803369 sshd-session[2470]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:04.807723 systemd-logind[1472]: New session 21 of user core. Oct 27 15:56:04.818813 systemd[1]: Started session-21.scope - Session 21 of User core. Oct 27 15:56:04.871371 sshd[2473]: Connection closed by 10.0.0.1 port 39028 Oct 27 15:56:04.871861 sshd-session[2470]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:04.875299 systemd[1]: sshd@20-10.0.0.135:22-10.0.0.1:39028.service: Deactivated successfully. Oct 27 15:56:04.876916 systemd[1]: session-21.scope: Deactivated successfully. Oct 27 15:56:04.877569 systemd-logind[1472]: Session 21 logged out. Waiting for processes to exit. Oct 27 15:56:04.878361 systemd-logind[1472]: Removed session 21. Oct 27 15:56:05.721869 systemd-networkd[1411]: vethe6544a7: Gained IPv6LL Oct 27 15:56:08.861815 update_engine[1481]: I20251027 15:56:08.861716 1481 update_attempter.cc:509] Updating boot flags... Oct 27 15:56:09.834788 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Oct 27 15:56:09.835279 dockerd[2073]: time="2025-10-27T15:56:09.835191765Z" level=info msg="Processing signal 'terminated'" Oct 27 15:56:09.835250 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 27 15:56:10.888647 systemd[1]: Started sshd@21-10.0.0.135:22-10.0.0.1:33140.service - OpenSSH per-connection server daemon (10.0.0.1:33140). Oct 27 15:56:10.952146 sshd[2495]: Accepted publickey for core from 10.0.0.1 port 33140 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:10.953511 sshd-session[2495]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:10.957712 systemd-logind[1472]: New session 22 of user core. Oct 27 15:56:10.968851 systemd[1]: Started session-22.scope - Session 22 of User core. Oct 27 15:56:11.021542 sshd[2498]: Connection closed by 10.0.0.1 port 33140 Oct 27 15:56:11.022078 sshd-session[2495]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:11.025235 systemd[1]: sshd@21-10.0.0.135:22-10.0.0.1:33140.service: Deactivated successfully. Oct 27 15:56:11.026725 systemd[1]: session-22.scope: Deactivated successfully. Oct 27 15:56:11.027431 systemd-logind[1472]: Session 22 logged out. Waiting for processes to exit. Oct 27 15:56:11.028420 systemd-logind[1472]: Removed session 22. Oct 27 15:56:11.837396 dockerd[2073]: time="2025-10-27T15:56:11.837259250Z" level=error msg="Error sending stop (signal 15) to container" container=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c error="Cannot kill container f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Oct 27 15:56:11.838018 dockerd[2073]: time="2025-10-27T15:56:11.837396483Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c Oct 27 15:56:17.038431 systemd[1]: Started sshd@22-10.0.0.135:22-10.0.0.1:33150.service - OpenSSH per-connection server daemon (10.0.0.1:33150). Oct 27 15:56:17.098613 sshd[2504]: Accepted publickey for core from 10.0.0.1 port 33150 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:17.099995 sshd-session[2504]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:17.104377 systemd-logind[1472]: New session 23 of user core. Oct 27 15:56:17.119828 systemd[1]: Started session-23.scope - Session 23 of User core. Oct 27 15:56:17.175098 sshd[2507]: Connection closed by 10.0.0.1 port 33150 Oct 27 15:56:17.175413 sshd-session[2504]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:17.178804 systemd[1]: sshd@22-10.0.0.135:22-10.0.0.1:33150.service: Deactivated successfully. Oct 27 15:56:17.181018 systemd[1]: session-23.scope: Deactivated successfully. Oct 27 15:56:17.181670 systemd-logind[1472]: Session 23 logged out. Waiting for processes to exit. Oct 27 15:56:17.183447 systemd-logind[1472]: Removed session 23. Oct 27 15:56:21.837866 dockerd[2073]: time="2025-10-27T15:56:21.837793774Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c error="context deadline exceeded" Oct 27 15:56:21.838590 systemd[1]: docker-f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c.scope: Deactivated successfully. Oct 27 15:56:23.186391 systemd[1]: Started sshd@23-10.0.0.135:22-10.0.0.1:38868.service - OpenSSH per-connection server daemon (10.0.0.1:38868). Oct 27 15:56:23.242729 sshd[2513]: Accepted publickey for core from 10.0.0.1 port 38868 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:23.243814 sshd-session[2513]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:23.248437 systemd-logind[1472]: New session 24 of user core. Oct 27 15:56:23.257835 systemd[1]: Started session-24.scope - Session 24 of User core. Oct 27 15:56:23.311707 sshd[2516]: Connection closed by 10.0.0.1 port 38868 Oct 27 15:56:23.312164 sshd-session[2513]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:23.316581 systemd[1]: sshd@23-10.0.0.135:22-10.0.0.1:38868.service: Deactivated successfully. Oct 27 15:56:23.318172 systemd[1]: session-24.scope: Deactivated successfully. Oct 27 15:56:23.320448 systemd-logind[1472]: Session 24 logged out. Waiting for processes to exit. Oct 27 15:56:23.322129 systemd-logind[1472]: Removed session 24. Oct 27 15:56:24.836007 dockerd[2073]: time="2025-10-27T15:56:24.835880800Z" level=error msg="Force shutdown daemon" Oct 27 15:56:24.837053 dockerd[2073]: time="2025-10-27T15:56:24.836096782Z" level=info msg="Daemon shutdown complete" Oct 27 15:56:24.840479 systemd[1]: docker.service: Deactivated successfully. Oct 27 15:56:24.841802 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 27 15:56:24.842283 systemd[1]: docker.socket: Deactivated successfully. Oct 27 15:56:24.842563 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 27 15:56:24.842601 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 27 15:56:24.843926 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 27 15:56:24.844067 systemd[1]: containerd.service: Found left-over process 2401 (containerd-shim) in control group while starting unit. Ignoring. Oct 27 15:56:24.844076 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 27 15:56:24.855070 systemd[1]: Starting containerd.service - containerd container runtime... Oct 27 15:56:24.855326 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 27 15:56:24.866018 systemd[1]: containerd.service: Found left-over process 2401 (containerd-shim) in control group while starting unit. Ignoring. Oct 27 15:56:24.866031 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 27 15:56:24.882146 containerd[2527]: time="2025-10-27T15:56:24Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 27 15:56:24.883253 containerd[2527]: time="2025-10-27T15:56:24.882763445Z" level=info msg="starting containerd" revision=cb1076646aa3740577fafbf3d914198b7fe8e3f7 version=v2.1.4 Oct 27 15:56:24.892063 containerd[2527]: time="2025-10-27T15:56:24.891991870Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.321µs" Oct 27 15:56:24.892063 containerd[2527]: time="2025-10-27T15:56:24.892034475Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 27 15:56:24.892264 containerd[2527]: time="2025-10-27T15:56:24.892242256Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 27 15:56:24.892316 containerd[2527]: time="2025-10-27T15:56:24.892266858Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 27 15:56:24.892316 containerd[2527]: time="2025-10-27T15:56:24.892299582Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 27 15:56:24.892316 containerd[2527]: time="2025-10-27T15:56:24.892311703Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892376 containerd[2527]: time="2025-10-27T15:56:24.892333945Z" 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 27 15:56:24.892376 containerd[2527]: time="2025-10-27T15:56:24.892343746Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892587 containerd[2527]: time="2025-10-27T15:56:24.892563449Z" 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 27 15:56:24.892587 containerd[2527]: time="2025-10-27T15:56:24.892584051Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892638 containerd[2527]: time="2025-10-27T15:56:24.892596252Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892638 containerd[2527]: time="2025-10-27T15:56:24.892605173Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892760 containerd[2527]: time="2025-10-27T15:56:24.892738867Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892790 containerd[2527]: time="2025-10-27T15:56:24.892758829Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892790 containerd[2527]: time="2025-10-27T15:56:24.892781271Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892872 containerd[2527]: time="2025-10-27T15:56:24.892857439Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 27 15:56:24.892896 containerd[2527]: time="2025-10-27T15:56:24.892883002Z" 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 27 15:56:24.892916 containerd[2527]: time="2025-10-27T15:56:24.892894603Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 27 15:56:24.892938 containerd[2527]: time="2025-10-27T15:56:24.892925046Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 27 15:56:24.893159 containerd[2527]: time="2025-10-27T15:56:24.893141908Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 27 15:56:24.893185 containerd[2527]: time="2025-10-27T15:56:24.893169031Z" level=info msg="metadata content store policy set" policy=shared Oct 27 15:56:24.893320 containerd[2527]: time="2025-10-27T15:56:24.893303965Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 27 15:56:24.893343 containerd[2527]: time="2025-10-27T15:56:24.893335248Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:56:24.893391 containerd[2527]: time="2025-10-27T15:56:24.893377572Z" level=info msg="skip loading plugin" error="could not find mkfs.erofs: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Oct 27 15:56:24.893413 containerd[2527]: time="2025-10-27T15:56:24.893390894Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 27 15:56:24.893439 containerd[2527]: time="2025-10-27T15:56:24.893412416Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 27 15:56:24.893439 containerd[2527]: time="2025-10-27T15:56:24.893434018Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 27 15:56:24.893488 containerd[2527]: time="2025-10-27T15:56:24.893448420Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 27 15:56:24.893488 containerd[2527]: time="2025-10-27T15:56:24.893459901Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 27 15:56:24.893488 containerd[2527]: time="2025-10-27T15:56:24.893472662Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 27 15:56:24.893488 containerd[2527]: time="2025-10-27T15:56:24.893485503Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 27 15:56:24.893557 containerd[2527]: time="2025-10-27T15:56:24.893498385Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 27 15:56:24.893557 containerd[2527]: time="2025-10-27T15:56:24.893510066Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 27 15:56:24.893557 containerd[2527]: time="2025-10-27T15:56:24.893520347Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 27 15:56:24.893557 containerd[2527]: time="2025-10-27T15:56:24.893533508Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 27 15:56:24.893862 containerd[2527]: time="2025-10-27T15:56:24.893816697Z" level=info msg="connecting to shim f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c" address="unix:///run/containerd/s/2d2ac508ec4f5a4b761573e701bd47e51e5261d24dc6c143fd74fec3c19886a8" namespace=moby protocol=ttrpc version=3 Oct 27 15:56:24.900572 containerd[2527]: time="2025-10-27T15:56:24.900543467Z" level=info msg="cleaning leaked shim process" id=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c namespace=moby Oct 27 15:56:24.909634 containerd[2527]: time="2025-10-27T15:56:24.909344929Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Oct 27 15:56:24.910418 containerd[2527]: time="2025-10-27T15:56:24.910387475Z" level=info msg="shim disconnected" id=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c namespace=moby Oct 27 15:56:24.910536 containerd[2527]: time="2025-10-27T15:56:24.910490126Z" level=info msg="cleaning up after shim disconnected" id=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c namespace=moby Oct 27 15:56:24.910601 containerd[2527]: time="2025-10-27T15:56:24.910588736Z" level=info msg="cleaning up dead shim" id=f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c namespace=moby Oct 27 15:56:24.920477 containerd[2527]: time="2025-10-27T15:56:24.920421024Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 27 15:56:24.920594 containerd[2527]: time="2025-10-27T15:56:24.920577600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 27 15:56:24.920699 containerd[2527]: time="2025-10-27T15:56:24.920682851Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 27 15:56:24.920762 containerd[2527]: time="2025-10-27T15:56:24.920748417Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 27 15:56:24.920830 containerd[2527]: time="2025-10-27T15:56:24.920812984Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 27 15:56:24.920908 containerd[2527]: time="2025-10-27T15:56:24.920893272Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 27 15:56:24.920970 containerd[2527]: time="2025-10-27T15:56:24.920956079Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 27 15:56:24.921030 containerd[2527]: time="2025-10-27T15:56:24.921010364Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 27 15:56:24.921133 containerd[2527]: time="2025-10-27T15:56:24.921115335Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 27 15:56:24.921189 containerd[2527]: time="2025-10-27T15:56:24.921176821Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 27 15:56:24.921241 containerd[2527]: time="2025-10-27T15:56:24.921229307Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 27 15:56:24.921314 containerd[2527]: time="2025-10-27T15:56:24.921300154Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 27 15:56:24.921420 containerd[2527]: time="2025-10-27T15:56:24.921402324Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 27 15:56:24.921489 containerd[2527]: time="2025-10-27T15:56:24.921477772Z" level=info msg="Start snapshots syncer" Oct 27 15:56:24.921620 containerd[2527]: time="2025-10-27T15:56:24.921602825Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 27 15:56:24.921939 containerd[2527]: time="2025-10-27T15:56:24.921893695Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 27 15:56:24.922084 containerd[2527]: time="2025-10-27T15:56:24.922065472Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 27 15:56:24.922210 containerd[2527]: time="2025-10-27T15:56:24.922193365Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 27 15:56:24.922296 containerd[2527]: time="2025-10-27T15:56:24.922281894Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 27 15:56:24.922358 containerd[2527]: time="2025-10-27T15:56:24.922345101Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 27 15:56:24.922418 containerd[2527]: time="2025-10-27T15:56:24.922405427Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 27 15:56:24.922505 containerd[2527]: time="2025-10-27T15:56:24.922490756Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 27 15:56:24.922560 containerd[2527]: time="2025-10-27T15:56:24.922547682Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 27 15:56:24.922619 containerd[2527]: time="2025-10-27T15:56:24.922607168Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 27 15:56:24.922695 containerd[2527]: time="2025-10-27T15:56:24.922680575Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 27 15:56:24.922755 containerd[2527]: time="2025-10-27T15:56:24.922741902Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 27 15:56:24.922823 containerd[2527]: time="2025-10-27T15:56:24.922810149Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 27 15:56:24.922921 containerd[2527]: time="2025-10-27T15:56:24.922906278Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 27 15:56:24.922979 containerd[2527]: time="2025-10-27T15:56:24.922965484Z" 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 27 15:56:24.923024 containerd[2527]: time="2025-10-27T15:56:24.923012209Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 27 15:56:24.923078 containerd[2527]: time="2025-10-27T15:56:24.923063895Z" 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 27 15:56:24.923125 containerd[2527]: time="2025-10-27T15:56:24.923112380Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 27 15:56:24.923185 containerd[2527]: time="2025-10-27T15:56:24.923171066Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 27 15:56:24.923239 containerd[2527]: time="2025-10-27T15:56:24.923226591Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 27 15:56:24.923292 containerd[2527]: time="2025-10-27T15:56:24.923281597Z" level=info msg="runtime interface created" Oct 27 15:56:24.923333 containerd[2527]: time="2025-10-27T15:56:24.923323761Z" level=info msg="created NRI interface" Oct 27 15:56:24.923397 containerd[2527]: time="2025-10-27T15:56:24.923383047Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 27 15:56:24.923459 containerd[2527]: time="2025-10-27T15:56:24.923447214Z" level=info msg="Connect containerd service" Oct 27 15:56:24.923580 containerd[2527]: time="2025-10-27T15:56:24.923564546Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 27 15:56:24.924127 containerd[2527]: time="2025-10-27T15:56:24.924098921Z" 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 27 15:56:24.932506 containerd[2527]: time="2025-10-27T15:56:24.932467378Z" level=info msg="Start subscribing containerd event" Oct 27 15:56:24.932600 containerd[2527]: time="2025-10-27T15:56:24.932588151Z" level=info msg="Start recovering state" Oct 27 15:56:24.932749 containerd[2527]: time="2025-10-27T15:56:24.932733966Z" level=info msg="Start event monitor" Oct 27 15:56:24.932816 containerd[2527]: time="2025-10-27T15:56:24.932803253Z" level=info msg="Start cni network conf syncer for default" Oct 27 15:56:24.932863 containerd[2527]: time="2025-10-27T15:56:24.932851218Z" level=info msg="Start streaming server" Oct 27 15:56:24.932947 containerd[2527]: time="2025-10-27T15:56:24.932599712Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 27 15:56:24.932999 containerd[2527]: time="2025-10-27T15:56:24.932982711Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 27 15:56:24.933024 containerd[2527]: time="2025-10-27T15:56:24.932916984Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 27 15:56:24.933024 containerd[2527]: time="2025-10-27T15:56:24.933008954Z" level=info msg="runtime interface starting up..." Oct 27 15:56:24.933024 containerd[2527]: time="2025-10-27T15:56:24.933014954Z" level=info msg="starting plugins..." Oct 27 15:56:24.933075 containerd[2527]: time="2025-10-27T15:56:24.933027836Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 27 15:56:24.933128 containerd[2527]: time="2025-10-27T15:56:24.933113925Z" level=info msg="containerd successfully booted in 0.051128s" Oct 27 15:56:24.933243 systemd[1]: Started containerd.service - containerd container runtime. Oct 27 15:56:24.936887 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 27 15:56:24.947077 (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 27 15:56:24.973626 dockerd[2575]: time="2025-10-27T15:56:24.973566910Z" level=info msg="Starting up" Oct 27 15:56:24.974115 dockerd[2575]: time="2025-10-27T15:56:24.974096004Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 27 15:56:24.983117 dockerd[2575]: time="2025-10-27T15:56:24.983076125Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 27 15:56:24.992719 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport2196177502-merged.mount: Deactivated successfully. Oct 27 15:56:25.006271 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck2691602619-merged.mount: Deactivated successfully. Oct 27 15:56:25.007669 dockerd[2575]: time="2025-10-27T15:56:25.007638317Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 27 15:56:25.017081 dockerd[2575]: time="2025-10-27T15:56:25.017038260Z" level=info msg="Loading containers: start." Oct 27 15:56:25.033990 systemd[1]: var-lib-docker-overlay2-45c683481b50f1b14c0e4b544bd5f26f9694bf7ce8d77e288fffeccf24804efe-merged.mount: Deactivated successfully. Oct 27 15:56:25.548718 systemd-networkd[1411]: vethe6544a7: Link DOWN Oct 27 15:56:25.548801 systemd-networkd[1411]: vethe6544a7: Lost carrier Oct 27 15:56:25.549678 kernel: docker0: port 1(vethe6544a7) entered disabled state Oct 27 15:56:25.551137 kernel: vethe6544a7 (unregistering): left allmulticast mode Oct 27 15:56:25.551176 kernel: vethe6544a7 (unregistering): left promiscuous mode Oct 27 15:56:25.551206 kernel: docker0: port 1(vethe6544a7) entered disabled state Oct 27 15:56:25.552407 systemd-networkd[1411]: docker0: Lost carrier Oct 27 15:56:25.553117 dockerd[2575]: time="2025-10-27T15:56:25.553064360Z" level=info msg="Removing stale sandbox 747c8888421ff76fe915eea04d2bb7b9c6d2ee08ae85c758b29cedd51be1d702 (f1536aa6ac87239ad9efee113e0280383fbbfc05392f1d9207dc1e8d55e3389c)" Oct 27 15:56:25.556049 dockerd[2575]: time="2025-10-27T15:56:25.555713455Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 27 15:56:25.556049 dockerd[2575]: time="2025-10-27T15:56:25.555753298Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 228a51622f1d363963e6118a5c74768d445a566ec570daa6aba0ec6e16c261d3 ab32b768ffaeb492420c352291818aa5ba145c0583192091ad0f88e4df84c223], retrying...." Oct 27 15:56:25.765257 dockerd[2575]: time="2025-10-27T15:56:25.765202182Z" level=warning msg="error locating sandbox id bd144253535590670be0138411aca92c5b2b39fc9ca21131db28a980be7157d9: sandbox bd144253535590670be0138411aca92c5b2b39fc9ca21131db28a980be7157d9 not found" Oct 27 15:56:25.765257 dockerd[2575]: time="2025-10-27T15:56:25.765250346Z" level=warning msg="error locating sandbox id 747c8888421ff76fe915eea04d2bb7b9c6d2ee08ae85c758b29cedd51be1d702: sandbox 747c8888421ff76fe915eea04d2bb7b9c6d2ee08ae85c758b29cedd51be1d702 not found" Oct 27 15:56:25.765403 dockerd[2575]: time="2025-10-27T15:56:25.765308592Z" level=info msg="Loading containers: done." Oct 27 15:56:25.774946 dockerd[2575]: time="2025-10-27T15:56:25.774901554Z" 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 27 15:56:25.775085 dockerd[2575]: time="2025-10-27T15:56:25.774976601Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 27 15:56:25.775085 dockerd[2575]: time="2025-10-27T15:56:25.775010524Z" level=info msg="Initializing buildkit" Oct 27 15:56:25.786422 dockerd[2575]: time="2025-10-27T15:56:25.786391818Z" level=info msg="Completed buildkit initialization" Oct 27 15:56:25.792684 dockerd[2575]: time="2025-10-27T15:56:25.792631977Z" level=info msg="Daemon has completed initialization" Oct 27 15:56:25.792771 dockerd[2575]: time="2025-10-27T15:56:25.792707384Z" level=info msg="API listen on /run/docker.sock" Oct 27 15:56:25.792910 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 27 15:56:25.990403 systemd[1]: run-docker-netns-747c8888421f.mount: Deactivated successfully. Oct 27 15:56:29.324143 systemd[1]: Started sshd@24-10.0.0.135:22-10.0.0.1:58728.service - OpenSSH per-connection server daemon (10.0.0.1:58728). Oct 27 15:56:29.381261 sshd[2814]: Accepted publickey for core from 10.0.0.1 port 58728 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:29.382505 sshd-session[2814]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:29.386708 systemd-logind[1472]: New session 25 of user core. Oct 27 15:56:29.397847 systemd[1]: Started session-25.scope - Session 25 of User core. Oct 27 15:56:29.451114 sshd[2817]: Connection closed by 10.0.0.1 port 58728 Oct 27 15:56:29.451551 sshd-session[2814]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:29.467021 systemd[1]: sshd@24-10.0.0.135:22-10.0.0.1:58728.service: Deactivated successfully. Oct 27 15:56:29.468857 systemd[1]: session-25.scope: Deactivated successfully. Oct 27 15:56:29.470397 systemd-logind[1472]: Session 25 logged out. Waiting for processes to exit. Oct 27 15:56:29.472398 systemd[1]: Started sshd@25-10.0.0.135:22-10.0.0.1:58734.service - OpenSSH per-connection server daemon (10.0.0.1:58734). Oct 27 15:56:29.473018 systemd-logind[1472]: Removed session 25. Oct 27 15:56:29.527521 sshd[2823]: Accepted publickey for core from 10.0.0.1 port 58734 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:29.531360 sshd-session[2823]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:29.536065 systemd-logind[1472]: New session 26 of user core. Oct 27 15:56:29.541816 systemd[1]: Started session-26.scope - Session 26 of User core. Oct 27 15:56:29.617158 sshd[2826]: Connection closed by 10.0.0.1 port 58734 Oct 27 15:56:29.618966 sshd-session[2823]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:29.632183 systemd[1]: sshd@25-10.0.0.135:22-10.0.0.1:58734.service: Deactivated successfully. Oct 27 15:56:29.634175 systemd[1]: session-26.scope: Deactivated successfully. Oct 27 15:56:29.635029 systemd-logind[1472]: Session 26 logged out. Waiting for processes to exit. Oct 27 15:56:29.637547 systemd[1]: Started sshd@26-10.0.0.135:22-10.0.0.1:58748.service - OpenSSH per-connection server daemon (10.0.0.1:58748). Oct 27 15:56:29.638423 systemd-logind[1472]: Removed session 26. Oct 27 15:56:29.694355 sshd[2832]: Accepted publickey for core from 10.0.0.1 port 58748 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:29.695506 sshd-session[2832]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:29.700065 systemd-logind[1472]: New session 27 of user core. Oct 27 15:56:29.705842 systemd[1]: Started session-27.scope - Session 27 of User core. Oct 27 15:56:29.766935 sshd[2835]: Connection closed by 10.0.0.1 port 58748 Oct 27 15:56:29.768859 sshd-session[2832]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:29.779606 systemd[1]: sshd@26-10.0.0.135:22-10.0.0.1:58748.service: Deactivated successfully. Oct 27 15:56:29.781172 systemd[1]: session-27.scope: Deactivated successfully. Oct 27 15:56:29.783843 systemd-logind[1472]: Session 27 logged out. Waiting for processes to exit. Oct 27 15:56:29.785954 systemd[1]: Started sshd@27-10.0.0.135:22-10.0.0.1:58760.service - OpenSSH per-connection server daemon (10.0.0.1:58760). Oct 27 15:56:29.787554 systemd-logind[1472]: Removed session 27. Oct 27 15:56:29.841012 sshd[2848]: Accepted publickey for core from 10.0.0.1 port 58760 ssh2: RSA SHA256:K6CtHCWUtobSfSGgZrbJLjUNKt0fiALRPHz2mArh8Rw Oct 27 15:56:29.842204 sshd-session[2848]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 27 15:56:29.846167 systemd-logind[1472]: New session 28 of user core. Oct 27 15:56:29.865855 systemd[1]: Started session-28.scope - Session 28 of User core. Oct 27 15:56:29.933149 systemd[1]: var-lib-docker-overlay2-557344ad6d9263d5f3a1b84d435520b2517b595cea64e57ac2de65959b235966\x2dinit-merged.mount: Deactivated successfully. Oct 27 15:56:29.973302 containerd[2527]: time="2025-10-27T15:56:29.973248565Z" level=info msg="connecting to shim c9f6a6aa2fa070acbf08bb0cd08b0bd91d5732e42a83ce56716cad994a7c8ecc" address="unix:///run/containerd/s/2ea9de711bfd370062af0b8d7a5c9409603bb1cc170623332822b6aab8ed9b07" namespace=moby protocol=ttrpc version=3 Oct 27 15:56:29.997865 systemd[1]: Started docker-c9f6a6aa2fa070acbf08bb0cd08b0bd91d5732e42a83ce56716cad994a7c8ecc.scope - libcontainer container c9f6a6aa2fa070acbf08bb0cd08b0bd91d5732e42a83ce56716cad994a7c8ecc. Oct 27 15:56:30.008064 systemd-resolved[1268]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 27 15:56:30.027137 kernel: docker0: port 1(vethe0fdef2) entered blocking state Oct 27 15:56:30.027240 kernel: docker0: port 1(vethe0fdef2) entered disabled state Oct 27 15:56:30.027263 kernel: vethe0fdef2: entered allmulticast mode Oct 27 15:56:30.027282 kernel: vethe0fdef2: entered promiscuous mode Oct 27 15:56:30.027990 systemd-networkd[1411]: vethe0fdef2: Link UP Oct 27 15:56:30.034392 kernel: eth0: renamed from veth4914d88 Oct 27 15:56:30.036296 kernel: docker0: port 1(vethe0fdef2) entered blocking state Oct 27 15:56:30.036354 kernel: docker0: port 1(vethe0fdef2) entered forwarding state Oct 27 15:56:30.036453 systemd-networkd[1411]: vethe0fdef2: Gained carrier Oct 27 15:56:30.036914 systemd-networkd[1411]: docker0: Gained carrier Oct 27 15:56:30.055942 sshd[2851]: Connection closed by 10.0.0.1 port 58760 Oct 27 15:56:30.056482 sshd-session[2848]: pam_unix(sshd:session): session closed for user core Oct 27 15:56:30.060564 systemd-logind[1472]: Session 28 logged out. Waiting for processes to exit. Oct 27 15:56:30.060895 systemd[1]: sshd@27-10.0.0.135:22-10.0.0.1:58760.service: Deactivated successfully. Oct 27 15:56:30.062516 systemd[1]: session-28.scope: Deactivated successfully. Oct 27 15:56:30.064127 systemd-logind[1472]: Removed session 28.