Oct 29 23:39:15.357548 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Oct 29 23:39:15.357572 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 Wed Oct 29 22:08:13 -00 2025 Oct 29 23:39:15.357581 kernel: KASLR enabled Oct 29 23:39:15.357587 kernel: efi: EFI v2.7 by EDK II Oct 29 23:39:15.357593 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Oct 29 23:39:15.357598 kernel: random: crng init done Oct 29 23:39:15.357605 kernel: secureboot: Secure boot disabled Oct 29 23:39:15.357611 kernel: ACPI: Early table checksum verification disabled Oct 29 23:39:15.357619 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Oct 29 23:39:15.357625 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Oct 29 23:39:15.357631 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357637 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357643 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357650 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357658 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357665 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357672 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357678 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357684 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 29 23:39:15.357690 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Oct 29 23:39:15.357697 kernel: ACPI: Use ACPI SPCR as default console: No Oct 29 23:39:15.357703 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 23:39:15.357711 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Oct 29 23:39:15.357717 kernel: Zone ranges: Oct 29 23:39:15.357724 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 23:39:15.357730 kernel: DMA32 empty Oct 29 23:39:15.357736 kernel: Normal empty Oct 29 23:39:15.357743 kernel: Device empty Oct 29 23:39:15.357749 kernel: Movable zone start for each node Oct 29 23:39:15.357755 kernel: Early memory node ranges Oct 29 23:39:15.357762 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Oct 29 23:39:15.357768 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Oct 29 23:39:15.357774 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Oct 29 23:39:15.357781 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Oct 29 23:39:15.357788 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Oct 29 23:39:15.357794 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Oct 29 23:39:15.357801 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Oct 29 23:39:15.357807 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Oct 29 23:39:15.357813 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Oct 29 23:39:15.357820 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Oct 29 23:39:15.357830 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Oct 29 23:39:15.357837 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Oct 29 23:39:15.357844 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Oct 29 23:39:15.357851 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Oct 29 23:39:15.357857 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Oct 29 23:39:15.357864 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Oct 29 23:39:15.357871 kernel: psci: probing for conduit method from ACPI. Oct 29 23:39:15.357878 kernel: psci: PSCIv1.1 detected in firmware. Oct 29 23:39:15.357886 kernel: psci: Using standard PSCI v0.2 function IDs Oct 29 23:39:15.357893 kernel: psci: Trusted OS migration not required Oct 29 23:39:15.357900 kernel: psci: SMC Calling Convention v1.1 Oct 29 23:39:15.357907 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Oct 29 23:39:15.357925 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Oct 29 23:39:15.357932 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Oct 29 23:39:15.357939 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Oct 29 23:39:15.357946 kernel: Detected PIPT I-cache on CPU0 Oct 29 23:39:15.357953 kernel: CPU features: detected: GIC system register CPU interface Oct 29 23:39:15.357960 kernel: CPU features: detected: Spectre-v4 Oct 29 23:39:15.357966 kernel: CPU features: detected: Spectre-BHB Oct 29 23:39:15.357975 kernel: CPU features: kernel page table isolation forced ON by KASLR Oct 29 23:39:15.357982 kernel: CPU features: detected: Kernel page table isolation (KPTI) Oct 29 23:39:15.357989 kernel: CPU features: detected: ARM erratum 1418040 Oct 29 23:39:15.357996 kernel: CPU features: detected: SSBS not fully self-synchronizing Oct 29 23:39:15.358002 kernel: alternatives: applying boot alternatives Oct 29 23:39:15.358010 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=c3f6e690ee2ade37dd6082d1ad3b53d2d12b3a76b4644e8ca271364e3a8c31ac Oct 29 23:39:15.358017 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 29 23:39:15.358025 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 29 23:39:15.358031 kernel: Fallback order for Node 0: 0 Oct 29 23:39:15.358038 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Oct 29 23:39:15.358046 kernel: Policy zone: DMA Oct 29 23:39:15.358053 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 29 23:39:15.358060 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Oct 29 23:39:15.358067 kernel: software IO TLB: area num 4. Oct 29 23:39:15.358073 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Oct 29 23:39:15.358081 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Oct 29 23:39:15.358095 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 29 23:39:15.358102 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 29 23:39:15.358110 kernel: rcu: RCU event tracing is enabled. Oct 29 23:39:15.358117 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 29 23:39:15.358124 kernel: Trampoline variant of Tasks RCU enabled. Oct 29 23:39:15.358133 kernel: Tracing variant of Tasks RCU enabled. Oct 29 23:39:15.358140 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 29 23:39:15.358147 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 29 23:39:15.358154 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 29 23:39:15.358161 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Oct 29 23:39:15.358168 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Oct 29 23:39:15.358174 kernel: GICv3: 256 SPIs implemented Oct 29 23:39:15.358181 kernel: GICv3: 0 Extended SPIs implemented Oct 29 23:39:15.358188 kernel: Root IRQ handler: gic_handle_irq Oct 29 23:39:15.358195 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Oct 29 23:39:15.358202 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Oct 29 23:39:15.358210 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Oct 29 23:39:15.358217 kernel: ITS [mem 0x08080000-0x0809ffff] Oct 29 23:39:15.358225 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Oct 29 23:39:15.358232 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Oct 29 23:39:15.358239 kernel: GICv3: using LPI property table @0x0000000040130000 Oct 29 23:39:15.358248 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Oct 29 23:39:15.358255 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 29 23:39:15.358262 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 23:39:15.358269 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Oct 29 23:39:15.358276 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Oct 29 23:39:15.358283 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Oct 29 23:39:15.358291 kernel: arm-pv: using stolen time PV Oct 29 23:39:15.358298 kernel: Console: colour dummy device 80x25 Oct 29 23:39:15.358306 kernel: ACPI: Core revision 20240827 Oct 29 23:39:15.358313 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Oct 29 23:39:15.358321 kernel: pid_max: default: 32768 minimum: 301 Oct 29 23:39:15.358328 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Oct 29 23:39:15.358335 kernel: landlock: Up and running. Oct 29 23:39:15.358343 kernel: SELinux: Initializing. Oct 29 23:39:15.358351 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 23:39:15.358377 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 29 23:39:15.358386 kernel: rcu: Hierarchical SRCU implementation. Oct 29 23:39:15.358393 kernel: rcu: Max phase no-delay instances is 400. Oct 29 23:39:15.358400 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Oct 29 23:39:15.358408 kernel: Remapping and enabling EFI services. Oct 29 23:39:15.358415 kernel: smp: Bringing up secondary CPUs ... Oct 29 23:39:15.358424 kernel: Detected PIPT I-cache on CPU1 Oct 29 23:39:15.358436 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Oct 29 23:39:15.358445 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Oct 29 23:39:15.358453 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 23:39:15.358460 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Oct 29 23:39:15.358468 kernel: Detected PIPT I-cache on CPU2 Oct 29 23:39:15.358476 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Oct 29 23:39:15.358485 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Oct 29 23:39:15.358492 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 23:39:15.358500 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Oct 29 23:39:15.358507 kernel: Detected PIPT I-cache on CPU3 Oct 29 23:39:15.358515 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Oct 29 23:39:15.358522 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Oct 29 23:39:15.358530 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Oct 29 23:39:15.358538 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Oct 29 23:39:15.358546 kernel: smp: Brought up 1 node, 4 CPUs Oct 29 23:39:15.358554 kernel: SMP: Total of 4 processors activated. Oct 29 23:39:15.358561 kernel: CPU: All CPU(s) started at EL1 Oct 29 23:39:15.358569 kernel: CPU features: detected: 32-bit EL0 Support Oct 29 23:39:15.358576 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Oct 29 23:39:15.358584 kernel: CPU features: detected: Common not Private translations Oct 29 23:39:15.358593 kernel: CPU features: detected: CRC32 instructions Oct 29 23:39:15.358600 kernel: CPU features: detected: Enhanced Virtualization Traps Oct 29 23:39:15.358608 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Oct 29 23:39:15.358615 kernel: CPU features: detected: LSE atomic instructions Oct 29 23:39:15.358623 kernel: CPU features: detected: Privileged Access Never Oct 29 23:39:15.358630 kernel: CPU features: detected: RAS Extension Support Oct 29 23:39:15.358638 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Oct 29 23:39:15.358645 kernel: alternatives: applying system-wide alternatives Oct 29 23:39:15.358654 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Oct 29 23:39:15.358662 kernel: Memory: 2450400K/2572288K available (11136K kernel code, 2456K rwdata, 9084K rodata, 12992K init, 1038K bss, 99552K reserved, 16384K cma-reserved) Oct 29 23:39:15.358670 kernel: devtmpfs: initialized Oct 29 23:39:15.358677 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 29 23:39:15.358685 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 29 23:39:15.358692 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Oct 29 23:39:15.358700 kernel: 0 pages in range for non-PLT usage Oct 29 23:39:15.358708 kernel: 515056 pages in range for PLT usage Oct 29 23:39:15.358716 kernel: pinctrl core: initialized pinctrl subsystem Oct 29 23:39:15.358723 kernel: SMBIOS 3.0.0 present. Oct 29 23:39:15.358731 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Oct 29 23:39:15.358738 kernel: DMI: Memory slots populated: 1/1 Oct 29 23:39:15.358746 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 29 23:39:15.358753 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Oct 29 23:39:15.358762 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Oct 29 23:39:15.358770 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Oct 29 23:39:15.358778 kernel: audit: initializing netlink subsys (disabled) Oct 29 23:39:15.358786 kernel: audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 Oct 29 23:39:15.358793 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 29 23:39:15.358801 kernel: cpuidle: using governor menu Oct 29 23:39:15.358808 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Oct 29 23:39:15.358817 kernel: ASID allocator initialised with 32768 entries Oct 29 23:39:15.358825 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 29 23:39:15.358832 kernel: Serial: AMBA PL011 UART driver Oct 29 23:39:15.358840 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 29 23:39:15.358847 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Oct 29 23:39:15.358855 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Oct 29 23:39:15.358862 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Oct 29 23:39:15.358869 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 29 23:39:15.358878 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Oct 29 23:39:15.358886 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Oct 29 23:39:15.358893 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Oct 29 23:39:15.358901 kernel: ACPI: Added _OSI(Module Device) Oct 29 23:39:15.358908 kernel: ACPI: Added _OSI(Processor Device) Oct 29 23:39:15.358922 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 29 23:39:15.358930 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 29 23:39:15.358939 kernel: ACPI: Interpreter enabled Oct 29 23:39:15.358946 kernel: ACPI: Using GIC for interrupt routing Oct 29 23:39:15.358954 kernel: ACPI: MCFG table detected, 1 entries Oct 29 23:39:15.358961 kernel: ACPI: CPU0 has been hot-added Oct 29 23:39:15.358969 kernel: ACPI: CPU1 has been hot-added Oct 29 23:39:15.358976 kernel: ACPI: CPU2 has been hot-added Oct 29 23:39:15.358984 kernel: ACPI: CPU3 has been hot-added Oct 29 23:39:15.358993 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Oct 29 23:39:15.359000 kernel: printk: legacy console [ttyAMA0] enabled Oct 29 23:39:15.359008 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 29 23:39:15.359191 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 29 23:39:15.359280 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Oct 29 23:39:15.359397 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Oct 29 23:39:15.359484 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Oct 29 23:39:15.359570 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Oct 29 23:39:15.359580 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Oct 29 23:39:15.359588 kernel: PCI host bridge to bus 0000:00 Oct 29 23:39:15.359678 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Oct 29 23:39:15.359771 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Oct 29 23:39:15.359847 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Oct 29 23:39:15.359935 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 29 23:39:15.360039 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Oct 29 23:39:15.360144 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Oct 29 23:39:15.360235 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Oct 29 23:39:15.360316 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Oct 29 23:39:15.360401 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Oct 29 23:39:15.360482 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Oct 29 23:39:15.360562 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Oct 29 23:39:15.360641 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Oct 29 23:39:15.360716 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Oct 29 23:39:15.360789 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Oct 29 23:39:15.360865 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Oct 29 23:39:15.360875 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Oct 29 23:39:15.360883 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Oct 29 23:39:15.360891 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Oct 29 23:39:15.360898 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Oct 29 23:39:15.360906 kernel: iommu: Default domain type: Translated Oct 29 23:39:15.360925 kernel: iommu: DMA domain TLB invalidation policy: strict mode Oct 29 23:39:15.360933 kernel: efivars: Registered efivars operations Oct 29 23:39:15.360940 kernel: vgaarb: loaded Oct 29 23:39:15.360948 kernel: clocksource: Switched to clocksource arch_sys_counter Oct 29 23:39:15.360956 kernel: VFS: Disk quotas dquot_6.6.0 Oct 29 23:39:15.360963 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 29 23:39:15.360971 kernel: pnp: PnP ACPI init Oct 29 23:39:15.361106 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Oct 29 23:39:15.361120 kernel: pnp: PnP ACPI: found 1 devices Oct 29 23:39:15.361128 kernel: NET: Registered PF_INET protocol family Oct 29 23:39:15.361136 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 29 23:39:15.361144 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 29 23:39:15.361154 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 29 23:39:15.361162 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 29 23:39:15.361173 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 29 23:39:15.361181 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 29 23:39:15.361189 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 23:39:15.361197 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 29 23:39:15.361206 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 29 23:39:15.361215 kernel: PCI: CLS 0 bytes, default 64 Oct 29 23:39:15.361223 kernel: kvm [1]: HYP mode not available Oct 29 23:39:15.361233 kernel: Initialise system trusted keyrings Oct 29 23:39:15.361262 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 29 23:39:15.361270 kernel: Key type asymmetric registered Oct 29 23:39:15.361278 kernel: Asymmetric key parser 'x509' registered Oct 29 23:39:15.361287 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Oct 29 23:39:15.361294 kernel: io scheduler mq-deadline registered Oct 29 23:39:15.361303 kernel: io scheduler kyber registered Oct 29 23:39:15.361313 kernel: io scheduler bfq registered Oct 29 23:39:15.361320 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Oct 29 23:39:15.361328 kernel: ACPI: button: Power Button [PWRB] Oct 29 23:39:15.361337 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Oct 29 23:39:15.361424 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Oct 29 23:39:15.361434 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 29 23:39:15.361442 kernel: thunder_xcv, ver 1.0 Oct 29 23:39:15.361452 kernel: thunder_bgx, ver 1.0 Oct 29 23:39:15.361459 kernel: nicpf, ver 1.0 Oct 29 23:39:15.361467 kernel: nicvf, ver 1.0 Oct 29 23:39:15.361560 kernel: rtc-efi rtc-efi.0: registered as rtc0 Oct 29 23:39:15.361637 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-10-29T23:39:14 UTC (1761781154) Oct 29 23:39:15.361647 kernel: hid: raw HID events driver (C) Jiri Kosina Oct 29 23:39:15.361657 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Oct 29 23:39:15.361665 kernel: watchdog: NMI not fully supported Oct 29 23:39:15.361672 kernel: watchdog: Hard watchdog permanently disabled Oct 29 23:39:15.361680 kernel: NET: Registered PF_INET6 protocol family Oct 29 23:39:15.361687 kernel: Segment Routing with IPv6 Oct 29 23:39:15.361695 kernel: In-situ OAM (IOAM) with IPv6 Oct 29 23:39:15.361703 kernel: NET: Registered PF_PACKET protocol family Oct 29 23:39:15.361710 kernel: Key type dns_resolver registered Oct 29 23:39:15.361719 kernel: registered taskstats version 1 Oct 29 23:39:15.361727 kernel: Loading compiled-in X.509 certificates Oct 29 23:39:15.361735 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.54-flatcar: c6256e7d9c20dfbb4deda09bbb20ce7eab6ed949' Oct 29 23:39:15.361743 kernel: Demotion targets for Node 0: null Oct 29 23:39:15.361751 kernel: Key type .fscrypt registered Oct 29 23:39:15.361759 kernel: Key type fscrypt-provisioning registered Oct 29 23:39:15.361766 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 29 23:39:15.361775 kernel: ima: Allocated hash algorithm: sha1 Oct 29 23:39:15.361783 kernel: ima: No architecture policies found Oct 29 23:39:15.361791 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Oct 29 23:39:15.361817 kernel: clk: Disabling unused clocks Oct 29 23:39:15.361824 kernel: PM: genpd: Disabling unused power domains Oct 29 23:39:15.361832 kernel: Freeing unused kernel memory: 12992K Oct 29 23:39:15.361839 kernel: Run /init as init process Oct 29 23:39:15.361849 kernel: with arguments: Oct 29 23:39:15.361859 kernel: /init Oct 29 23:39:15.361869 kernel: with environment: Oct 29 23:39:15.361877 kernel: HOME=/ Oct 29 23:39:15.361884 kernel: TERM=linux Oct 29 23:39:15.362007 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Oct 29 23:39:15.362096 kernel: virtio_blk virtio1: [vda] 16515072 512-byte logical blocks (8.46 GB/7.88 GiB) Oct 29 23:39:15.362110 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 29 23:39:15.362118 kernel: SCSI subsystem initialized Oct 29 23:39:15.362126 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 29 23:39:15.362134 kernel: device-mapper: uevent: version 1.0.3 Oct 29 23:39:15.362142 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Oct 29 23:39:15.362149 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Oct 29 23:39:15.362158 kernel: raid6: neonx8 gen() 15777 MB/s Oct 29 23:39:15.362166 kernel: raid6: neonx4 gen() 15820 MB/s Oct 29 23:39:15.362174 kernel: raid6: neonx2 gen() 13229 MB/s Oct 29 23:39:15.362181 kernel: raid6: neonx1 gen() 10419 MB/s Oct 29 23:39:15.362189 kernel: raid6: int64x8 gen() 6903 MB/s Oct 29 23:39:15.362196 kernel: raid6: int64x4 gen() 7349 MB/s Oct 29 23:39:15.362204 kernel: raid6: int64x2 gen() 6111 MB/s Oct 29 23:39:15.362213 kernel: raid6: int64x1 gen() 5044 MB/s Oct 29 23:39:15.362221 kernel: raid6: using algorithm neonx4 gen() 15820 MB/s Oct 29 23:39:15.362229 kernel: raid6: .... xor() 12342 MB/s, rmw enabled Oct 29 23:39:15.362236 kernel: raid6: using neon recovery algorithm Oct 29 23:39:15.362244 kernel: xor: measuring software checksum speed Oct 29 23:39:15.362251 kernel: 8regs : 18925 MB/sec Oct 29 23:39:15.362259 kernel: 32regs : 21636 MB/sec Oct 29 23:39:15.362267 kernel: arm64_neon : 27965 MB/sec Oct 29 23:39:15.362276 kernel: xor: using function: arm64_neon (27965 MB/sec) Oct 29 23:39:15.362283 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 29 23:39:15.362291 kernel: BTRFS: device fsid f84bda9c-c65c-4b2e-9db1-1debc07ad11f devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (206) Oct 29 23:39:15.362299 kernel: BTRFS info (device dm-0): first mount of filesystem f84bda9c-c65c-4b2e-9db1-1debc07ad11f Oct 29 23:39:15.362306 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Oct 29 23:39:15.362314 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 29 23:39:15.362322 kernel: BTRFS info (device dm-0): enabling free space tree Oct 29 23:39:15.362331 kernel: loop: module loaded Oct 29 23:39:15.362338 kernel: loop0: detected capacity change from 0 to 91464 Oct 29 23:39:15.362346 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 29 23:39:15.362354 systemd[1]: Successfully made /usr/ read-only. Oct 29 23:39:15.362365 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 29 23:39:15.362375 systemd[1]: Detected virtualization kvm. Oct 29 23:39:15.362383 systemd[1]: Detected architecture arm64. Oct 29 23:39:15.362391 systemd[1]: Running in initrd. Oct 29 23:39:15.362399 systemd[1]: No hostname configured, using default hostname. Oct 29 23:39:15.362408 systemd[1]: Hostname set to . Oct 29 23:39:15.362416 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 29 23:39:15.362424 systemd[1]: Queued start job for default target initrd.target. Oct 29 23:39:15.362433 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 29 23:39:15.362441 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 23:39:15.362450 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 23:39:15.362458 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 29 23:39:15.362467 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 23:39:15.362475 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 29 23:39:15.362485 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 29 23:39:15.362494 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 23:39:15.362502 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 23:39:15.362510 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Oct 29 23:39:15.362518 systemd[1]: Reached target paths.target - Path Units. Oct 29 23:39:15.362526 systemd[1]: Reached target slices.target - Slice Units. Oct 29 23:39:15.362536 systemd[1]: Reached target swap.target - Swaps. Oct 29 23:39:15.362544 systemd[1]: Reached target timers.target - Timer Units. Oct 29 23:39:15.362552 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 23:39:15.362560 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 23:39:15.362568 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 29 23:39:15.362576 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Oct 29 23:39:15.362585 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 29 23:39:15.362594 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 23:39:15.362603 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 23:39:15.362611 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 23:39:15.362619 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 29 23:39:15.362636 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 29 23:39:15.362647 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 23:39:15.362655 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 29 23:39:15.362664 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 29 23:39:15.362673 systemd[1]: Starting systemd-fsck-usr.service... Oct 29 23:39:15.362681 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 23:39:15.362690 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 23:39:15.362699 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 23:39:15.362709 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 29 23:39:15.362718 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 23:39:15.362726 systemd[1]: Finished systemd-fsck-usr.service. Oct 29 23:39:15.362736 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 29 23:39:15.362761 systemd-journald[345]: Collecting audit messages is disabled. Oct 29 23:39:15.362781 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 29 23:39:15.362791 kernel: Bridge firewalling registered Oct 29 23:39:15.362800 systemd-journald[345]: Journal started Oct 29 23:39:15.362819 systemd-journald[345]: Runtime Journal (/run/log/journal/18046aee056d47c7a6b053271c205428) is 6M, max 48.5M, 42.4M free. Oct 29 23:39:15.361791 systemd-modules-load[347]: Inserted module 'br_netfilter' Oct 29 23:39:15.375151 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 23:39:15.377836 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 23:39:15.378545 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 23:39:15.382365 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 29 23:39:15.384329 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 23:39:15.386536 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 23:39:15.396470 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 23:39:15.399862 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 23:39:15.404022 systemd-tmpfiles[366]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Oct 29 23:39:15.409132 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 23:39:15.414036 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 23:39:15.417556 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 23:39:15.420293 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 23:39:15.423078 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 29 23:39:15.425502 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 23:39:15.445653 dracut-cmdline[387]: 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=c3f6e690ee2ade37dd6082d1ad3b53d2d12b3a76b4644e8ca271364e3a8c31ac Oct 29 23:39:15.468530 systemd-resolved[388]: Positive Trust Anchors: Oct 29 23:39:15.468549 systemd-resolved[388]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 23:39:15.468553 systemd-resolved[388]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 29 23:39:15.468583 systemd-resolved[388]: 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 29 23:39:15.493657 systemd-resolved[388]: Defaulting to hostname 'linux'. Oct 29 23:39:15.494635 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 23:39:15.495938 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 23:39:15.527948 kernel: Loading iSCSI transport class v2.0-870. Oct 29 23:39:15.536943 kernel: iscsi: registered transport (tcp) Oct 29 23:39:15.550396 kernel: iscsi: registered transport (qla4xxx) Oct 29 23:39:15.550448 kernel: QLogic iSCSI HBA Driver Oct 29 23:39:15.571938 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 29 23:39:15.590362 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 23:39:15.592704 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 23:39:15.640488 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 29 23:39:15.645065 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 29 23:39:15.647208 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 29 23:39:15.685537 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 29 23:39:15.688455 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 23:39:15.717038 systemd-udevd[629]: Using default interface naming scheme 'v257'. Oct 29 23:39:15.724737 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 23:39:15.729365 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 29 23:39:15.750882 dracut-pre-trigger[696]: rd.md=0: removing MD RAID activation Oct 29 23:39:15.757974 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 29 23:39:15.761057 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 29 23:39:15.776992 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 23:39:15.779557 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 23:39:15.804665 systemd-networkd[745]: lo: Link UP Oct 29 23:39:15.804673 systemd-networkd[745]: lo: Gained carrier Oct 29 23:39:15.805340 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 29 23:39:15.806755 systemd[1]: Reached target network.target - Network. Oct 29 23:39:15.839107 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 23:39:15.841975 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 29 23:39:15.881128 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 29 23:39:15.888374 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 29 23:39:15.895585 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 29 23:39:15.904132 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 29 23:39:15.912042 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 29 23:39:15.913695 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 23:39:15.915050 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 23:39:15.926097 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 23:39:15.931061 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 29 23:39:15.932824 systemd-networkd[745]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 29 23:39:15.932828 systemd-networkd[745]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 23:39:15.933335 systemd-networkd[745]: eth0: Link UP Oct 29 23:39:15.933573 systemd-networkd[745]: eth0: Gained carrier Oct 29 23:39:15.933584 systemd-networkd[745]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 29 23:39:15.934815 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 29 23:39:15.940262 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 23:39:15.940385 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 23:39:15.941801 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 23:39:15.951031 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 23:39:15.954016 systemd-networkd[745]: eth0: DHCPv4 address 10.0.0.90/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 29 23:39:15.959972 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 29 23:39:15.976172 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 23:39:16.990507 disk-uuid[813]: Warning: The kernel is still using the old partition table. Oct 29 23:39:16.990507 disk-uuid[813]: The new table will be used at the next reboot or after you Oct 29 23:39:16.990507 disk-uuid[813]: run partprobe(8) or kpartx(8) Oct 29 23:39:16.990507 disk-uuid[813]: The operation has completed successfully. Oct 29 23:39:16.996598 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 29 23:39:16.996703 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 29 23:39:16.998987 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 29 23:39:17.026940 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (828) Oct 29 23:39:17.029336 kernel: BTRFS info (device vda6): first mount of filesystem 69a058e1-a2ca-4b98-8b6f-1187a84af986 Oct 29 23:39:17.029368 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 29 23:39:17.032944 kernel: BTRFS info (device vda6): turning on async discard Oct 29 23:39:17.032983 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 23:39:17.038950 kernel: BTRFS info (device vda6): last unmount of filesystem 69a058e1-a2ca-4b98-8b6f-1187a84af986 Oct 29 23:39:17.039241 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 29 23:39:17.041304 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 29 23:39:17.144861 ignition[847]: Ignition 2.22.0 Oct 29 23:39:17.144878 ignition[847]: Stage: fetch-offline Oct 29 23:39:17.144944 ignition[847]: no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:17.144954 ignition[847]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:17.145031 ignition[847]: parsed url from cmdline: "" Oct 29 23:39:17.145038 ignition[847]: no config URL provided Oct 29 23:39:17.145043 ignition[847]: reading system config file "/usr/lib/ignition/user.ign" Oct 29 23:39:17.145062 ignition[847]: no config at "/usr/lib/ignition/user.ign" Oct 29 23:39:17.145100 ignition[847]: op(1): [started] loading QEMU firmware config module Oct 29 23:39:17.145104 ignition[847]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 29 23:39:17.155512 ignition[847]: op(1): [finished] loading QEMU firmware config module Oct 29 23:39:17.159020 ignition[847]: parsing config with SHA512: 53888d205ce92b024f9438cce4484f88c632f820fb46d29eb6531ba3edb8becffa030d4329af9a495f3cba81a3a70af34061a2a1e54684aff2da6fa1de2a7372 Oct 29 23:39:17.164594 unknown[847]: fetched base config from "system" Oct 29 23:39:17.164606 unknown[847]: fetched user config from "qemu" Oct 29 23:39:17.164763 ignition[847]: fetch-offline: fetch-offline passed Oct 29 23:39:17.167404 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 23:39:17.164851 ignition[847]: Ignition finished successfully Oct 29 23:39:17.168812 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 29 23:39:17.169647 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 29 23:39:17.199555 ignition[863]: Ignition 2.22.0 Oct 29 23:39:17.199577 ignition[863]: Stage: kargs Oct 29 23:39:17.199714 ignition[863]: no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:17.199722 ignition[863]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:17.200213 ignition[863]: kargs: kargs passed Oct 29 23:39:17.200257 ignition[863]: Ignition finished successfully Oct 29 23:39:17.203970 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 29 23:39:17.206644 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 29 23:39:17.235747 ignition[871]: Ignition 2.22.0 Oct 29 23:39:17.235761 ignition[871]: Stage: disks Oct 29 23:39:17.235892 ignition[871]: no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:17.235901 ignition[871]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:17.238522 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 29 23:39:17.236419 ignition[871]: disks: disks passed Oct 29 23:39:17.240745 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 29 23:39:17.236460 ignition[871]: Ignition finished successfully Oct 29 23:39:17.242774 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 29 23:39:17.245015 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 23:39:17.246604 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 23:39:17.248729 systemd[1]: Reached target basic.target - Basic System. Oct 29 23:39:17.251327 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 29 23:39:17.291814 systemd-fsck[881]: ROOT: clean, 15/456736 files, 38230/456704 blocks Oct 29 23:39:17.297522 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 29 23:39:17.299959 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 29 23:39:17.364944 kernel: EXT4-fs (vda9): mounted filesystem 1648bfe3-fe28-4898-89ac-a64f076d042f r/w with ordered data mode. Quota mode: none. Oct 29 23:39:17.365689 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 29 23:39:17.367129 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 29 23:39:17.370823 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 29 23:39:17.374863 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 29 23:39:17.376012 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 29 23:39:17.376055 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 29 23:39:17.376094 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 23:39:17.391555 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 29 23:39:17.395396 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 29 23:39:17.398548 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (889) Oct 29 23:39:17.401765 kernel: BTRFS info (device vda6): first mount of filesystem 69a058e1-a2ca-4b98-8b6f-1187a84af986 Oct 29 23:39:17.401800 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 29 23:39:17.405143 kernel: BTRFS info (device vda6): turning on async discard Oct 29 23:39:17.405171 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 23:39:17.406190 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 29 23:39:17.439658 initrd-setup-root[913]: cut: /sysroot/etc/passwd: No such file or directory Oct 29 23:39:17.444382 initrd-setup-root[920]: cut: /sysroot/etc/group: No such file or directory Oct 29 23:39:17.448651 initrd-setup-root[927]: cut: /sysroot/etc/shadow: No such file or directory Oct 29 23:39:17.451708 initrd-setup-root[934]: cut: /sysroot/etc/gshadow: No such file or directory Oct 29 23:39:17.525946 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 29 23:39:17.528410 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 29 23:39:17.531132 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 29 23:39:17.545758 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 29 23:39:17.548933 kernel: BTRFS info (device vda6): last unmount of filesystem 69a058e1-a2ca-4b98-8b6f-1187a84af986 Oct 29 23:39:17.565971 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 29 23:39:17.573320 ignition[1003]: INFO : Ignition 2.22.0 Oct 29 23:39:17.574396 ignition[1003]: INFO : Stage: mount Oct 29 23:39:17.575156 ignition[1003]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:17.575156 ignition[1003]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:17.577372 ignition[1003]: INFO : mount: mount passed Oct 29 23:39:17.577372 ignition[1003]: INFO : Ignition finished successfully Oct 29 23:39:17.577274 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 29 23:39:17.579401 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 29 23:39:17.786018 systemd-networkd[745]: eth0: Gained IPv6LL Oct 29 23:39:18.367263 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 29 23:39:18.401712 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (1015) Oct 29 23:39:18.408381 kernel: BTRFS info (device vda6): first mount of filesystem 69a058e1-a2ca-4b98-8b6f-1187a84af986 Oct 29 23:39:18.408458 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Oct 29 23:39:18.411572 kernel: BTRFS info (device vda6): turning on async discard Oct 29 23:39:18.411646 kernel: BTRFS info (device vda6): enabling free space tree Oct 29 23:39:18.412997 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 29 23:39:18.448441 ignition[1032]: INFO : Ignition 2.22.0 Oct 29 23:39:18.449575 ignition[1032]: INFO : Stage: files Oct 29 23:39:18.450553 ignition[1032]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:18.451802 ignition[1032]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:18.453831 ignition[1032]: DEBUG : files: compiled without relabeling support, skipping Oct 29 23:39:18.455786 ignition[1032]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 29 23:39:18.457387 ignition[1032]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 29 23:39:18.462506 ignition[1032]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 29 23:39:18.464289 ignition[1032]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 29 23:39:18.466222 unknown[1032]: wrote ssh authorized keys file for user: core Oct 29 23:39:18.467672 ignition[1032]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 29 23:39:18.471869 ignition[1032]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 23:39:18.474092 ignition[1032]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 29 23:39:18.474092 ignition[1032]: INFO : files: op(4): [started] processing unit "docker.service" Oct 29 23:39:18.474092 ignition[1032]: INFO : files: op(4): [finished] processing unit "docker.service" Oct 29 23:39:18.474092 ignition[1032]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Oct 29 23:39:18.480534 ignition[1032]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 29 23:39:18.483503 ignition[1032]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 29 23:39:18.483503 ignition[1032]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Oct 29 23:39:18.487153 ignition[1032]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Oct 29 23:39:18.521080 ignition[1032]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 29 23:39:18.526788 ignition[1032]: INFO : files: files passed Oct 29 23:39:18.526788 ignition[1032]: INFO : Ignition finished successfully Oct 29 23:39:18.528773 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 29 23:39:18.532497 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 29 23:39:18.535156 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 29 23:39:18.549895 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 29 23:39:18.550053 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 29 23:39:18.553663 initrd-setup-root-after-ignition[1063]: grep: /sysroot/oem/oem-release: No such file or directory Oct 29 23:39:18.555956 initrd-setup-root-after-ignition[1065]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 23:39:18.555956 initrd-setup-root-after-ignition[1065]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 29 23:39:18.559654 initrd-setup-root-after-ignition[1069]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 29 23:39:18.560676 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 23:39:18.562859 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 29 23:39:18.565938 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 29 23:39:18.619014 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 29 23:39:18.619149 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 29 23:39:18.621771 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 29 23:39:18.624018 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 29 23:39:18.626308 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 29 23:39:18.627230 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 29 23:39:18.661996 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 23:39:18.665465 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 29 23:39:18.686825 systemd[1]: Unnecessary job was removed for dev-mapper-usr.device - /dev/mapper/usr. Oct 29 23:39:18.688595 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 29 23:39:18.691530 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 23:39:18.692987 systemd[1]: Stopped target timers.target - Timer Units. Oct 29 23:39:18.696150 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 29 23:39:18.696295 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 29 23:39:18.702441 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 29 23:39:18.703698 systemd[1]: Stopped target basic.target - Basic System. Oct 29 23:39:18.706059 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 29 23:39:18.708187 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 29 23:39:18.712245 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 29 23:39:18.715756 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Oct 29 23:39:18.718048 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 29 23:39:18.720869 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 29 23:39:18.723113 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 29 23:39:18.725395 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 29 23:39:18.727517 systemd[1]: Stopped target swap.target - Swaps. Oct 29 23:39:18.729182 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 29 23:39:18.729331 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 29 23:39:18.731957 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 29 23:39:18.733240 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 23:39:18.735480 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 29 23:39:18.739988 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 23:39:18.741433 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 29 23:39:18.741574 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 29 23:39:18.744987 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 29 23:39:18.745133 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 29 23:39:18.747310 systemd[1]: Stopped target paths.target - Path Units. Oct 29 23:39:18.749053 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 29 23:39:18.749170 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 23:39:18.751384 systemd[1]: Stopped target slices.target - Slice Units. Oct 29 23:39:18.753331 systemd[1]: Stopped target sockets.target - Socket Units. Oct 29 23:39:18.755276 systemd[1]: iscsid.socket: Deactivated successfully. Oct 29 23:39:18.755372 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 29 23:39:18.757948 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 29 23:39:18.758045 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 29 23:39:18.760009 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 29 23:39:18.760145 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 29 23:39:18.762299 systemd[1]: ignition-files.service: Deactivated successfully. Oct 29 23:39:18.762407 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 29 23:39:18.764864 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 29 23:39:18.767441 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 29 23:39:18.768472 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 29 23:39:18.768614 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 23:39:18.770946 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 29 23:39:18.771070 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 23:39:18.773535 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 29 23:39:18.773646 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 29 23:39:18.779463 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 29 23:39:18.789111 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 29 23:39:18.801319 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 29 23:39:18.807765 ignition[1091]: INFO : Ignition 2.22.0 Oct 29 23:39:18.807765 ignition[1091]: INFO : Stage: umount Oct 29 23:39:18.807765 ignition[1091]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 29 23:39:18.807765 ignition[1091]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 29 23:39:18.807765 ignition[1091]: INFO : umount: umount passed Oct 29 23:39:18.807765 ignition[1091]: INFO : Ignition finished successfully Oct 29 23:39:18.809547 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 29 23:39:18.809649 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 29 23:39:18.813506 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 29 23:39:18.813604 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 29 23:39:18.815556 systemd[1]: Stopped target network.target - Network. Oct 29 23:39:18.816736 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 29 23:39:18.816805 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 29 23:39:18.818676 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 29 23:39:18.818725 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 29 23:39:18.820570 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 29 23:39:18.820626 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 29 23:39:18.822427 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 29 23:39:18.822475 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 29 23:39:18.824220 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 29 23:39:18.824274 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 29 23:39:18.826325 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 29 23:39:18.827997 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 29 23:39:18.834895 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 29 23:39:18.835084 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 29 23:39:18.840153 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 29 23:39:18.840266 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 29 23:39:18.844379 systemd[1]: Stopped target network-pre.target - Preparation for Network. Oct 29 23:39:18.846314 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 29 23:39:18.846354 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 29 23:39:18.849062 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 29 23:39:18.850186 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 29 23:39:18.850259 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 29 23:39:18.852529 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 29 23:39:18.852577 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 29 23:39:18.854481 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 29 23:39:18.854533 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 29 23:39:18.856676 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 23:39:18.871460 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 29 23:39:18.871592 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 23:39:18.874115 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 29 23:39:18.874156 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 29 23:39:18.876318 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 29 23:39:18.876350 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 23:39:18.878332 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 29 23:39:18.878385 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 29 23:39:18.881553 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 29 23:39:18.881616 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 29 23:39:18.884718 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 29 23:39:18.884773 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 29 23:39:18.888818 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 29 23:39:18.890220 systemd[1]: systemd-network-generator.service: Deactivated successfully. Oct 29 23:39:18.890285 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 23:39:18.892543 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 29 23:39:18.892598 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 23:39:18.895227 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 29 23:39:18.895279 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 23:39:18.897685 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 29 23:39:18.897735 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 23:39:18.900083 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 29 23:39:18.900140 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 23:39:18.903292 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 29 23:39:18.911057 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 29 23:39:18.916810 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 29 23:39:18.916938 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 29 23:39:18.919546 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 29 23:39:18.922562 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 29 23:39:18.954270 systemd[1]: Switching root. Oct 29 23:39:18.981492 systemd-journald[345]: Journal stopped Oct 29 23:39:19.700146 systemd-journald[345]: Received SIGTERM from PID 1 (systemd). Oct 29 23:39:19.700198 kernel: SELinux: policy capability network_peer_controls=1 Oct 29 23:39:19.700212 kernel: SELinux: policy capability open_perms=1 Oct 29 23:39:19.700228 kernel: SELinux: policy capability extended_socket_class=1 Oct 29 23:39:19.700241 kernel: SELinux: policy capability always_check_network=0 Oct 29 23:39:19.700251 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 29 23:39:19.700261 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 29 23:39:19.700271 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 29 23:39:19.700280 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 29 23:39:19.700293 kernel: SELinux: policy capability userspace_initial_context=0 Oct 29 23:39:19.700304 kernel: audit: type=1403 audit(1761781159.061:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 29 23:39:19.700316 systemd[1]: Successfully loaded SELinux policy in 61.780ms. Oct 29 23:39:19.700335 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.631ms. Oct 29 23:39:19.700346 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 29 23:39:19.700358 systemd[1]: Detected virtualization kvm. Oct 29 23:39:19.700369 systemd[1]: Detected architecture arm64. Oct 29 23:39:19.700381 systemd[1]: Detected first boot. Oct 29 23:39:19.700391 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Oct 29 23:39:19.700404 zram_generator::config[1139]: No configuration found. Oct 29 23:39:19.700415 kernel: NET: Registered PF_VSOCK protocol family Oct 29 23:39:19.700425 systemd[1]: Populated /etc with preset unit settings. Oct 29 23:39:19.700436 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 29 23:39:19.700447 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 29 23:39:19.700457 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 29 23:39:19.700469 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 29 23:39:19.700481 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 29 23:39:19.700492 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 29 23:39:19.700503 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 29 23:39:19.700513 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 29 23:39:19.700537 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 29 23:39:19.700549 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 29 23:39:19.700560 systemd[1]: Created slice user.slice - User and Session Slice. Oct 29 23:39:19.700571 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 29 23:39:19.700583 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 29 23:39:19.700594 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 29 23:39:19.700607 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 29 23:39:19.700619 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 29 23:39:19.700630 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 29 23:39:19.700641 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Oct 29 23:39:19.700652 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 29 23:39:19.700662 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 29 23:39:19.700673 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 29 23:39:19.700685 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 29 23:39:19.700697 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 29 23:39:19.700708 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 29 23:39:19.700718 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 29 23:39:19.700729 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 29 23:39:19.700740 systemd[1]: Reached target slices.target - Slice Units. Oct 29 23:39:19.700751 systemd[1]: Reached target swap.target - Swaps. Oct 29 23:39:19.700762 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 29 23:39:19.700773 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 29 23:39:19.700783 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Oct 29 23:39:19.700794 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 29 23:39:19.700811 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 29 23:39:19.700822 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 29 23:39:19.700834 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 29 23:39:19.700845 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 29 23:39:19.700856 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 29 23:39:19.700870 systemd[1]: Mounting media.mount - External Media Directory... Oct 29 23:39:19.700881 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 29 23:39:19.700891 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 29 23:39:19.700901 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 29 23:39:19.700920 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 29 23:39:19.700933 systemd[1]: Reached target machines.target - Containers. Oct 29 23:39:19.700943 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 29 23:39:19.700954 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 23:39:19.700965 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 29 23:39:19.700975 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 29 23:39:19.700986 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 29 23:39:19.700996 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 29 23:39:19.701016 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 29 23:39:19.701027 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 29 23:39:19.701038 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 29 23:39:19.701049 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 29 23:39:19.701060 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 29 23:39:19.701071 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 29 23:39:19.701081 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 29 23:39:19.701093 systemd[1]: Stopped systemd-fsck-usr.service. Oct 29 23:39:19.701104 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 29 23:39:19.701114 kernel: ACPI: bus type drm_connector registered Oct 29 23:39:19.701124 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 29 23:39:19.701135 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 29 23:39:19.701145 kernel: fuse: init (API version 7.41) Oct 29 23:39:19.701155 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 29 23:39:19.701170 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 29 23:39:19.701181 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Oct 29 23:39:19.701213 systemd-journald[1207]: Collecting audit messages is disabled. Oct 29 23:39:19.701239 systemd-journald[1207]: Journal started Oct 29 23:39:19.701260 systemd-journald[1207]: Runtime Journal (/run/log/journal/18046aee056d47c7a6b053271c205428) is 6M, max 48.5M, 42.4M free. Oct 29 23:39:19.451634 systemd[1]: Queued start job for default target multi-user.target. Oct 29 23:39:19.477002 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 29 23:39:19.477536 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 29 23:39:19.711689 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 29 23:39:19.716059 systemd[1]: Started systemd-journald.service - Journal Service. Oct 29 23:39:19.717040 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 29 23:39:19.718185 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 29 23:39:19.719410 systemd[1]: Mounted media.mount - External Media Directory. Oct 29 23:39:19.720546 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 29 23:39:19.721792 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 29 23:39:19.723123 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 29 23:39:19.725971 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 29 23:39:19.727461 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 29 23:39:19.727620 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 29 23:39:19.729223 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 29 23:39:19.729399 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 29 23:39:19.730867 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 23:39:19.731070 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 29 23:39:19.732483 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 29 23:39:19.732646 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 29 23:39:19.734453 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 29 23:39:19.734605 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 29 23:39:19.736135 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 29 23:39:19.736298 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 29 23:39:19.737826 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 29 23:39:19.739682 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 29 23:39:19.742015 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 29 23:39:19.753181 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 29 23:39:19.754909 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Oct 29 23:39:19.757530 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 29 23:39:19.762041 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 29 23:39:19.763304 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 29 23:39:19.763342 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 29 23:39:19.765384 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Oct 29 23:39:19.766996 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 23:39:19.768409 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 29 23:39:19.770511 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 29 23:39:19.771929 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 29 23:39:19.775088 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 29 23:39:19.776412 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 29 23:39:19.779122 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 29 23:39:19.781718 systemd-journald[1207]: Time spent on flushing to /var/log/journal/18046aee056d47c7a6b053271c205428 is 14.637ms for 840 entries. Oct 29 23:39:19.781718 systemd-journald[1207]: System Journal (/var/log/journal/18046aee056d47c7a6b053271c205428) is 8M, max 163.5M, 155.5M free. Oct 29 23:39:19.819097 systemd-journald[1207]: Received client request to flush runtime journal. Oct 29 23:39:19.819156 kernel: loop1: detected capacity change from 0 to 119344 Oct 29 23:39:19.785091 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 29 23:39:19.789166 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 29 23:39:19.792435 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 29 23:39:19.799285 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Oct 29 23:39:19.801804 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 29 23:39:19.803423 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 29 23:39:19.806383 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 29 23:39:19.808285 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 29 23:39:19.811810 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 29 23:39:19.814722 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Oct 29 23:39:19.823638 systemd-tmpfiles[1254]: ACLs are not supported, ignoring. Oct 29 23:39:19.823656 systemd-tmpfiles[1254]: ACLs are not supported, ignoring. Oct 29 23:39:19.827135 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 29 23:39:19.828933 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 29 23:39:19.831590 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 29 23:39:19.836322 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 29 23:39:19.845964 kernel: loop2: detected capacity change from 0 to 100624 Oct 29 23:39:19.856402 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Oct 29 23:39:19.867973 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 29 23:39:19.871957 kernel: loop3: detected capacity change from 0 to 119344 Oct 29 23:39:19.871891 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 29 23:39:19.876102 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 29 23:39:19.881676 kernel: loop4: detected capacity change from 0 to 100624 Oct 29 23:39:19.881970 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 29 23:39:19.888723 (sd-merge)[1276]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw'. Oct 29 23:39:19.891478 (sd-merge)[1276]: Merged extensions into '/usr'. Oct 29 23:39:19.894716 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 29 23:39:19.897779 systemd[1]: Starting ensure-sysext.service... Oct 29 23:39:19.900182 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Oct 29 23:39:19.904832 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Oct 29 23:39:19.905187 systemd-tmpfiles[1278]: ACLs are not supported, ignoring. Oct 29 23:39:19.912289 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 29 23:39:19.917803 systemd[1]: Reload requested from client PID 1282 ('systemctl') (unit ensure-sysext.service)... Oct 29 23:39:19.917815 systemd[1]: Reloading... Oct 29 23:39:19.926144 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Oct 29 23:39:19.927068 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Oct 29 23:39:19.927451 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 29 23:39:19.927669 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 29 23:39:19.928278 systemd-tmpfiles[1283]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 29 23:39:19.928445 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Oct 29 23:39:19.928491 systemd-tmpfiles[1283]: ACLs are not supported, ignoring. Oct 29 23:39:19.938437 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Oct 29 23:39:19.938571 systemd-tmpfiles[1283]: Skipping /boot Oct 29 23:39:19.946742 systemd-tmpfiles[1283]: Detected autofs mount point /boot during canonicalization of boot. Oct 29 23:39:19.946870 systemd-tmpfiles[1283]: Skipping /boot Oct 29 23:39:19.983033 zram_generator::config[1322]: No configuration found. Oct 29 23:39:20.004195 systemd-resolved[1277]: Positive Trust Anchors: Oct 29 23:39:20.004214 systemd-resolved[1277]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 29 23:39:20.004218 systemd-resolved[1277]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Oct 29 23:39:20.004249 systemd-resolved[1277]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Oct 29 23:39:20.016232 systemd-resolved[1277]: Defaulting to hostname 'linux'. Oct 29 23:39:20.114522 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 29 23:39:20.114601 systemd[1]: Reloading finished in 196 ms. Oct 29 23:39:20.140578 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 29 23:39:20.142203 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 29 23:39:20.160124 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Oct 29 23:39:20.166108 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 29 23:39:20.168830 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 29 23:39:20.171070 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 29 23:39:20.173544 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 29 23:39:20.184032 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 29 23:39:20.187596 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 29 23:39:20.193361 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 23:39:20.203660 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 29 23:39:20.207232 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 29 23:39:20.209598 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 29 23:39:20.210874 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 23:39:20.211020 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 29 23:39:20.212077 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 29 23:39:20.212255 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 29 23:39:20.216216 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 29 23:39:20.216387 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 29 23:39:20.218166 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 29 23:39:20.218332 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 29 23:39:20.223257 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 29 23:39:20.224597 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 29 23:39:20.229143 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 29 23:39:20.237174 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 29 23:39:20.249332 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 29 23:39:20.250669 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 29 23:39:20.250832 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 29 23:39:20.252087 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 29 23:39:20.252272 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 29 23:39:20.254256 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 29 23:39:20.254429 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 29 23:39:20.256359 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 29 23:39:20.258399 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 29 23:39:20.260561 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 29 23:39:20.261735 augenrules[1388]: No rules Oct 29 23:39:20.262587 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 29 23:39:20.266103 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 29 23:39:20.268182 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 23:39:20.268419 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 29 23:39:20.270151 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 29 23:39:20.270368 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 29 23:39:20.276336 systemd[1]: Finished ensure-sysext.service. Oct 29 23:39:20.283431 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 29 23:39:20.283565 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 29 23:39:20.285189 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 29 23:39:20.287793 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 29 23:39:20.289249 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 29 23:39:20.289662 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 29 23:39:20.319754 systemd-udevd[1403]: Using default interface naming scheme 'v257'. Oct 29 23:39:20.335312 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 29 23:39:20.337163 systemd[1]: Reached target time-set.target - System Time Set. Oct 29 23:39:20.339864 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 29 23:39:20.343273 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 29 23:39:20.384623 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Oct 29 23:39:20.421200 systemd-networkd[1412]: lo: Link UP Oct 29 23:39:20.421586 systemd-networkd[1412]: lo: Gained carrier Oct 29 23:39:20.422641 systemd-networkd[1412]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 29 23:39:20.422645 systemd-networkd[1412]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 29 23:39:20.422663 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 29 23:39:20.423901 systemd-networkd[1412]: eth0: Link UP Oct 29 23:39:20.424170 systemd-networkd[1412]: eth0: Gained carrier Oct 29 23:39:20.424259 systemd-networkd[1412]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Oct 29 23:39:20.432996 systemd[1]: Reached target network.target - Network. Oct 29 23:39:20.438990 systemd-networkd[1412]: eth0: DHCPv4 address 10.0.0.90/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 29 23:39:20.439104 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Oct 29 23:39:20.439697 systemd-timesyncd[1402]: Network configuration changed, trying to establish connection. Oct 29 23:39:20.440734 systemd-timesyncd[1402]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 29 23:39:20.440791 systemd-timesyncd[1402]: Initial clock synchronization to Wed 2025-10-29 23:39:20.527190 UTC. Oct 29 23:39:20.444119 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 29 23:39:20.451087 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 29 23:39:20.456184 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 29 23:39:20.471410 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 29 23:39:20.473580 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Oct 29 23:39:20.524133 ldconfig[1356]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 29 23:39:20.532225 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 29 23:39:20.535635 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 29 23:39:20.548663 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 29 23:39:20.555190 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 29 23:39:20.592719 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 29 23:39:20.596281 systemd[1]: Reached target sysinit.target - System Initialization. Oct 29 23:39:20.597500 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 29 23:39:20.598799 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 29 23:39:20.600275 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 29 23:39:20.601556 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 29 23:39:20.602882 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 29 23:39:20.604182 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 29 23:39:20.604213 systemd[1]: Reached target paths.target - Path Units. Oct 29 23:39:20.605179 systemd[1]: Reached target timers.target - Timer Units. Oct 29 23:39:20.606957 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 29 23:39:20.609526 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 29 23:39:20.612430 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Oct 29 23:39:20.614012 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Oct 29 23:39:20.615339 systemd[1]: Reached target ssh-access.target - SSH Access Available. Oct 29 23:39:20.619816 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 29 23:39:20.621276 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Oct 29 23:39:20.623166 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 29 23:39:20.624382 systemd[1]: Reached target sockets.target - Socket Units. Oct 29 23:39:20.625462 systemd[1]: Reached target basic.target - Basic System. Oct 29 23:39:20.626488 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 29 23:39:20.626520 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 29 23:39:20.627550 systemd[1]: Starting containerd.service - containerd container runtime... Oct 29 23:39:20.629670 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 29 23:39:20.631662 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 29 23:39:20.633776 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 29 23:39:20.635863 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 29 23:39:20.637084 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 29 23:39:20.638148 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 29 23:39:20.642075 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 29 23:39:20.642343 jq[1472]: false Oct 29 23:39:20.644237 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 29 23:39:20.648136 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 29 23:39:20.648503 extend-filesystems[1473]: Found /dev/vda6 Oct 29 23:39:20.649723 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 29 23:39:20.650161 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 29 23:39:20.650795 systemd[1]: Starting update-engine.service - Update Engine... Oct 29 23:39:20.653058 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 29 23:39:20.657661 extend-filesystems[1473]: Found /dev/vda9 Oct 29 23:39:20.659086 extend-filesystems[1473]: Checking size of /dev/vda9 Oct 29 23:39:20.668546 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 29 23:39:20.670935 extend-filesystems[1473]: Resized partition /dev/vda9 Oct 29 23:39:20.670330 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 29 23:39:20.670512 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 29 23:39:20.670752 systemd[1]: motdgen.service: Deactivated successfully. Oct 29 23:39:20.670901 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 29 23:39:20.672248 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 29 23:39:20.672401 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 29 23:39:20.674384 jq[1488]: true Oct 29 23:39:20.675804 extend-filesystems[1499]: resize2fs 1.47.3 (8-Jul-2025) Oct 29 23:39:20.691098 kernel: EXT4-fs (vda9): resizing filesystem from 456704 to 474107 blocks Oct 29 23:39:20.691153 kernel: EXT4-fs (vda9): resized filesystem to 474107 Oct 29 23:39:20.691173 jq[1500]: true Oct 29 23:39:20.696165 (ntainerd)[1511]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 29 23:39:20.706625 dbus-daemon[1470]: [system] SELinux support is enabled Oct 29 23:39:20.707757 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 29 23:39:20.712602 update_engine[1484]: I20251029 23:39:20.705241 1484 main.cc:92] Flatcar Update Engine starting Oct 29 23:39:20.712726 extend-filesystems[1499]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Oct 29 23:39:20.712726 extend-filesystems[1499]: old_desc_blocks = 1, new_desc_blocks = 1 Oct 29 23:39:20.712726 extend-filesystems[1499]: The filesystem on /dev/vda9 is now 474107 (4k) blocks long. Oct 29 23:39:20.725175 extend-filesystems[1473]: Resized filesystem in /dev/vda9 Oct 29 23:39:20.726680 update_engine[1484]: I20251029 23:39:20.722713 1484 update_check_scheduler.cc:74] Next update check in 4m54s Oct 29 23:39:20.716421 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 29 23:39:20.716610 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 29 23:39:20.731138 bash[1531]: Updated "/home/core/.ssh/authorized_keys" Oct 29 23:39:20.733032 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 29 23:39:20.735330 systemd[1]: Started update-engine.service - Update Engine. Oct 29 23:39:20.737177 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 29 23:39:20.737280 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 29 23:39:20.737306 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 29 23:39:20.738831 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 29 23:39:20.738853 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 29 23:39:20.744096 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 29 23:39:20.757821 systemd-logind[1482]: Watching system buttons on /dev/input/event0 (Power Button) Oct 29 23:39:20.759197 systemd-logind[1482]: New seat seat0. Oct 29 23:39:20.761474 systemd[1]: Started systemd-logind.service - User Login Management. Oct 29 23:39:20.794202 locksmithd[1534]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 29 23:39:20.862161 containerd[1511]: time="2025-10-29T23:39:20Z" 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 29 23:39:20.863740 containerd[1511]: time="2025-10-29T23:39:20.863703360Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 29 23:39:20.875870 containerd[1511]: time="2025-10-29T23:39:20.875831800Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.84µs" Oct 29 23:39:20.875906 containerd[1511]: time="2025-10-29T23:39:20.875869160Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 29 23:39:20.875906 containerd[1511]: time="2025-10-29T23:39:20.875888320Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 29 23:39:20.876070 containerd[1511]: time="2025-10-29T23:39:20.876049320Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 29 23:39:20.876097 containerd[1511]: time="2025-10-29T23:39:20.876072440Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 29 23:39:20.876116 containerd[1511]: time="2025-10-29T23:39:20.876101560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876209 containerd[1511]: time="2025-10-29T23:39:20.876156360Z" 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 29 23:39:20.876233 containerd[1511]: time="2025-10-29T23:39:20.876206640Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876423 containerd[1511]: time="2025-10-29T23:39:20.876396640Z" 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 29 23:39:20.876423 containerd[1511]: time="2025-10-29T23:39:20.876421400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876470 containerd[1511]: time="2025-10-29T23:39:20.876432800Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876470 containerd[1511]: time="2025-10-29T23:39:20.876440000Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876527 containerd[1511]: time="2025-10-29T23:39:20.876510960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876703 containerd[1511]: time="2025-10-29T23:39:20.876684960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 23:39:20.876738 containerd[1511]: time="2025-10-29T23:39:20.876716320Z" 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 29 23:39:20.876738 containerd[1511]: time="2025-10-29T23:39:20.876736240Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 29 23:39:20.876799 containerd[1511]: time="2025-10-29T23:39:20.876784640Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 29 23:39:20.877108 containerd[1511]: time="2025-10-29T23:39:20.877087520Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 29 23:39:20.877176 containerd[1511]: time="2025-10-29T23:39:20.877155280Z" level=info msg="metadata content store policy set" policy=shared Oct 29 23:39:20.881744 containerd[1511]: time="2025-10-29T23:39:20.881713400Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 29 23:39:20.881788 containerd[1511]: time="2025-10-29T23:39:20.881774320Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 29 23:39:20.881828 containerd[1511]: time="2025-10-29T23:39:20.881791640Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 29 23:39:20.881828 containerd[1511]: time="2025-10-29T23:39:20.881805520Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 29 23:39:20.881828 containerd[1511]: time="2025-10-29T23:39:20.881817160Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 29 23:39:20.881876 containerd[1511]: time="2025-10-29T23:39:20.881829800Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 29 23:39:20.881876 containerd[1511]: time="2025-10-29T23:39:20.881841560Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 29 23:39:20.881876 containerd[1511]: time="2025-10-29T23:39:20.881853760Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 29 23:39:20.881945 containerd[1511]: time="2025-10-29T23:39:20.881892400Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 29 23:39:20.881945 containerd[1511]: time="2025-10-29T23:39:20.881905640Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 29 23:39:20.881945 containerd[1511]: time="2025-10-29T23:39:20.881924760Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 29 23:39:20.881945 containerd[1511]: time="2025-10-29T23:39:20.881939680Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 29 23:39:20.882095 containerd[1511]: time="2025-10-29T23:39:20.882073600Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 29 23:39:20.882118 containerd[1511]: time="2025-10-29T23:39:20.882101920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 29 23:39:20.882136 containerd[1511]: time="2025-10-29T23:39:20.882118280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 29 23:39:20.882136 containerd[1511]: time="2025-10-29T23:39:20.882130440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 29 23:39:20.882173 containerd[1511]: time="2025-10-29T23:39:20.882140240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 29 23:39:20.882173 containerd[1511]: time="2025-10-29T23:39:20.882151400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 29 23:39:20.882173 containerd[1511]: time="2025-10-29T23:39:20.882168640Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 29 23:39:20.882222 containerd[1511]: time="2025-10-29T23:39:20.882181800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 29 23:39:20.882222 containerd[1511]: time="2025-10-29T23:39:20.882193560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 29 23:39:20.882222 containerd[1511]: time="2025-10-29T23:39:20.882203920Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 29 23:39:20.882222 containerd[1511]: time="2025-10-29T23:39:20.882214160Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 29 23:39:20.882958 containerd[1511]: time="2025-10-29T23:39:20.882391280Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 29 23:39:20.882958 containerd[1511]: time="2025-10-29T23:39:20.882411760Z" level=info msg="Start snapshots syncer" Oct 29 23:39:20.882958 containerd[1511]: time="2025-10-29T23:39:20.882452760Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 29 23:39:20.883105 containerd[1511]: time="2025-10-29T23:39:20.882774400Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 29 23:39:20.883105 containerd[1511]: time="2025-10-29T23:39:20.882825480Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 29 23:39:20.883105 containerd[1511]: time="2025-10-29T23:39:20.882901480Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 29 23:39:20.883236 containerd[1511]: time="2025-10-29T23:39:20.883177200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 29 23:39:20.883236 containerd[1511]: time="2025-10-29T23:39:20.883205760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 29 23:39:20.883236 containerd[1511]: time="2025-10-29T23:39:20.883217920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 29 23:39:20.883236 containerd[1511]: time="2025-10-29T23:39:20.883230720Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 29 23:39:20.883300 containerd[1511]: time="2025-10-29T23:39:20.883243480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 29 23:39:20.883300 containerd[1511]: time="2025-10-29T23:39:20.883254320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 29 23:39:20.883300 containerd[1511]: time="2025-10-29T23:39:20.883264720Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 29 23:39:20.883300 containerd[1511]: time="2025-10-29T23:39:20.883289240Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 29 23:39:20.883369 containerd[1511]: time="2025-10-29T23:39:20.883307920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 29 23:39:20.883369 containerd[1511]: time="2025-10-29T23:39:20.883319320Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 29 23:39:20.883369 containerd[1511]: time="2025-10-29T23:39:20.883357480Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 23:39:20.883421 containerd[1511]: time="2025-10-29T23:39:20.883371160Z" 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 29 23:39:20.883421 containerd[1511]: time="2025-10-29T23:39:20.883386080Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 23:39:20.883421 containerd[1511]: time="2025-10-29T23:39:20.883396880Z" 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 29 23:39:20.883421 containerd[1511]: time="2025-10-29T23:39:20.883404120Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 29 23:39:20.883421 containerd[1511]: time="2025-10-29T23:39:20.883414080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 29 23:39:20.883500 containerd[1511]: time="2025-10-29T23:39:20.883424960Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 29 23:39:20.883520 containerd[1511]: time="2025-10-29T23:39:20.883501920Z" level=info msg="runtime interface created" Oct 29 23:39:20.883520 containerd[1511]: time="2025-10-29T23:39:20.883507280Z" level=info msg="created NRI interface" Oct 29 23:39:20.883520 containerd[1511]: time="2025-10-29T23:39:20.883515480Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 29 23:39:20.883571 containerd[1511]: time="2025-10-29T23:39:20.883526400Z" level=info msg="Connect containerd service" Oct 29 23:39:20.883571 containerd[1511]: time="2025-10-29T23:39:20.883551240Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 29 23:39:20.884509 containerd[1511]: time="2025-10-29T23:39:20.884473200Z" 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 29 23:39:20.949465 containerd[1511]: time="2025-10-29T23:39:20.949343560Z" level=info msg="Start subscribing containerd event" Oct 29 23:39:20.949943 containerd[1511]: time="2025-10-29T23:39:20.949606320Z" level=info msg="Start recovering state" Oct 29 23:39:20.949943 containerd[1511]: time="2025-10-29T23:39:20.949509800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 29 23:39:20.949943 containerd[1511]: time="2025-10-29T23:39:20.949744080Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 29 23:39:20.951478 containerd[1511]: time="2025-10-29T23:39:20.951432400Z" level=info msg="Start event monitor" Oct 29 23:39:20.951535 containerd[1511]: time="2025-10-29T23:39:20.951513680Z" level=info msg="Start cni network conf syncer for default" Oct 29 23:39:20.951535 containerd[1511]: time="2025-10-29T23:39:20.951523320Z" level=info msg="Start streaming server" Oct 29 23:39:20.951591 containerd[1511]: time="2025-10-29T23:39:20.951575200Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 29 23:39:20.951591 containerd[1511]: time="2025-10-29T23:39:20.951585960Z" level=info msg="runtime interface starting up..." Oct 29 23:39:20.951776 containerd[1511]: time="2025-10-29T23:39:20.951592160Z" level=info msg="starting plugins..." Oct 29 23:39:20.951776 containerd[1511]: time="2025-10-29T23:39:20.951607640Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 29 23:39:20.952102 systemd[1]: Started containerd.service - containerd container runtime. Oct 29 23:39:20.953717 containerd[1511]: time="2025-10-29T23:39:20.953677440Z" level=info msg="containerd successfully booted in 0.091882s" Oct 29 23:39:21.276244 sshd_keygen[1508]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 29 23:39:21.298048 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 29 23:39:21.300840 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 29 23:39:21.320600 systemd[1]: issuegen.service: Deactivated successfully. Oct 29 23:39:21.320846 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 29 23:39:21.323809 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 29 23:39:21.346072 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 29 23:39:21.351218 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 29 23:39:21.353591 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Oct 29 23:39:21.355176 systemd[1]: Reached target getty.target - Login Prompts. Oct 29 23:39:21.562127 systemd-networkd[1412]: eth0: Gained IPv6LL Oct 29 23:39:21.569077 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 29 23:39:21.570972 systemd[1]: Reached target network-online.target - Network is Online. Oct 29 23:39:21.575428 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 29 23:39:21.577647 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 29 23:39:21.619192 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 29 23:39:21.621090 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 29 23:39:21.622022 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 29 23:39:21.626842 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 29 23:39:21.627354 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 29 23:39:21.634053 systemd[1]: Startup finished in 1.176s (kernel) + 3.971s (initrd) + 2.634s (userspace) = 7.783s. Oct 29 23:39:26.356684 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 29 23:39:26.357826 systemd[1]: Started sshd@0-10.0.0.90:22-10.0.0.1:59014.service - OpenSSH per-connection server daemon (10.0.0.1:59014). Oct 29 23:39:26.420627 sshd[1597]: Accepted publickey for core from 10.0.0.1 port 59014 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:26.422442 sshd-session[1597]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:26.428773 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 29 23:39:26.429698 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 29 23:39:26.434673 systemd-logind[1482]: New session 1 of user core. Oct 29 23:39:26.448657 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 29 23:39:26.450996 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 29 23:39:26.464985 (systemd)[1602]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 29 23:39:26.467416 systemd-logind[1482]: New session c1 of user core. Oct 29 23:39:26.570788 systemd[1602]: Queued start job for default target default.target. Oct 29 23:39:26.580788 systemd[1602]: Created slice app.slice - User Application Slice. Oct 29 23:39:26.580815 systemd[1602]: Reached target paths.target - Paths. Oct 29 23:39:26.580850 systemd[1602]: Reached target timers.target - Timers. Oct 29 23:39:26.581996 systemd[1602]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 29 23:39:26.590997 systemd[1602]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 29 23:39:26.591056 systemd[1602]: Reached target sockets.target - Sockets. Oct 29 23:39:26.591091 systemd[1602]: Reached target basic.target - Basic System. Oct 29 23:39:26.591118 systemd[1602]: Reached target default.target - Main User Target. Oct 29 23:39:26.591143 systemd[1602]: Startup finished in 117ms. Oct 29 23:39:26.591281 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 29 23:39:26.592690 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 29 23:39:26.654327 systemd[1]: Started sshd@1-10.0.0.90:22-10.0.0.1:59030.service - OpenSSH per-connection server daemon (10.0.0.1:59030). Oct 29 23:39:26.719091 sshd[1613]: Accepted publickey for core from 10.0.0.1 port 59030 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:26.720276 sshd-session[1613]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:26.725750 systemd-logind[1482]: New session 2 of user core. Oct 29 23:39:26.740119 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 29 23:39:26.791977 sshd[1616]: Connection closed by 10.0.0.1 port 59030 Oct 29 23:39:26.792276 sshd-session[1613]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:26.804102 systemd[1]: sshd@1-10.0.0.90:22-10.0.0.1:59030.service: Deactivated successfully. Oct 29 23:39:26.806343 systemd[1]: session-2.scope: Deactivated successfully. Oct 29 23:39:26.808105 systemd-logind[1482]: Session 2 logged out. Waiting for processes to exit. Oct 29 23:39:26.810683 systemd[1]: Started sshd@2-10.0.0.90:22-10.0.0.1:59034.service - OpenSSH per-connection server daemon (10.0.0.1:59034). Oct 29 23:39:26.811332 systemd-logind[1482]: Removed session 2. Oct 29 23:39:26.866178 sshd[1622]: Accepted publickey for core from 10.0.0.1 port 59034 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:26.867487 sshd-session[1622]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:26.872002 systemd-logind[1482]: New session 3 of user core. Oct 29 23:39:26.888143 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 29 23:39:26.936117 sshd[1625]: Connection closed by 10.0.0.1 port 59034 Oct 29 23:39:26.936439 sshd-session[1622]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:26.951039 systemd[1]: sshd@2-10.0.0.90:22-10.0.0.1:59034.service: Deactivated successfully. Oct 29 23:39:26.953395 systemd[1]: session-3.scope: Deactivated successfully. Oct 29 23:39:26.956050 systemd-logind[1482]: Session 3 logged out. Waiting for processes to exit. Oct 29 23:39:26.958067 systemd[1]: Started sshd@3-10.0.0.90:22-10.0.0.1:59038.service - OpenSSH per-connection server daemon (10.0.0.1:59038). Oct 29 23:39:26.958722 systemd-logind[1482]: Removed session 3. Oct 29 23:39:27.016070 sshd[1631]: Accepted publickey for core from 10.0.0.1 port 59038 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:27.017443 sshd-session[1631]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:27.022238 systemd-logind[1482]: New session 4 of user core. Oct 29 23:39:27.040135 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 29 23:39:27.092620 sshd[1634]: Connection closed by 10.0.0.1 port 59038 Oct 29 23:39:27.093180 sshd-session[1631]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:27.107293 systemd[1]: sshd@3-10.0.0.90:22-10.0.0.1:59038.service: Deactivated successfully. Oct 29 23:39:27.108968 systemd[1]: session-4.scope: Deactivated successfully. Oct 29 23:39:27.109568 systemd-logind[1482]: Session 4 logged out. Waiting for processes to exit. Oct 29 23:39:27.112061 systemd[1]: Started sshd@4-10.0.0.90:22-10.0.0.1:59052.service - OpenSSH per-connection server daemon (10.0.0.1:59052). Oct 29 23:39:27.112692 systemd-logind[1482]: Removed session 4. Oct 29 23:39:27.180384 sshd[1640]: Accepted publickey for core from 10.0.0.1 port 59052 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:27.181911 sshd-session[1640]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:27.185826 systemd-logind[1482]: New session 5 of user core. Oct 29 23:39:27.195101 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 29 23:39:27.253723 sudo[1644]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 29 23:39:27.254009 sudo[1644]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 23:39:27.266801 sudo[1644]: pam_unix(sudo:session): session closed for user root Oct 29 23:39:27.268650 sshd[1643]: Connection closed by 10.0.0.1 port 59052 Oct 29 23:39:27.269063 sshd-session[1640]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:27.276553 systemd[1]: sshd@4-10.0.0.90:22-10.0.0.1:59052.service: Deactivated successfully. Oct 29 23:39:27.279032 systemd[1]: session-5.scope: Deactivated successfully. Oct 29 23:39:27.279951 systemd-logind[1482]: Session 5 logged out. Waiting for processes to exit. Oct 29 23:39:27.282398 systemd[1]: Started sshd@5-10.0.0.90:22-10.0.0.1:59062.service - OpenSSH per-connection server daemon (10.0.0.1:59062). Oct 29 23:39:27.282943 systemd-logind[1482]: Removed session 5. Oct 29 23:39:27.336536 sshd[1650]: Accepted publickey for core from 10.0.0.1 port 59062 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:27.337870 sshd-session[1650]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:27.342557 systemd-logind[1482]: New session 6 of user core. Oct 29 23:39:27.353110 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 29 23:39:27.405803 sudo[1655]: 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 29 23:39:27.406467 sudo[1655]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 23:39:27.412191 sudo[1655]: pam_unix(sudo:session): session closed for user root Oct 29 23:39:27.418770 sudo[1654]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Oct 29 23:39:27.419067 sudo[1654]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 23:39:27.429534 systemd[1]: Starting audit-rules.service - Load Audit Rules... Oct 29 23:39:27.475817 augenrules[1677]: No rules Oct 29 23:39:27.477018 systemd[1]: audit-rules.service: Deactivated successfully. Oct 29 23:39:27.478020 systemd[1]: Finished audit-rules.service - Load Audit Rules. Oct 29 23:39:27.479432 sudo[1654]: pam_unix(sudo:session): session closed for user root Oct 29 23:39:27.481854 sshd[1653]: Connection closed by 10.0.0.1 port 59062 Oct 29 23:39:27.481690 sshd-session[1650]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:27.488884 systemd[1]: sshd@5-10.0.0.90:22-10.0.0.1:59062.service: Deactivated successfully. Oct 29 23:39:27.490574 systemd[1]: session-6.scope: Deactivated successfully. Oct 29 23:39:27.491313 systemd-logind[1482]: Session 6 logged out. Waiting for processes to exit. Oct 29 23:39:27.494219 systemd[1]: Started sshd@6-10.0.0.90:22-10.0.0.1:59064.service - OpenSSH per-connection server daemon (10.0.0.1:59064). Oct 29 23:39:27.494809 systemd-logind[1482]: Removed session 6. Oct 29 23:39:27.559930 sshd[1686]: Accepted publickey for core from 10.0.0.1 port 59064 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:27.561215 sshd-session[1686]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:27.565804 systemd-logind[1482]: New session 7 of user core. Oct 29 23:39:27.577132 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 29 23:39:27.631996 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 29 23:39:27.643319 (dockerd)[1691]: 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 29 23:39:27.858168 dockerd[1691]: time="2025-10-29T23:39:27.857994265Z" level=info msg="Starting up" Oct 29 23:39:27.859375 dockerd[1691]: time="2025-10-29T23:39:27.859345850Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 29 23:39:27.870587 dockerd[1691]: time="2025-10-29T23:39:27.870520091Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 29 23:39:27.911439 dockerd[1691]: time="2025-10-29T23:39:27.911392702Z" level=info msg="Loading containers: start." Oct 29 23:39:27.921961 kernel: Initializing XFRM netlink socket Oct 29 23:39:28.118578 systemd-networkd[1412]: docker0: Link UP Oct 29 23:39:28.123383 dockerd[1691]: time="2025-10-29T23:39:28.123320949Z" level=info msg="Loading containers: done." Oct 29 23:39:28.138248 dockerd[1691]: time="2025-10-29T23:39:28.138199511Z" 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 29 23:39:28.138401 dockerd[1691]: time="2025-10-29T23:39:28.138286731Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 29 23:39:28.138401 dockerd[1691]: time="2025-10-29T23:39:28.138367769Z" level=info msg="Initializing buildkit" Oct 29 23:39:28.163905 dockerd[1691]: time="2025-10-29T23:39:28.163865281Z" level=info msg="Completed buildkit initialization" Oct 29 23:39:28.168680 dockerd[1691]: time="2025-10-29T23:39:28.168638496Z" level=info msg="Daemon has completed initialization" Oct 29 23:39:28.168782 dockerd[1691]: time="2025-10-29T23:39:28.168704562Z" level=info msg="API listen on /run/docker.sock" Oct 29 23:39:28.168947 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 29 23:39:28.177071 sshd[1689]: Connection closed by 10.0.0.1 port 59064 Oct 29 23:39:28.177413 sshd-session[1686]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:28.195813 systemd[1]: sshd@6-10.0.0.90:22-10.0.0.1:59064.service: Deactivated successfully. Oct 29 23:39:28.197242 systemd[1]: session-7.scope: Deactivated successfully. Oct 29 23:39:28.197869 systemd-logind[1482]: Session 7 logged out. Waiting for processes to exit. Oct 29 23:39:28.199985 systemd[1]: Started sshd@7-10.0.0.90:22-10.0.0.1:59080.service - OpenSSH per-connection server daemon (10.0.0.1:59080). Oct 29 23:39:28.200407 systemd-logind[1482]: Removed session 7. Oct 29 23:39:28.253515 sshd[1907]: Accepted publickey for core from 10.0.0.1 port 59080 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:28.254750 sshd-session[1907]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:28.259476 systemd-logind[1482]: New session 8 of user core. Oct 29 23:39:28.274094 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 29 23:39:28.883418 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck4279018793-merged.mount: Deactivated successfully. Oct 29 23:39:29.398769 systemd[1]: var-lib-docker-overlay2-6e588ea746085d90cb34656576fa7b61160b9ded0ac9ab6f0de8fbd665bef9a5\x2dinit-merged.mount: Deactivated successfully. Oct 29 23:39:29.427696 systemd[1]: var-lib-docker-overlay2-6e588ea746085d90cb34656576fa7b61160b9ded0ac9ab6f0de8fbd665bef9a5-merged.mount: Deactivated successfully. Oct 29 23:39:29.458772 containerd[1511]: time="2025-10-29T23:39:29.458719416Z" level=info msg="connecting to shim 548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a" address="unix:///run/containerd/s/20b64d86c628a99b71930e62de435c345e091fa2d8f90002c0e78d043078f6e2" namespace=moby protocol=ttrpc version=3 Oct 29 23:39:29.492126 systemd[1]: Started docker-548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a.scope - libcontainer container 548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a. Oct 29 23:39:29.504537 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 29 23:39:29.522436 kernel: docker0: port 1(vethedf67c5) entered blocking state Oct 29 23:39:29.522519 kernel: docker0: port 1(vethedf67c5) entered disabled state Oct 29 23:39:29.522537 kernel: vethedf67c5: entered allmulticast mode Oct 29 23:39:29.523851 systemd-networkd[1412]: vethedf67c5: Link UP Oct 29 23:39:29.524092 kernel: vethedf67c5: entered promiscuous mode Oct 29 23:39:29.535377 kernel: eth0: renamed from veth162f0a7 Oct 29 23:39:29.535458 kernel: docker0: port 1(vethedf67c5) entered blocking state Oct 29 23:39:29.535476 kernel: docker0: port 1(vethedf67c5) entered forwarding state Oct 29 23:39:29.535419 systemd-networkd[1412]: vethedf67c5: Gained carrier Oct 29 23:39:29.535982 systemd-networkd[1412]: docker0: Gained carrier Oct 29 23:39:29.560650 sshd[1910]: Connection closed by 10.0.0.1 port 59080 Oct 29 23:39:29.561036 sshd-session[1907]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:29.568840 systemd[1]: sshd@7-10.0.0.90:22-10.0.0.1:59080.service: Deactivated successfully. Oct 29 23:39:29.570484 systemd[1]: session-8.scope: Deactivated successfully. Oct 29 23:39:29.571268 systemd-logind[1482]: Session 8 logged out. Waiting for processes to exit. Oct 29 23:39:29.573837 systemd[1]: Started sshd@8-10.0.0.90:22-10.0.0.1:39216.service - OpenSSH per-connection server daemon (10.0.0.1:39216). Oct 29 23:39:29.574533 systemd-logind[1482]: Removed session 8. Oct 29 23:39:29.631335 sshd[1985]: Accepted publickey for core from 10.0.0.1 port 39216 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:29.632586 sshd-session[1985]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:29.636998 systemd-logind[1482]: New session 9 of user core. Oct 29 23:39:29.643069 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 29 23:39:29.701476 sshd[1988]: Connection closed by 10.0.0.1 port 39216 Oct 29 23:39:29.701175 sshd-session[1985]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:29.716931 systemd[1]: sshd@8-10.0.0.90:22-10.0.0.1:39216.service: Deactivated successfully. Oct 29 23:39:29.718703 systemd[1]: session-9.scope: Deactivated successfully. Oct 29 23:39:29.719710 systemd-logind[1482]: Session 9 logged out. Waiting for processes to exit. Oct 29 23:39:29.722222 systemd[1]: Started sshd@9-10.0.0.90:22-10.0.0.1:39230.service - OpenSSH per-connection server daemon (10.0.0.1:39230). Oct 29 23:39:29.723578 systemd-logind[1482]: Removed session 9. Oct 29 23:39:29.784369 sshd[1994]: Accepted publickey for core from 10.0.0.1 port 39230 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:29.785654 sshd-session[1994]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:29.790060 systemd-logind[1482]: New session 10 of user core. Oct 29 23:39:29.799321 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 29 23:39:29.852426 sudo[1998]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1511 Oct 29 23:39:29.852685 sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 23:39:29.856892 sudo[1998]: pam_unix(sudo:session): session closed for user root Oct 29 23:39:29.857151 dockerd[1691]: time="2025-10-29T23:39:29.856957100Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 29 23:39:29.857151 dockerd[1691]: time="2025-10-29T23:39:29.856992373Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 29 23:39:29.857151 dockerd[1691]: time="2025-10-29T23:39:29.856961996Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 29 23:39:29.857151 dockerd[1691]: time="2025-10-29T23:39:29.857111356Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 29 23:39:29.858091 containerd[1511]: time="2025-10-29T23:39:29.857019742Z" level=info msg="Stop CRI service" Oct 29 23:39:29.858466 containerd[1511]: time="2025-10-29T23:39:29.858382204Z" level=info msg="Stop CRI service" Oct 29 23:39:29.858466 containerd[1511]: time="2025-10-29T23:39:29.858424019Z" level=info msg="Event monitor stopped" Oct 29 23:39:29.860010 sshd[1997]: Connection closed by 10.0.0.1 port 39230 Oct 29 23:39:29.860398 sshd-session[1994]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:29.874109 systemd[1]: containerd.service: Deactivated successfully. Oct 29 23:39:29.874193 systemd[1]: containerd.service: Unit process 1933 (containerd-shim) remains running after unit stopped. Oct 29 23:39:29.874384 systemd[1]: containerd.service: Consumed 286ms CPU time, 120.1M memory peak. Oct 29 23:39:29.874745 systemd[1]: sshd@9-10.0.0.90:22-10.0.0.1:39230.service: Deactivated successfully. Oct 29 23:39:29.878295 systemd[1]: session-10.scope: Deactivated successfully. Oct 29 23:39:29.878951 systemd-logind[1482]: Session 10 logged out. Waiting for processes to exit. Oct 29 23:39:29.881594 systemd[1]: Started sshd@10-10.0.0.90:22-10.0.0.1:39238.service - OpenSSH per-connection server daemon (10.0.0.1:39238). Oct 29 23:39:29.882052 systemd-logind[1482]: Removed session 10. Oct 29 23:39:29.942675 sshd[2005]: Accepted publickey for core from 10.0.0.1 port 39238 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:29.945221 sshd-session[2005]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:29.956406 systemd-logind[1482]: New session 11 of user core. Oct 29 23:39:29.975213 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 29 23:39:30.035338 sshd[2008]: Connection closed by 10.0.0.1 port 39238 Oct 29 23:39:30.035698 sshd-session[2005]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:30.039178 systemd[1]: sshd@10-10.0.0.90:22-10.0.0.1:39238.service: Deactivated successfully. Oct 29 23:39:30.040809 systemd[1]: session-11.scope: Deactivated successfully. Oct 29 23:39:30.041590 systemd-logind[1482]: Session 11 logged out. Waiting for processes to exit. Oct 29 23:39:30.042537 systemd-logind[1482]: Removed session 11. Oct 29 23:39:30.715186 systemd-networkd[1412]: vethedf67c5: Gained IPv6LL Oct 29 23:39:31.162143 systemd-networkd[1412]: docker0: Gained IPv6LL Oct 29 23:39:35.124746 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Oct 29 23:39:35.125087 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 29 23:39:35.126748 dockerd[1691]: time="2025-10-29T23:39:35.126472583Z" level=info msg="Processing signal 'terminated'" Oct 29 23:39:36.085265 systemd[1]: Started sshd@11-10.0.0.90:22-10.0.0.1:39240.service - OpenSSH per-connection server daemon (10.0.0.1:39240). Oct 29 23:39:36.159565 sshd[2014]: Accepted publickey for core from 10.0.0.1 port 39240 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:36.159444 sshd-session[2014]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:36.164980 systemd-logind[1482]: New session 12 of user core. Oct 29 23:39:36.175159 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 29 23:39:36.232488 sshd[2017]: Connection closed by 10.0.0.1 port 39240 Oct 29 23:39:36.232341 sshd-session[2014]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:36.237961 systemd[1]: sshd@11-10.0.0.90:22-10.0.0.1:39240.service: Deactivated successfully. Oct 29 23:39:36.239484 systemd[1]: session-12.scope: Deactivated successfully. Oct 29 23:39:36.243176 systemd-logind[1482]: Session 12 logged out. Waiting for processes to exit. Oct 29 23:39:36.247259 systemd-logind[1482]: Removed session 12. Oct 29 23:39:42.256042 systemd[1]: Started sshd@12-10.0.0.90:22-10.0.0.1:36586.service - OpenSSH per-connection server daemon (10.0.0.1:36586). Oct 29 23:39:42.311898 sshd[2023]: Accepted publickey for core from 10.0.0.1 port 36586 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:42.313467 sshd-session[2023]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:42.321699 systemd-logind[1482]: New session 13 of user core. Oct 29 23:39:42.329281 systemd[1]: Started session-13.scope - Session 13 of User core. Oct 29 23:39:42.389982 sshd[2026]: Connection closed by 10.0.0.1 port 36586 Oct 29 23:39:42.389575 sshd-session[2023]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:42.393584 systemd[1]: sshd@12-10.0.0.90:22-10.0.0.1:36586.service: Deactivated successfully. Oct 29 23:39:42.393585 systemd-logind[1482]: Session 13 logged out. Waiting for processes to exit. Oct 29 23:39:42.395902 systemd[1]: session-13.scope: Deactivated successfully. Oct 29 23:39:42.399214 systemd-logind[1482]: Removed session 13. Oct 29 23:39:48.413937 systemd[1]: Started sshd@13-10.0.0.90:22-10.0.0.1:36598.service - OpenSSH per-connection server daemon (10.0.0.1:36598). Oct 29 23:39:48.477515 sshd[2032]: Accepted publickey for core from 10.0.0.1 port 36598 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:48.478785 sshd-session[2032]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:48.483819 systemd-logind[1482]: New session 14 of user core. Oct 29 23:39:48.498162 systemd[1]: Started session-14.scope - Session 14 of User core. Oct 29 23:39:48.553037 sshd[2035]: Connection closed by 10.0.0.1 port 36598 Oct 29 23:39:48.553426 sshd-session[2032]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:48.557247 systemd[1]: sshd@13-10.0.0.90:22-10.0.0.1:36598.service: Deactivated successfully. Oct 29 23:39:48.560531 systemd[1]: session-14.scope: Deactivated successfully. Oct 29 23:39:48.561372 systemd-logind[1482]: Session 14 logged out. Waiting for processes to exit. Oct 29 23:39:48.562263 systemd-logind[1482]: Removed session 14. Oct 29 23:39:50.127053 dockerd[1691]: time="2025-10-29T23:39:50.126984809Z" level=error msg="Force shutdown daemon" Oct 29 23:39:50.127445 dockerd[1691]: time="2025-10-29T23:39:50.127112075Z" level=info msg="Daemon shutdown complete" Oct 29 23:39:50.129802 systemd[1]: docker.service: Deactivated successfully. Oct 29 23:39:50.130127 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 29 23:39:50.130194 systemd[1]: docker.service: Consumed 916ms CPU time, 122.9M memory peak. Oct 29 23:39:50.130588 systemd[1]: docker.socket: Deactivated successfully. Oct 29 23:39:50.130845 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 29 23:39:50.130885 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 29 23:39:50.132184 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 29 23:39:50.132332 systemd[1]: containerd.service: Found left-over process 1933 (containerd-shim) in control group while starting unit. Ignoring. Oct 29 23:39:50.132339 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 29 23:39:50.139446 systemd[1]: Starting containerd.service - containerd container runtime... Oct 29 23:39:50.139734 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 29 23:39:50.150843 systemd[1]: containerd.service: Found left-over process 1933 (containerd-shim) in control group while starting unit. Ignoring. Oct 29 23:39:50.150855 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 29 23:39:50.155540 (ntainerd)[2046]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 29 23:39:50.170139 containerd[2046]: time="2025-10-29T23:39:50Z" 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 29 23:39:50.170631 containerd[2046]: time="2025-10-29T23:39:50.170575536Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 29 23:39:50.178259 containerd[2046]: time="2025-10-29T23:39:50.178211405Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.888µs" Oct 29 23:39:50.178679 containerd[2046]: time="2025-10-29T23:39:50.178376142Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 29 23:39:50.178679 containerd[2046]: time="2025-10-29T23:39:50.178402123Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 29 23:39:50.178679 containerd[2046]: time="2025-10-29T23:39:50.178539678Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 29 23:39:50.178679 containerd[2046]: time="2025-10-29T23:39:50.178564018Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 29 23:39:50.178985 containerd[2046]: time="2025-10-29T23:39:50.178961188Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179217 containerd[2046]: time="2025-10-29T23:39:50.179104988Z" 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 29 23:39:50.179291 containerd[2046]: time="2025-10-29T23:39:50.179275249Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179551 containerd[2046]: time="2025-10-29T23:39:50.179530342Z" 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 29 23:39:50.179635 containerd[2046]: time="2025-10-29T23:39:50.179604804Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179689 containerd[2046]: time="2025-10-29T23:39:50.179675462Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179744 containerd[2046]: time="2025-10-29T23:39:50.179731109Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179803 containerd[2046]: time="2025-10-29T23:39:50.179791879Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 29 23:39:50.179975 containerd[2046]: time="2025-10-29T23:39:50.179956056Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 23:39:50.180048 containerd[2046]: time="2025-10-29T23:39:50.180032920Z" 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 29 23:39:50.180094 containerd[2046]: time="2025-10-29T23:39:50.180082681Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 29 23:39:50.180183 containerd[2046]: time="2025-10-29T23:39:50.180167872Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 29 23:39:50.180469 containerd[2046]: time="2025-10-29T23:39:50.180440699Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 29 23:39:50.180536 containerd[2046]: time="2025-10-29T23:39:50.180524648Z" level=info msg="metadata content store policy set" policy=shared Oct 29 23:39:50.180733 containerd[2046]: time="2025-10-29T23:39:50.180712485Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 29 23:39:50.180821 containerd[2046]: time="2025-10-29T23:39:50.180805682Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 29 23:39:50.180888 containerd[2046]: time="2025-10-29T23:39:50.180873218Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 29 23:39:50.180982 containerd[2046]: time="2025-10-29T23:39:50.180964975Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 29 23:39:50.181037 containerd[2046]: time="2025-10-29T23:39:50.181023863Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 29 23:39:50.181087 containerd[2046]: time="2025-10-29T23:39:50.181074185Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 29 23:39:50.181149 containerd[2046]: time="2025-10-29T23:39:50.181136917Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 29 23:39:50.181224 containerd[2046]: time="2025-10-29T23:39:50.181211299Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 29 23:39:50.181337 containerd[2046]: time="2025-10-29T23:39:50.181320430Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 29 23:39:50.181405 containerd[2046]: time="2025-10-29T23:39:50.181390849Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 29 23:39:50.181458 containerd[2046]: time="2025-10-29T23:39:50.181444573Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 29 23:39:50.181524 containerd[2046]: time="2025-10-29T23:39:50.181510468Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 29 23:39:50.181822 containerd[2046]: time="2025-10-29T23:39:50.181798307Z" level=info msg="connecting to shim 548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a" address="unix:///run/containerd/s/20b64d86c628a99b71930e62de435c345e091fa2d8f90002c0e78d043078f6e2" namespace=moby protocol=ttrpc version=3 Oct 29 23:39:50.189643 containerd[2046]: time="2025-10-29T23:39:50.189599434Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 29 23:39:50.189783 containerd[2046]: time="2025-10-29T23:39:50.189764932Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 29 23:39:50.189852 containerd[2046]: time="2025-10-29T23:39:50.189838033Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 29 23:39:50.189900 containerd[2046]: time="2025-10-29T23:39:50.189888875Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 29 23:39:50.189980 containerd[2046]: time="2025-10-29T23:39:50.189966700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 29 23:39:50.190041 containerd[2046]: time="2025-10-29T23:39:50.190028351Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 29 23:39:50.190095 containerd[2046]: time="2025-10-29T23:39:50.190083156Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 29 23:39:50.190150 containerd[2046]: time="2025-10-29T23:39:50.190138162Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 29 23:39:50.190199 containerd[2046]: time="2025-10-29T23:39:50.190189485Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 29 23:39:50.190247 containerd[2046]: time="2025-10-29T23:39:50.190236204Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 29 23:39:50.190296 containerd[2046]: time="2025-10-29T23:39:50.190284204Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 29 23:39:50.190408 containerd[2046]: time="2025-10-29T23:39:50.190392374Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 29 23:39:50.190478 containerd[2046]: time="2025-10-29T23:39:50.190463313Z" level=info msg="Start snapshots syncer" Oct 29 23:39:50.190558 containerd[2046]: time="2025-10-29T23:39:50.190542699Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 29 23:39:50.190863 containerd[2046]: time="2025-10-29T23:39:50.190825854Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 29 23:39:50.191079 containerd[2046]: time="2025-10-29T23:39:50.191060249Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 29 23:39:50.191212 containerd[2046]: time="2025-10-29T23:39:50.191194961Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 29 23:39:50.191309 containerd[2046]: time="2025-10-29T23:39:50.191294284Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 29 23:39:50.191392 containerd[2046]: time="2025-10-29T23:39:50.191376752Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 29 23:39:50.191451 containerd[2046]: time="2025-10-29T23:39:50.191430517Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 29 23:39:50.191505 containerd[2046]: time="2025-10-29T23:39:50.191492809Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 29 23:39:50.191557 containerd[2046]: time="2025-10-29T23:39:50.191544291Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 29 23:39:50.191609 containerd[2046]: time="2025-10-29T23:39:50.191595974Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 29 23:39:50.191683 containerd[2046]: time="2025-10-29T23:39:50.191666953Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 29 23:39:50.191761 containerd[2046]: time="2025-10-29T23:39:50.191746620Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 29 23:39:50.191812 containerd[2046]: time="2025-10-29T23:39:50.191801105Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 29 23:39:50.191863 containerd[2046]: time="2025-10-29T23:39:50.191850906Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 29 23:39:50.191972 containerd[2046]: time="2025-10-29T23:39:50.191956474Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 23:39:50.192032 containerd[2046]: time="2025-10-29T23:39:50.192018085Z" 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 29 23:39:50.192076 containerd[2046]: time="2025-10-29T23:39:50.192065004Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 23:39:50.192139 containerd[2046]: time="2025-10-29T23:39:50.192125094Z" 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 29 23:39:50.192188 containerd[2046]: time="2025-10-29T23:39:50.192176177Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 29 23:39:50.192236 containerd[2046]: time="2025-10-29T23:39:50.192224777Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 29 23:39:50.192284 containerd[2046]: time="2025-10-29T23:39:50.192271736Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 29 23:39:50.192343 containerd[2046]: time="2025-10-29T23:39:50.192332026Z" level=info msg="runtime interface created" Oct 29 23:39:50.192382 containerd[2046]: time="2025-10-29T23:39:50.192372980Z" level=info msg="created NRI interface" Oct 29 23:39:50.192429 containerd[2046]: time="2025-10-29T23:39:50.192416737Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 29 23:39:50.192484 containerd[2046]: time="2025-10-29T23:39:50.192472543Z" level=info msg="Connect containerd service" Oct 29 23:39:50.192555 containerd[2046]: time="2025-10-29T23:39:50.192542521Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 29 23:39:50.193205 containerd[2046]: time="2025-10-29T23:39:50.193174847Z" 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 29 23:39:50.204714 containerd[2046]: time="2025-10-29T23:39:50.204653192Z" level=info msg="Start subscribing containerd event" Oct 29 23:39:50.204820 containerd[2046]: time="2025-10-29T23:39:50.204726613Z" level=info msg="Start recovering state" Oct 29 23:39:50.204820 containerd[2046]: time="2025-10-29T23:39:50.204780858Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 29 23:39:50.204820 containerd[2046]: time="2025-10-29T23:39:50.204810522Z" level=info msg="Start event monitor" Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204824854Z" level=info msg="Start cni network conf syncer for default" Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204826816Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204833261Z" level=info msg="Start streaming server" Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204866489Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204873375Z" level=info msg="runtime interface starting up..." Oct 29 23:39:50.204880 containerd[2046]: time="2025-10-29T23:39:50.204878699Z" level=info msg="starting plugins..." Oct 29 23:39:50.204989 containerd[2046]: time="2025-10-29T23:39:50.204888307Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 29 23:39:50.205462 systemd[1]: Started containerd.service - containerd container runtime. Oct 29 23:39:50.206217 containerd[2046]: time="2025-10-29T23:39:50.205332637Z" level=info msg="containerd successfully booted in 0.035364s" Oct 29 23:39:50.207837 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 29 23:39:50.220195 (dockerd)[2076]: 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 29 23:39:50.262927 dockerd[2076]: time="2025-10-29T23:39:50.262860552Z" level=info msg="Starting up" Oct 29 23:39:50.264484 dockerd[2076]: time="2025-10-29T23:39:50.264458160Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 29 23:39:50.277457 dockerd[2076]: time="2025-10-29T23:39:50.277412492Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 29 23:39:50.335157 dockerd[2076]: time="2025-10-29T23:39:50.335109268Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 29 23:39:50.343103 dockerd[2076]: time="2025-10-29T23:39:50.342897384Z" level=info msg="Loading containers: start." Oct 29 23:39:54.573056 systemd[1]: Started sshd@14-10.0.0.90:22-10.0.0.1:54754.service - OpenSSH per-connection server daemon (10.0.0.1:54754). Oct 29 23:39:54.638728 sshd[2110]: Accepted publickey for core from 10.0.0.1 port 54754 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:54.640041 sshd-session[2110]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:54.646414 systemd-logind[1482]: New session 15 of user core. Oct 29 23:39:54.653093 systemd[1]: Started session-15.scope - Session 15 of User core. Oct 29 23:39:54.706664 sshd[2113]: Connection closed by 10.0.0.1 port 54754 Oct 29 23:39:54.706587 sshd-session[2110]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:54.724982 systemd[1]: sshd@14-10.0.0.90:22-10.0.0.1:54754.service: Deactivated successfully. Oct 29 23:39:54.728464 systemd[1]: session-15.scope: Deactivated successfully. Oct 29 23:39:54.729288 systemd-logind[1482]: Session 15 logged out. Waiting for processes to exit. Oct 29 23:39:54.731849 systemd[1]: Started sshd@15-10.0.0.90:22-10.0.0.1:54756.service - OpenSSH per-connection server daemon (10.0.0.1:54756). Oct 29 23:39:54.735507 systemd-logind[1482]: Removed session 15. Oct 29 23:39:54.801305 sshd[2119]: Accepted publickey for core from 10.0.0.1 port 54756 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:54.802523 sshd-session[2119]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:54.806600 systemd-logind[1482]: New session 16 of user core. Oct 29 23:39:54.816068 systemd[1]: Started session-16.scope - Session 16 of User core. Oct 29 23:39:54.870599 sshd[2122]: Connection closed by 10.0.0.1 port 54756 Oct 29 23:39:54.870616 sshd-session[2119]: pam_unix(sshd:session): session closed for user core Oct 29 23:39:54.886868 systemd[1]: sshd@15-10.0.0.90:22-10.0.0.1:54756.service: Deactivated successfully. Oct 29 23:39:54.890212 systemd[1]: session-16.scope: Deactivated successfully. Oct 29 23:39:54.890854 systemd-logind[1482]: Session 16 logged out. Waiting for processes to exit. Oct 29 23:39:54.892894 systemd[1]: Started sshd@16-10.0.0.90:22-10.0.0.1:54758.service - OpenSSH per-connection server daemon (10.0.0.1:54758). Oct 29 23:39:54.896841 systemd-logind[1482]: Removed session 16. Oct 29 23:39:54.959127 sshd[2128]: Accepted publickey for core from 10.0.0.1 port 54758 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:39:54.960320 sshd-session[2128]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:39:54.964060 systemd-logind[1482]: New session 17 of user core. Oct 29 23:39:54.974144 systemd[1]: Started session-17.scope - Session 17 of User core. Oct 29 23:40:00.368537 dockerd[2076]: time="2025-10-29T23:40:00.368023903Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a Oct 29 23:40:00.381011 systemd[1]: docker-548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a.scope: Deactivated successfully. Oct 29 23:40:00.394688 dockerd[2076]: time="2025-10-29T23:40:00.394625709Z" level=info msg="ignoring event" container=548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Oct 29 23:40:00.395374 containerd[2046]: time="2025-10-29T23:40:00.395092993Z" level=info msg="shim disconnected" id=548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a namespace=moby Oct 29 23:40:00.395374 containerd[2046]: time="2025-10-29T23:40:00.395119924Z" level=warning msg="cleaning up after shim disconnected" id=548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a namespace=moby Oct 29 23:40:00.395374 containerd[2046]: time="2025-10-29T23:40:00.395147416Z" level=info msg="cleaning up dead shim" namespace=moby Oct 29 23:40:00.414510 systemd[1]: var-lib-docker-overlay2-6e588ea746085d90cb34656576fa7b61160b9ded0ac9ab6f0de8fbd665bef9a5-merged.mount: Deactivated successfully. Oct 29 23:40:00.873537 dockerd[2076]: time="2025-10-29T23:40:00.872642813Z" level=info msg="Removing stale sandbox a8e59f0a1335b996c5d8ed72b5389d8cdffbd9b157be8373d8aa28a6242d3e06 (548cdc6ee607370e1e68213727c85b1cf9b7d205c746547598e515c4407f626a)" Oct 29 23:40:00.872996 systemd[1]: run-docker-netns-a8e59f0a1335.mount: Deactivated successfully. Oct 29 23:40:00.878129 kernel: docker0: port 1(vethedf67c5) entered disabled state Oct 29 23:40:00.877243 systemd-networkd[1412]: vethedf67c5: Link DOWN Oct 29 23:40:00.877248 systemd-networkd[1412]: vethedf67c5: Lost carrier Oct 29 23:40:00.880950 dockerd[2076]: time="2025-10-29T23:40:00.880875124Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 29 23:40:00.881194 dockerd[2076]: time="2025-10-29T23:40:00.881083215Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 76210a2841ef388084657b31e03d217410efce35a5e111d124d3a0e36d6d70ea d3410ea04e040302010e2bc7029daf55a99f16a1c8967582cdb3b4337edd6126], retrying...." Oct 29 23:40:00.881729 kernel: vethedf67c5 (unregistering): left allmulticast mode Oct 29 23:40:00.881772 kernel: vethedf67c5 (unregistering): left promiscuous mode Oct 29 23:40:00.881789 kernel: docker0: port 1(vethedf67c5) entered disabled state Oct 29 23:40:00.884758 systemd-networkd[1412]: docker0: Lost carrier Oct 29 23:40:00.889073 systemd[1]: run-docker-netns-a8e59f0a1335.mount: Deactivated successfully. Oct 29 23:40:01.076068 dockerd[2076]: time="2025-10-29T23:40:01.075961029Z" level=warning msg="error locating sandbox id a8e59f0a1335b996c5d8ed72b5389d8cdffbd9b157be8373d8aa28a6242d3e06: sandbox a8e59f0a1335b996c5d8ed72b5389d8cdffbd9b157be8373d8aa28a6242d3e06 not found" Oct 29 23:40:01.076068 dockerd[2076]: time="2025-10-29T23:40:01.076042262Z" level=info msg="Loading containers: done." Oct 29 23:40:01.099514 dockerd[2076]: time="2025-10-29T23:40:01.099470565Z" 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 29 23:40:01.099658 dockerd[2076]: time="2025-10-29T23:40:01.099545075Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 29 23:40:01.099658 dockerd[2076]: time="2025-10-29T23:40:01.099577089Z" level=info msg="Initializing buildkit" Oct 29 23:40:01.111137 dockerd[2076]: time="2025-10-29T23:40:01.111089557Z" level=info msg="Completed buildkit initialization" Oct 29 23:40:01.117529 dockerd[2076]: time="2025-10-29T23:40:01.117487094Z" level=info msg="Daemon has completed initialization" Oct 29 23:40:01.118363 dockerd[2076]: time="2025-10-29T23:40:01.117634194Z" level=info msg="API listen on /run/docker.sock" Oct 29 23:40:01.118168 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 29 23:40:01.125985 sshd[2132]: Connection closed by 10.0.0.1 port 54758 Oct 29 23:40:01.125812 sshd-session[2128]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:01.134575 systemd[1]: sshd@16-10.0.0.90:22-10.0.0.1:54758.service: Deactivated successfully. Oct 29 23:40:01.137371 systemd[1]: session-17.scope: Deactivated successfully. Oct 29 23:40:01.141484 systemd-logind[1482]: Session 17 logged out. Waiting for processes to exit. Oct 29 23:40:01.143769 systemd[1]: Started sshd@17-10.0.0.90:22-10.0.0.1:52040.service - OpenSSH per-connection server daemon (10.0.0.1:52040). Oct 29 23:40:01.146495 systemd-logind[1482]: Removed session 17. Oct 29 23:40:01.209581 sshd[2384]: Accepted publickey for core from 10.0.0.1 port 52040 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:01.210696 sshd-session[2384]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:01.218052 systemd-logind[1482]: New session 18 of user core. Oct 29 23:40:01.229084 systemd[1]: Started session-18.scope - Session 18 of User core. Oct 29 23:40:01.363399 containerd[2046]: time="2025-10-29T23:40:01.363335930Z" level=info msg="connecting to shim 1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845" address="unix:///run/containerd/s/34295208fd000a31565339d3b2f77d7d19c627140b5269cdd6d713cde0941b2a" namespace=moby protocol=ttrpc version=3 Oct 29 23:40:01.400313 systemd[1]: Started docker-1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845.scope - libcontainer container 1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845. Oct 29 23:40:01.410809 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 29 23:40:01.414809 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1093754517-merged.mount: Deactivated successfully. Oct 29 23:40:01.433922 kernel: docker0: port 1(veth8cec8b3) entered blocking state Oct 29 23:40:01.433994 kernel: docker0: port 1(veth8cec8b3) entered disabled state Oct 29 23:40:01.434015 kernel: veth8cec8b3: entered allmulticast mode Oct 29 23:40:01.436075 kernel: veth8cec8b3: entered promiscuous mode Oct 29 23:40:01.436618 systemd-networkd[1412]: veth8cec8b3: Link UP Oct 29 23:40:01.447939 kernel: eth0: renamed from veth79fb82f Oct 29 23:40:01.449770 systemd-networkd[1412]: veth8cec8b3: Gained carrier Oct 29 23:40:01.449953 kernel: docker0: port 1(veth8cec8b3) entered blocking state Oct 29 23:40:01.449980 kernel: docker0: port 1(veth8cec8b3) entered forwarding state Oct 29 23:40:01.450827 systemd-networkd[1412]: docker0: Gained carrier Oct 29 23:40:01.469152 sshd[2387]: Connection closed by 10.0.0.1 port 52040 Oct 29 23:40:01.469635 sshd-session[2384]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:01.480730 systemd[1]: sshd@17-10.0.0.90:22-10.0.0.1:52040.service: Deactivated successfully. Oct 29 23:40:01.482069 systemd[1]: session-18.scope: Deactivated successfully. Oct 29 23:40:01.482703 systemd-logind[1482]: Session 18 logged out. Waiting for processes to exit. Oct 29 23:40:01.486686 systemd[1]: Started sshd@18-10.0.0.90:22-10.0.0.1:52052.service - OpenSSH per-connection server daemon (10.0.0.1:52052). Oct 29 23:40:01.487134 systemd-logind[1482]: Removed session 18. Oct 29 23:40:01.543288 sshd[2455]: Accepted publickey for core from 10.0.0.1 port 52052 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:01.544343 sshd-session[2455]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:01.547977 systemd-logind[1482]: New session 19 of user core. Oct 29 23:40:01.560098 systemd[1]: Started session-19.scope - Session 19 of User core. Oct 29 23:40:01.612699 sshd[2458]: Connection closed by 10.0.0.1 port 52052 Oct 29 23:40:01.613147 sshd-session[2455]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:01.622886 systemd[1]: sshd@18-10.0.0.90:22-10.0.0.1:52052.service: Deactivated successfully. Oct 29 23:40:01.624349 systemd[1]: session-19.scope: Deactivated successfully. Oct 29 23:40:01.626726 systemd-logind[1482]: Session 19 logged out. Waiting for processes to exit. Oct 29 23:40:01.628286 systemd[1]: Started sshd@19-10.0.0.90:22-10.0.0.1:52060.service - OpenSSH per-connection server daemon (10.0.0.1:52060). Oct 29 23:40:01.629265 systemd-logind[1482]: Removed session 19. Oct 29 23:40:01.683093 sshd[2464]: Accepted publickey for core from 10.0.0.1 port 52060 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:01.684393 sshd-session[2464]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:01.688802 systemd-logind[1482]: New session 20 of user core. Oct 29 23:40:01.697065 systemd[1]: Started session-20.scope - Session 20 of User core. Oct 29 23:40:01.749156 sudo[2468]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2046 Oct 29 23:40:01.749431 sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Oct 29 23:40:01.755934 sudo[2468]: pam_unix(sudo:session): session closed for user root Oct 29 23:40:01.758743 dockerd[2076]: time="2025-10-29T23:40:01.758345174Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 29 23:40:01.758743 dockerd[2076]: time="2025-10-29T23:40:01.758374226Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 29 23:40:01.758743 dockerd[2076]: time="2025-10-29T23:40:01.758646337Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 29 23:40:01.758743 dockerd[2076]: time="2025-10-29T23:40:01.758660703Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 29 23:40:01.758064 systemd[1]: containerd.service: Deactivated successfully. Oct 29 23:40:01.758155 systemd[1]: containerd.service: Unit process 2406 (containerd-shim) remains running after unit stopped. Oct 29 23:40:01.758381 systemd[1]: containerd.service: Consumed 179ms CPU time, 123.2M memory peak. Oct 29 23:40:01.760940 sshd[2467]: Connection closed by 10.0.0.1 port 52060 Oct 29 23:40:01.759657 sshd-session[2464]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:01.772890 systemd[1]: sshd@19-10.0.0.90:22-10.0.0.1:52060.service: Deactivated successfully. Oct 29 23:40:01.778314 systemd[1]: session-20.scope: Deactivated successfully. Oct 29 23:40:01.779302 systemd-logind[1482]: Session 20 logged out. Waiting for processes to exit. Oct 29 23:40:01.782151 systemd[1]: Started sshd@20-10.0.0.90:22-10.0.0.1:52072.service - OpenSSH per-connection server daemon (10.0.0.1:52072). Oct 29 23:40:01.784033 systemd-logind[1482]: Removed session 20. Oct 29 23:40:01.849575 sshd[2475]: Accepted publickey for core from 10.0.0.1 port 52072 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:01.847490 sshd-session[2475]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:01.855974 systemd-logind[1482]: New session 21 of user core. Oct 29 23:40:01.868134 systemd[1]: Started session-21.scope - Session 21 of User core. Oct 29 23:40:01.937771 sshd[2478]: Connection closed by 10.0.0.1 port 52072 Oct 29 23:40:01.938096 sshd-session[2475]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:01.946555 systemd-logind[1482]: Session 21 logged out. Waiting for processes to exit. Oct 29 23:40:01.949005 systemd[1]: sshd@20-10.0.0.90:22-10.0.0.1:52072.service: Deactivated successfully. Oct 29 23:40:01.950902 systemd[1]: session-21.scope: Deactivated successfully. Oct 29 23:40:01.952259 systemd-logind[1482]: Removed session 21. Oct 29 23:40:02.842169 systemd-networkd[1412]: veth8cec8b3: Gained IPv6LL Oct 29 23:40:05.855695 update_engine[1484]: I20251029 23:40:05.855221 1484 update_attempter.cc:509] Updating boot flags... Oct 29 23:40:06.877013 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Oct 29 23:40:06.877338 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 29 23:40:06.877699 dockerd[2076]: time="2025-10-29T23:40:06.877425274Z" level=info msg="Processing signal 'terminated'" Oct 29 23:40:07.950726 systemd[1]: Started sshd@21-10.0.0.90:22-10.0.0.1:52086.service - OpenSSH per-connection server daemon (10.0.0.1:52086). Oct 29 23:40:08.015063 sshd[2500]: Accepted publickey for core from 10.0.0.1 port 52086 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:08.016392 sshd-session[2500]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:08.021186 systemd-logind[1482]: New session 22 of user core. Oct 29 23:40:08.027117 systemd[1]: Started session-22.scope - Session 22 of User core. Oct 29 23:40:08.082739 sshd[2503]: Connection closed by 10.0.0.1 port 52086 Oct 29 23:40:08.083107 sshd-session[2500]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:08.086823 systemd-logind[1482]: Session 22 logged out. Waiting for processes to exit. Oct 29 23:40:08.087459 systemd[1]: sshd@21-10.0.0.90:22-10.0.0.1:52086.service: Deactivated successfully. Oct 29 23:40:08.090326 systemd[1]: session-22.scope: Deactivated successfully. Oct 29 23:40:08.091543 systemd-logind[1482]: Removed session 22. Oct 29 23:40:08.878588 dockerd[2076]: time="2025-10-29T23:40:08.878347093Z" level=error msg="Error sending stop (signal 15) to container" container=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 error="Cannot kill container 1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Oct 29 23:40:08.878588 dockerd[2076]: time="2025-10-29T23:40:08.878409909Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 Oct 29 23:40:14.106819 systemd[1]: Started sshd@22-10.0.0.90:22-10.0.0.1:51256.service - OpenSSH per-connection server daemon (10.0.0.1:51256). Oct 29 23:40:14.174207 sshd[2509]: Accepted publickey for core from 10.0.0.1 port 51256 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:14.175345 sshd-session[2509]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:14.180564 systemd-logind[1482]: New session 23 of user core. Oct 29 23:40:14.195112 systemd[1]: Started session-23.scope - Session 23 of User core. Oct 29 23:40:14.248599 sshd[2512]: Connection closed by 10.0.0.1 port 51256 Oct 29 23:40:14.248910 sshd-session[2509]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:14.252329 systemd[1]: sshd@22-10.0.0.90:22-10.0.0.1:51256.service: Deactivated successfully. Oct 29 23:40:14.253710 systemd[1]: session-23.scope: Deactivated successfully. Oct 29 23:40:14.255106 systemd-logind[1482]: Session 23 logged out. Waiting for processes to exit. Oct 29 23:40:14.255833 systemd-logind[1482]: Removed session 23. Oct 29 23:40:18.879015 dockerd[2076]: time="2025-10-29T23:40:18.878929550Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 error="context deadline exceeded" Oct 29 23:40:18.880034 systemd[1]: docker-1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845.scope: Deactivated successfully. Oct 29 23:40:20.264830 systemd[1]: Started sshd@23-10.0.0.90:22-10.0.0.1:36002.service - OpenSSH per-connection server daemon (10.0.0.1:36002). Oct 29 23:40:20.318520 sshd[2519]: Accepted publickey for core from 10.0.0.1 port 36002 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:20.319644 sshd-session[2519]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:20.323664 systemd-logind[1482]: New session 24 of user core. Oct 29 23:40:20.339073 systemd[1]: Started session-24.scope - Session 24 of User core. Oct 29 23:40:20.397124 sshd[2522]: Connection closed by 10.0.0.1 port 36002 Oct 29 23:40:20.397491 sshd-session[2519]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:20.402177 systemd[1]: sshd@23-10.0.0.90:22-10.0.0.1:36002.service: Deactivated successfully. Oct 29 23:40:20.403911 systemd[1]: session-24.scope: Deactivated successfully. Oct 29 23:40:20.406541 systemd-logind[1482]: Session 24 logged out. Waiting for processes to exit. Oct 29 23:40:20.407950 systemd-logind[1482]: Removed session 24. Oct 29 23:40:21.879049 dockerd[2076]: time="2025-10-29T23:40:21.878974181Z" level=error msg="Force shutdown daemon" Oct 29 23:40:21.879404 dockerd[2076]: time="2025-10-29T23:40:21.879198046Z" level=info msg="Daemon shutdown complete" Oct 29 23:40:21.879404 dockerd[2076]: time="2025-10-29T23:40:21.879283496Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Oct 29 23:40:21.882766 systemd[1]: docker.service: Deactivated successfully. Oct 29 23:40:21.883071 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 29 23:40:21.883953 systemd[1]: docker.socket: Deactivated successfully. Oct 29 23:40:21.884269 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 29 23:40:21.884313 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 29 23:40:21.886314 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 29 23:40:21.886500 systemd[1]: containerd.service: Found left-over process 2406 (containerd-shim) in control group while starting unit. Ignoring. Oct 29 23:40:21.886503 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 29 23:40:21.899420 systemd[1]: Starting containerd.service - containerd container runtime... Oct 29 23:40:21.899949 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 29 23:40:21.912431 systemd[1]: containerd.service: Found left-over process 2406 (containerd-shim) in control group while starting unit. Ignoring. Oct 29 23:40:21.912442 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 29 23:40:21.916893 (ntainerd)[2533]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 29 23:40:21.933617 containerd[2533]: time="2025-10-29T23:40:21Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Oct 29 23:40:21.934183 containerd[2533]: time="2025-10-29T23:40:21.934067261Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Oct 29 23:40:21.941775 containerd[2533]: time="2025-10-29T23:40:21.941714921Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.721µs" Oct 29 23:40:21.941775 containerd[2533]: time="2025-10-29T23:40:21.941746805Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Oct 29 23:40:21.941775 containerd[2533]: time="2025-10-29T23:40:21.941763887Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Oct 29 23:40:21.941908 containerd[2533]: time="2025-10-29T23:40:21.941794170Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Oct 29 23:40:21.941908 containerd[2533]: time="2025-10-29T23:40:21.941805332Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Oct 29 23:40:21.942036 containerd[2533]: time="2025-10-29T23:40:21.941998753Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942139 containerd[2533]: time="2025-10-29T23:40:21.942033797Z" 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 29 23:40:21.942139 containerd[2533]: time="2025-10-29T23:40:21.942046119Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942218 containerd[2533]: time="2025-10-29T23:40:21.942204937Z" 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 29 23:40:21.942248 containerd[2533]: time="2025-10-29T23:40:21.942218058Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942248 containerd[2533]: time="2025-10-29T23:40:21.942228219Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942248 containerd[2533]: time="2025-10-29T23:40:21.942235580Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942302 containerd[2533]: time="2025-10-29T23:40:21.942256462Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942344 containerd[2533]: time="2025-10-29T23:40:21.942325630Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Oct 29 23:40:21.942371 containerd[2533]: time="2025-10-29T23:40:21.942353153Z" 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 29 23:40:21.942371 containerd[2533]: time="2025-10-29T23:40:21.942362034Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Oct 29 23:40:21.942408 containerd[2533]: time="2025-10-29T23:40:21.942393278Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Oct 29 23:40:21.942959 containerd[2533]: time="2025-10-29T23:40:21.942887733Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Oct 29 23:40:21.943114 containerd[2533]: time="2025-10-29T23:40:21.943083635Z" level=info msg="metadata content store policy set" policy=shared Oct 29 23:40:21.943331 containerd[2533]: time="2025-10-29T23:40:21.943269536Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Oct 29 23:40:21.943331 containerd[2533]: time="2025-10-29T23:40:21.943312381Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Oct 29 23:40:21.943331 containerd[2533]: time="2025-10-29T23:40:21.943331943Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943348305Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943361387Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943376308Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943392990Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943408832Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Oct 29 23:40:21.943426 containerd[2533]: time="2025-10-29T23:40:21.943422794Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Oct 29 23:40:21.943535 containerd[2533]: time="2025-10-29T23:40:21.943433355Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Oct 29 23:40:21.943535 containerd[2533]: time="2025-10-29T23:40:21.943446356Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Oct 29 23:40:21.943535 containerd[2533]: time="2025-10-29T23:40:21.943461598Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Oct 29 23:40:21.944204 containerd[2533]: time="2025-10-29T23:40:21.943694504Z" level=info msg="connecting to shim 1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845" address="unix:///run/containerd/s/34295208fd000a31565339d3b2f77d7d19c627140b5269cdd6d713cde0941b2a" namespace=moby protocol=ttrpc version=3 Oct 29 23:40:21.950413 containerd[2533]: time="2025-10-29T23:40:21.950381977Z" level=info msg="cleaning leaked shim process" id=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 namespace=moby Oct 29 23:40:21.960049 containerd[2533]: time="2025-10-29T23:40:21.959962255Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Oct 29 23:40:21.960334 containerd[2533]: time="2025-10-29T23:40:21.960305694Z" level=info msg="shim disconnected" id=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 namespace=moby Oct 29 23:40:21.960384 containerd[2533]: time="2025-10-29T23:40:21.960333817Z" level=warning msg="cleaning up after shim disconnected" id=1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845 namespace=moby Oct 29 23:40:21.960384 containerd[2533]: time="2025-10-29T23:40:21.960370261Z" level=info msg="cleaning up dead shim" namespace=moby Oct 29 23:40:21.973543 containerd[2533]: time="2025-10-29T23:40:21.973488897Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Oct 29 23:40:21.973543 containerd[2533]: time="2025-10-29T23:40:21.973541263Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973560185Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973572467Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973584228Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973594669Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973605830Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973622272Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973633713Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973644595Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Oct 29 23:40:21.973665 containerd[2533]: time="2025-10-29T23:40:21.973654836Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Oct 29 23:40:21.973827 containerd[2533]: time="2025-10-29T23:40:21.973717563Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Oct 29 23:40:21.973827 containerd[2533]: time="2025-10-29T23:40:21.973733445Z" level=info msg="Start snapshots syncer" Oct 29 23:40:21.973827 containerd[2533]: time="2025-10-29T23:40:21.973763608Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Oct 29 23:40:21.974128 containerd[2533]: time="2025-10-29T23:40:21.974050080Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Oct 29 23:40:21.974211 containerd[2533]: time="2025-10-29T23:40:21.974176495Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Oct 29 23:40:21.974281 containerd[2533]: time="2025-10-29T23:40:21.974257544Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974303909Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974326231Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974337433Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974348434Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974362756Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Oct 29 23:40:21.974484 containerd[2533]: time="2025-10-29T23:40:21.974373717Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Oct 29 23:40:21.974618 containerd[2533]: time="2025-10-29T23:40:21.974417082Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Oct 29 23:40:21.974664 containerd[2533]: time="2025-10-29T23:40:21.974637426Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Oct 29 23:40:21.974664 containerd[2533]: time="2025-10-29T23:40:21.974661229Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974672990Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974709195Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974722956Z" 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 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974733157Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974742318Z" 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 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974751439Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974765001Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974776442Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974791204Z" level=info msg="runtime interface created" Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974795924Z" level=info msg="created NRI interface" Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974817567Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974830048Z" level=info msg="Connect containerd service" Oct 29 23:40:21.974884 containerd[2533]: time="2025-10-29T23:40:21.974854971Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 29 23:40:21.975449 containerd[2533]: time="2025-10-29T23:40:21.975418674Z" 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 29 23:40:21.984186 containerd[2533]: time="2025-10-29T23:40:21.984146537Z" level=info msg="Start subscribing containerd event" Oct 29 23:40:21.984186 containerd[2533]: time="2025-10-29T23:40:21.984201223Z" level=info msg="Start recovering state" Oct 29 23:40:21.984323 containerd[2533]: time="2025-10-29T23:40:21.984273431Z" level=info msg="Start event monitor" Oct 29 23:40:21.984323 containerd[2533]: time="2025-10-29T23:40:21.984288513Z" level=info msg="Start cni network conf syncer for default" Oct 29 23:40:21.984323 containerd[2533]: time="2025-10-29T23:40:21.984298434Z" level=info msg="Start streaming server" Oct 29 23:40:21.984323 containerd[2533]: time="2025-10-29T23:40:21.984309155Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Oct 29 23:40:21.984323 containerd[2533]: time="2025-10-29T23:40:21.984316156Z" level=info msg="runtime interface starting up..." Oct 29 23:40:21.984514 containerd[2533]: time="2025-10-29T23:40:21.984317316Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 29 23:40:21.984514 containerd[2533]: time="2025-10-29T23:40:21.984323356Z" level=info msg="starting plugins..." Oct 29 23:40:21.984514 containerd[2533]: time="2025-10-29T23:40:21.984382203Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Oct 29 23:40:21.984514 containerd[2533]: time="2025-10-29T23:40:21.984369082Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 29 23:40:21.984785 containerd[2533]: time="2025-10-29T23:40:21.984771647Z" level=info msg="containerd successfully booted in 0.051514s" Oct 29 23:40:21.984892 systemd[1]: Started containerd.service - containerd container runtime. Oct 29 23:40:21.987157 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 29 23:40:22.002244 (dockerd)[2581]: 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 29 23:40:22.036609 dockerd[2581]: time="2025-10-29T23:40:22.036554504Z" level=info msg="Starting up" Oct 29 23:40:22.037148 dockerd[2581]: time="2025-10-29T23:40:22.037128004Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Oct 29 23:40:22.047835 dockerd[2581]: time="2025-10-29T23:40:22.047805291Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Oct 29 23:40:22.074688 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck1485201902-merged.mount: Deactivated successfully. Oct 29 23:40:22.076670 dockerd[2581]: time="2025-10-29T23:40:22.076628292Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 29 23:40:22.084086 dockerd[2581]: time="2025-10-29T23:40:22.084057515Z" level=info msg="Loading containers: start." Oct 29 23:40:22.099175 systemd[1]: var-lib-docker-overlay2-fadc7f00d73432ca2d086987479e31def23cc1583b8fecdefb2722c2427b4cad-merged.mount: Deactivated successfully. Oct 29 23:40:22.524711 systemd-networkd[1412]: veth8cec8b3: Link DOWN Oct 29 23:40:22.524720 systemd-networkd[1412]: veth8cec8b3: Lost carrier Oct 29 23:40:22.525988 kernel: docker0: port 1(veth8cec8b3) entered disabled state Oct 29 23:40:22.526076 kernel: veth8cec8b3 (unregistering): left allmulticast mode Oct 29 23:40:22.527536 kernel: veth8cec8b3 (unregistering): left promiscuous mode Oct 29 23:40:22.527573 kernel: docker0: port 1(veth8cec8b3) entered disabled state Oct 29 23:40:22.530250 systemd-networkd[1412]: docker0: Lost carrier Oct 29 23:40:22.531728 dockerd[2581]: time="2025-10-29T23:40:22.531680181Z" level=info msg="Removing stale sandbox 34f061c17def071d72e18c08a6051b08801b383106bb27a160716ebd8df8bc7f (1d4058934ce9cdce8eeadfbe6c9bfee190eaaaa39ad99491cae57577ef6b0845)" Oct 29 23:40:22.614607 dockerd[2581]: time="2025-10-29T23:40:22.614542684Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Oct 29 23:40:22.614607 dockerd[2581]: time="2025-10-29T23:40:22.614611691Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint a93fdd054edff3b67bcadf679c6532dfb3a6e54a403040f67490861da46db012 2670682b792c81a5705a1b6af16bd99e9099f209e0fe9d2efce419e7911aa7f0], retrying...." Oct 29 23:40:22.798685 dockerd[2581]: time="2025-10-29T23:40:22.798453327Z" level=warning msg="error locating sandbox id a8e59f0a1335b996c5d8ed72b5389d8cdffbd9b157be8373d8aa28a6242d3e06: sandbox a8e59f0a1335b996c5d8ed72b5389d8cdffbd9b157be8373d8aa28a6242d3e06 not found" Oct 29 23:40:22.798685 dockerd[2581]: time="2025-10-29T23:40:22.798528495Z" level=warning msg="error locating sandbox id 34f061c17def071d72e18c08a6051b08801b383106bb27a160716ebd8df8bc7f: sandbox 34f061c17def071d72e18c08a6051b08801b383106bb27a160716ebd8df8bc7f not found" Oct 29 23:40:22.798685 dockerd[2581]: time="2025-10-29T23:40:22.798596702Z" level=info msg="Loading containers: done." Oct 29 23:40:22.810528 dockerd[2581]: time="2025-10-29T23:40:22.810481396Z" 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 29 23:40:22.810693 dockerd[2581]: time="2025-10-29T23:40:22.810562564Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Oct 29 23:40:22.810693 dockerd[2581]: time="2025-10-29T23:40:22.810593768Z" level=info msg="Initializing buildkit" Oct 29 23:40:22.822435 dockerd[2581]: time="2025-10-29T23:40:22.822400733Z" level=info msg="Completed buildkit initialization" Oct 29 23:40:22.829007 dockerd[2581]: time="2025-10-29T23:40:22.828971066Z" level=info msg="Daemon has completed initialization" Oct 29 23:40:22.829101 dockerd[2581]: time="2025-10-29T23:40:22.829036873Z" level=info msg="API listen on /run/docker.sock" Oct 29 23:40:22.829220 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 29 23:40:23.057042 systemd[1]: run-docker-netns-34f061c17def.mount: Deactivated successfully. Oct 29 23:40:26.413762 systemd[1]: Started sshd@24-10.0.0.90:22-10.0.0.1:36004.service - OpenSSH per-connection server daemon (10.0.0.1:36004). Oct 29 23:40:26.463402 sshd[2818]: Accepted publickey for core from 10.0.0.1 port 36004 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:26.464677 sshd-session[2818]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:26.469013 systemd-logind[1482]: New session 25 of user core. Oct 29 23:40:26.479139 systemd[1]: Started session-25.scope - Session 25 of User core. Oct 29 23:40:26.533458 sshd[2821]: Connection closed by 10.0.0.1 port 36004 Oct 29 23:40:26.534061 sshd-session[2818]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:26.544883 systemd[1]: sshd@24-10.0.0.90:22-10.0.0.1:36004.service: Deactivated successfully. Oct 29 23:40:26.546546 systemd[1]: session-25.scope: Deactivated successfully. Oct 29 23:40:26.549134 systemd-logind[1482]: Session 25 logged out. Waiting for processes to exit. Oct 29 23:40:26.550755 systemd[1]: Started sshd@25-10.0.0.90:22-10.0.0.1:36006.service - OpenSSH per-connection server daemon (10.0.0.1:36006). Oct 29 23:40:26.551768 systemd-logind[1482]: Removed session 25. Oct 29 23:40:26.621315 sshd[2827]: Accepted publickey for core from 10.0.0.1 port 36006 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:26.622818 sshd-session[2827]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:26.627010 systemd-logind[1482]: New session 26 of user core. Oct 29 23:40:26.643182 systemd[1]: Started session-26.scope - Session 26 of User core. Oct 29 23:40:26.696719 sshd[2830]: Connection closed by 10.0.0.1 port 36006 Oct 29 23:40:26.698105 sshd-session[2827]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:26.706710 systemd[1]: sshd@25-10.0.0.90:22-10.0.0.1:36006.service: Deactivated successfully. Oct 29 23:40:26.709678 systemd[1]: session-26.scope: Deactivated successfully. Oct 29 23:40:26.710690 systemd-logind[1482]: Session 26 logged out. Waiting for processes to exit. Oct 29 23:40:26.714271 systemd[1]: Started sshd@26-10.0.0.90:22-10.0.0.1:36022.service - OpenSSH per-connection server daemon (10.0.0.1:36022). Oct 29 23:40:26.714783 systemd-logind[1482]: Removed session 26. Oct 29 23:40:26.774827 sshd[2836]: Accepted publickey for core from 10.0.0.1 port 36022 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:26.776196 sshd-session[2836]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:26.780192 systemd-logind[1482]: New session 27 of user core. Oct 29 23:40:26.794092 systemd[1]: Started session-27.scope - Session 27 of User core. Oct 29 23:40:26.855742 sshd[2839]: Connection closed by 10.0.0.1 port 36022 Oct 29 23:40:26.856182 sshd-session[2836]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:26.870239 systemd[1]: sshd@26-10.0.0.90:22-10.0.0.1:36022.service: Deactivated successfully. Oct 29 23:40:26.873436 systemd[1]: session-27.scope: Deactivated successfully. Oct 29 23:40:26.874150 systemd-logind[1482]: Session 27 logged out. Waiting for processes to exit. Oct 29 23:40:26.876351 systemd[1]: Started sshd@27-10.0.0.90:22-10.0.0.1:36024.service - OpenSSH per-connection server daemon (10.0.0.1:36024). Oct 29 23:40:26.877393 systemd-logind[1482]: Removed session 27. Oct 29 23:40:26.946276 sshd[2852]: Accepted publickey for core from 10.0.0.1 port 36024 ssh2: RSA SHA256:4Dr3tbK61/FsUQz8dYLzShceLjKIFoQvj0rUu7yBHE4 Oct 29 23:40:26.948330 sshd-session[2852]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Oct 29 23:40:26.952341 systemd-logind[1482]: New session 28 of user core. Oct 29 23:40:26.968169 systemd[1]: Started session-28.scope - Session 28 of User core. Oct 29 23:40:27.038975 systemd[1]: var-lib-docker-overlay2-04b2d8989c70a48fdba4b4317c2c63b988188bf13ad3e0b7b345fde8c2b21a30\x2dinit-merged.mount: Deactivated successfully. Oct 29 23:40:27.082720 containerd[2533]: time="2025-10-29T23:40:27.082651557Z" level=info msg="connecting to shim cfab5e090ba899fb469a4aaa0b9ba3d90c6af8982040d28167e4a796d5b767b3" address="unix:///run/containerd/s/03b9fff01459967369436f183c75699375c3a55f01335ff466d0aabcb50ee507" namespace=moby protocol=ttrpc version=3 Oct 29 23:40:27.109315 systemd[1]: Started docker-cfab5e090ba899fb469a4aaa0b9ba3d90c6af8982040d28167e4a796d5b767b3.scope - libcontainer container cfab5e090ba899fb469a4aaa0b9ba3d90c6af8982040d28167e4a796d5b767b3. Oct 29 23:40:27.123010 systemd-resolved[1277]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 29 23:40:27.139414 kernel: docker0: port 1(veth427d437) entered blocking state Oct 29 23:40:27.139512 kernel: docker0: port 1(veth427d437) entered disabled state Oct 29 23:40:27.139529 kernel: veth427d437: entered allmulticast mode Oct 29 23:40:27.139549 kernel: veth427d437: entered promiscuous mode Oct 29 23:40:27.141487 systemd-networkd[1412]: veth427d437: Link UP Oct 29 23:40:27.149944 kernel: eth0: renamed from vethfb4acf7 Oct 29 23:40:27.151730 systemd-networkd[1412]: veth427d437: Gained carrier Oct 29 23:40:27.151942 kernel: docker0: port 1(veth427d437) entered blocking state Oct 29 23:40:27.151989 kernel: docker0: port 1(veth427d437) entered forwarding state Oct 29 23:40:27.152025 systemd-networkd[1412]: docker0: Gained carrier Oct 29 23:40:27.171665 sshd[2855]: Connection closed by 10.0.0.1 port 36024 Oct 29 23:40:27.172045 sshd-session[2852]: pam_unix(sshd:session): session closed for user core Oct 29 23:40:27.177647 systemd[1]: sshd@27-10.0.0.90:22-10.0.0.1:36024.service: Deactivated successfully. Oct 29 23:40:27.180037 systemd[1]: session-28.scope: Deactivated successfully. Oct 29 23:40:27.180788 systemd-logind[1482]: Session 28 logged out. Waiting for processes to exit. Oct 29 23:40:27.181752 systemd-logind[1482]: Removed session 28. Oct 29 23:40:28.378265 systemd-networkd[1412]: veth427d437: Gained IPv6LL