Sep 5 05:42:30.732163 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 5 05:42:30.732191 kernel: Linux version 6.12.44-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p4) 2.44.0) #1 SMP PREEMPT Fri Sep 5 04:25:57 -00 2025 Sep 5 05:42:30.732200 kernel: KASLR enabled Sep 5 05:42:30.732205 kernel: efi: EFI v2.7 by EDK II Sep 5 05:42:30.732211 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Sep 5 05:42:30.732216 kernel: random: crng init done Sep 5 05:42:30.732223 kernel: secureboot: Secure boot disabled Sep 5 05:42:30.732228 kernel: ACPI: Early table checksum verification disabled Sep 5 05:42:30.732234 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Sep 5 05:42:30.732241 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 5 05:42:30.732247 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732253 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732259 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732265 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732272 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732279 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732337 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732343 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732350 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 5 05:42:30.732356 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 5 05:42:30.732362 kernel: ACPI: Use ACPI SPCR as default console: No Sep 5 05:42:30.732368 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:42:30.732374 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Sep 5 05:42:30.732380 kernel: Zone ranges: Sep 5 05:42:30.732387 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:42:30.732395 kernel: DMA32 empty Sep 5 05:42:30.732401 kernel: Normal empty Sep 5 05:42:30.732407 kernel: Device empty Sep 5 05:42:30.732413 kernel: Movable zone start for each node Sep 5 05:42:30.732419 kernel: Early memory node ranges Sep 5 05:42:30.732425 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Sep 5 05:42:30.732431 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Sep 5 05:42:30.732437 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Sep 5 05:42:30.732443 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Sep 5 05:42:30.732449 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Sep 5 05:42:30.732455 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Sep 5 05:42:30.732461 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Sep 5 05:42:30.732469 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Sep 5 05:42:30.732475 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Sep 5 05:42:30.732481 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 5 05:42:30.732489 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 5 05:42:30.732496 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 5 05:42:30.732502 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 5 05:42:30.732510 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 5 05:42:30.732516 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 5 05:42:30.732522 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Sep 5 05:42:30.732529 kernel: psci: probing for conduit method from ACPI. Sep 5 05:42:30.732535 kernel: psci: PSCIv1.1 detected in firmware. Sep 5 05:42:30.732542 kernel: psci: Using standard PSCI v0.2 function IDs Sep 5 05:42:30.732551 kernel: psci: Trusted OS migration not required Sep 5 05:42:30.732559 kernel: psci: SMC Calling Convention v1.1 Sep 5 05:42:30.732566 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 5 05:42:30.732573 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Sep 5 05:42:30.732581 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Sep 5 05:42:30.732588 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 5 05:42:30.732594 kernel: Detected PIPT I-cache on CPU0 Sep 5 05:42:30.732602 kernel: CPU features: detected: GIC system register CPU interface Sep 5 05:42:30.732611 kernel: CPU features: detected: Spectre-v4 Sep 5 05:42:30.732617 kernel: CPU features: detected: Spectre-BHB Sep 5 05:42:30.732624 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 5 05:42:30.732631 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 5 05:42:30.732637 kernel: CPU features: detected: ARM erratum 1418040 Sep 5 05:42:30.732644 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 5 05:42:30.732651 kernel: alternatives: applying boot alternatives Sep 5 05:42:30.732658 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=ad0560d5d82b42c8405832aa39f4f52a20b919c503afe4e7ecc72adb2e451fae Sep 5 05:42:30.732666 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 5 05:42:30.732673 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 5 05:42:30.732681 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 5 05:42:30.732687 kernel: Fallback order for Node 0: 0 Sep 5 05:42:30.732693 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Sep 5 05:42:30.732700 kernel: Policy zone: DMA Sep 5 05:42:30.732706 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 5 05:42:30.732713 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Sep 5 05:42:30.732719 kernel: software IO TLB: area num 4. Sep 5 05:42:30.732726 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Sep 5 05:42:30.732732 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Sep 5 05:42:30.732746 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 5 05:42:30.732753 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 5 05:42:30.732760 kernel: rcu: RCU event tracing is enabled. Sep 5 05:42:30.732767 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 5 05:42:30.732773 kernel: Trampoline variant of Tasks RCU enabled. Sep 5 05:42:30.732780 kernel: Tracing variant of Tasks RCU enabled. Sep 5 05:42:30.732787 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 5 05:42:30.732793 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 5 05:42:30.732800 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 05:42:30.732807 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 5 05:42:30.732813 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 5 05:42:30.732821 kernel: GICv3: 256 SPIs implemented Sep 5 05:42:30.732828 kernel: GICv3: 0 Extended SPIs implemented Sep 5 05:42:30.732834 kernel: Root IRQ handler: gic_handle_irq Sep 5 05:42:30.732841 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 5 05:42:30.732847 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 5 05:42:30.732853 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 5 05:42:30.732860 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 5 05:42:30.732866 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Sep 5 05:42:30.732873 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Sep 5 05:42:30.732880 kernel: GICv3: using LPI property table @0x0000000040130000 Sep 5 05:42:30.732886 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Sep 5 05:42:30.732893 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 5 05:42:30.732900 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:42:30.732906 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 5 05:42:30.732913 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 5 05:42:30.732920 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 5 05:42:30.732926 kernel: arm-pv: using stolen time PV Sep 5 05:42:30.732933 kernel: Console: colour dummy device 80x25 Sep 5 05:42:30.732940 kernel: ACPI: Core revision 20240827 Sep 5 05:42:30.732946 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 5 05:42:30.732953 kernel: pid_max: default: 32768 minimum: 301 Sep 5 05:42:30.732960 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 5 05:42:30.732967 kernel: landlock: Up and running. Sep 5 05:42:30.732974 kernel: SELinux: Initializing. Sep 5 05:42:30.732981 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 05:42:30.732988 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 5 05:42:30.732994 kernel: rcu: Hierarchical SRCU implementation. Sep 5 05:42:30.733001 kernel: rcu: Max phase no-delay instances is 400. Sep 5 05:42:30.733008 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 5 05:42:30.733015 kernel: Remapping and enabling EFI services. Sep 5 05:42:30.733021 kernel: smp: Bringing up secondary CPUs ... Sep 5 05:42:30.733033 kernel: Detected PIPT I-cache on CPU1 Sep 5 05:42:30.733040 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 5 05:42:30.733047 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Sep 5 05:42:30.733055 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:42:30.733062 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 5 05:42:30.733069 kernel: Detected PIPT I-cache on CPU2 Sep 5 05:42:30.733077 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 5 05:42:30.733084 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Sep 5 05:42:30.733092 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:42:30.733098 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 5 05:42:30.733106 kernel: Detected PIPT I-cache on CPU3 Sep 5 05:42:30.733112 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 5 05:42:30.733120 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Sep 5 05:42:30.733126 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 5 05:42:30.733133 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 5 05:42:30.733140 kernel: smp: Brought up 1 node, 4 CPUs Sep 5 05:42:30.733147 kernel: SMP: Total of 4 processors activated. Sep 5 05:42:30.733155 kernel: CPU: All CPU(s) started at EL1 Sep 5 05:42:30.733162 kernel: CPU features: detected: 32-bit EL0 Support Sep 5 05:42:30.733169 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 5 05:42:30.733176 kernel: CPU features: detected: Common not Private translations Sep 5 05:42:30.733183 kernel: CPU features: detected: CRC32 instructions Sep 5 05:42:30.733190 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 5 05:42:30.733197 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 5 05:42:30.733204 kernel: CPU features: detected: LSE atomic instructions Sep 5 05:42:30.733211 kernel: CPU features: detected: Privileged Access Never Sep 5 05:42:30.733219 kernel: CPU features: detected: RAS Extension Support Sep 5 05:42:30.733226 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 5 05:42:30.733233 kernel: alternatives: applying system-wide alternatives Sep 5 05:42:30.733240 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Sep 5 05:42:30.733247 kernel: Memory: 2424544K/2572288K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 125408K reserved, 16384K cma-reserved) Sep 5 05:42:30.733254 kernel: devtmpfs: initialized Sep 5 05:42:30.733261 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 5 05:42:30.733268 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 5 05:42:30.733276 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 5 05:42:30.733298 kernel: 0 pages in range for non-PLT usage Sep 5 05:42:30.733308 kernel: 508576 pages in range for PLT usage Sep 5 05:42:30.733315 kernel: pinctrl core: initialized pinctrl subsystem Sep 5 05:42:30.733322 kernel: SMBIOS 3.0.0 present. Sep 5 05:42:30.733329 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 5 05:42:30.733336 kernel: DMI: Memory slots populated: 1/1 Sep 5 05:42:30.733343 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 5 05:42:30.733350 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 5 05:42:30.733357 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 5 05:42:30.733366 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 5 05:42:30.733373 kernel: audit: initializing netlink subsys (disabled) Sep 5 05:42:30.733381 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Sep 5 05:42:30.733388 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 5 05:42:30.733395 kernel: cpuidle: using governor menu Sep 5 05:42:30.733402 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 5 05:42:30.733409 kernel: ASID allocator initialised with 32768 entries Sep 5 05:42:30.733417 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 5 05:42:30.733424 kernel: Serial: AMBA PL011 UART driver Sep 5 05:42:30.733432 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 5 05:42:30.733439 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 5 05:42:30.733448 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 5 05:42:30.733455 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 5 05:42:30.733462 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 5 05:42:30.733469 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 5 05:42:30.733476 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 5 05:42:30.733483 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 5 05:42:30.733490 kernel: ACPI: Added _OSI(Module Device) Sep 5 05:42:30.733499 kernel: ACPI: Added _OSI(Processor Device) Sep 5 05:42:30.733506 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 5 05:42:30.733513 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 5 05:42:30.733519 kernel: ACPI: Interpreter enabled Sep 5 05:42:30.733526 kernel: ACPI: Using GIC for interrupt routing Sep 5 05:42:30.733533 kernel: ACPI: MCFG table detected, 1 entries Sep 5 05:42:30.733542 kernel: ACPI: CPU0 has been hot-added Sep 5 05:42:30.733551 kernel: ACPI: CPU1 has been hot-added Sep 5 05:42:30.733562 kernel: ACPI: CPU2 has been hot-added Sep 5 05:42:30.733569 kernel: ACPI: CPU3 has been hot-added Sep 5 05:42:30.733578 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 5 05:42:30.733585 kernel: printk: legacy console [ttyAMA0] enabled Sep 5 05:42:30.733593 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 5 05:42:30.733724 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 5 05:42:30.733817 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 5 05:42:30.733879 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 5 05:42:30.733939 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 5 05:42:30.733998 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 5 05:42:30.734007 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 5 05:42:30.734015 kernel: PCI host bridge to bus 0000:00 Sep 5 05:42:30.734081 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 5 05:42:30.734136 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 5 05:42:30.734188 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 5 05:42:30.734239 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 5 05:42:30.734335 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Sep 5 05:42:30.734407 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Sep 5 05:42:30.734470 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Sep 5 05:42:30.734531 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Sep 5 05:42:30.734590 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Sep 5 05:42:30.734650 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Sep 5 05:42:30.734711 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Sep 5 05:42:30.734781 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Sep 5 05:42:30.734838 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 5 05:42:30.734890 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 5 05:42:30.734944 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 5 05:42:30.734953 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 5 05:42:30.734960 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 5 05:42:30.734968 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 5 05:42:30.734976 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 5 05:42:30.734983 kernel: iommu: Default domain type: Translated Sep 5 05:42:30.734990 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 5 05:42:30.734997 kernel: efivars: Registered efivars operations Sep 5 05:42:30.735004 kernel: vgaarb: loaded Sep 5 05:42:30.735011 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 5 05:42:30.735018 kernel: VFS: Disk quotas dquot_6.6.0 Sep 5 05:42:30.735025 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 5 05:42:30.735032 kernel: pnp: PnP ACPI init Sep 5 05:42:30.735103 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 5 05:42:30.735113 kernel: pnp: PnP ACPI: found 1 devices Sep 5 05:42:30.735120 kernel: NET: Registered PF_INET protocol family Sep 5 05:42:30.735127 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 5 05:42:30.735134 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 5 05:42:30.735142 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 5 05:42:30.735149 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 5 05:42:30.735156 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 5 05:42:30.735164 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 5 05:42:30.735171 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 05:42:30.735178 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 5 05:42:30.735185 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 5 05:42:30.735192 kernel: PCI: CLS 0 bytes, default 64 Sep 5 05:42:30.735199 kernel: kvm [1]: HYP mode not available Sep 5 05:42:30.735206 kernel: Initialise system trusted keyrings Sep 5 05:42:30.735213 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 5 05:42:30.735220 kernel: Key type asymmetric registered Sep 5 05:42:30.735228 kernel: Asymmetric key parser 'x509' registered Sep 5 05:42:30.735235 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 5 05:42:30.735242 kernel: io scheduler mq-deadline registered Sep 5 05:42:30.735249 kernel: io scheduler kyber registered Sep 5 05:42:30.735256 kernel: io scheduler bfq registered Sep 5 05:42:30.735263 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 5 05:42:30.735270 kernel: ACPI: button: Power Button [PWRB] Sep 5 05:42:30.735277 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 5 05:42:30.735352 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 5 05:42:30.735364 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 5 05:42:30.735371 kernel: thunder_xcv, ver 1.0 Sep 5 05:42:30.735378 kernel: thunder_bgx, ver 1.0 Sep 5 05:42:30.735385 kernel: nicpf, ver 1.0 Sep 5 05:42:30.735392 kernel: nicvf, ver 1.0 Sep 5 05:42:30.735458 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 5 05:42:30.735521 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-05T05:42:30 UTC (1757050950) Sep 5 05:42:30.735531 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 5 05:42:30.735538 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Sep 5 05:42:30.735547 kernel: watchdog: NMI not fully supported Sep 5 05:42:30.735554 kernel: watchdog: Hard watchdog permanently disabled Sep 5 05:42:30.735561 kernel: NET: Registered PF_INET6 protocol family Sep 5 05:42:30.735569 kernel: Segment Routing with IPv6 Sep 5 05:42:30.735576 kernel: In-situ OAM (IOAM) with IPv6 Sep 5 05:42:30.735583 kernel: NET: Registered PF_PACKET protocol family Sep 5 05:42:30.735590 kernel: Key type dns_resolver registered Sep 5 05:42:30.735597 kernel: registered taskstats version 1 Sep 5 05:42:30.735605 kernel: Loading compiled-in X.509 certificates Sep 5 05:42:30.735613 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.44-flatcar: aa317a1d4cc75a128b85a6fc319190bc5853ac85' Sep 5 05:42:30.735620 kernel: Demotion targets for Node 0: null Sep 5 05:42:30.735628 kernel: Key type .fscrypt registered Sep 5 05:42:30.735635 kernel: Key type fscrypt-provisioning registered Sep 5 05:42:30.735643 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 5 05:42:30.735650 kernel: ima: Allocated hash algorithm: sha1 Sep 5 05:42:30.735658 kernel: ima: No architecture policies found Sep 5 05:42:30.735665 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 5 05:42:30.735673 kernel: clk: Disabling unused clocks Sep 5 05:42:30.735680 kernel: PM: genpd: Disabling unused power domains Sep 5 05:42:30.735688 kernel: Warning: unable to open an initial console. Sep 5 05:42:30.735695 kernel: Freeing unused kernel memory: 38912K Sep 5 05:42:30.735702 kernel: Run /init as init process Sep 5 05:42:30.735709 kernel: with arguments: Sep 5 05:42:30.735716 kernel: /init Sep 5 05:42:30.735723 kernel: with environment: Sep 5 05:42:30.735730 kernel: HOME=/ Sep 5 05:42:30.735745 kernel: TERM=linux Sep 5 05:42:30.735753 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 5 05:42:30.735761 systemd[1]: Successfully made /usr/ read-only. Sep 5 05:42:30.735771 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 5 05:42:30.735779 systemd[1]: Detected virtualization kvm. Sep 5 05:42:30.735787 systemd[1]: Detected architecture arm64. Sep 5 05:42:30.735794 systemd[1]: Running in initrd. Sep 5 05:42:30.735801 systemd[1]: No hostname configured, using default hostname. Sep 5 05:42:30.735810 systemd[1]: Hostname set to . Sep 5 05:42:30.735818 systemd[1]: Initializing machine ID from VM UUID. Sep 5 05:42:30.735825 systemd[1]: Queued start job for default target initrd.target. Sep 5 05:42:30.735833 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:42:30.735840 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:42:30.735848 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 5 05:42:30.735856 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 05:42:30.735864 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 5 05:42:30.735873 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 5 05:42:30.735882 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 5 05:42:30.735889 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 5 05:42:30.735897 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:42:30.735904 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:42:30.735912 systemd[1]: Reached target paths.target - Path Units. Sep 5 05:42:30.735920 systemd[1]: Reached target slices.target - Slice Units. Sep 5 05:42:30.735928 systemd[1]: Reached target swap.target - Swaps. Sep 5 05:42:30.735936 systemd[1]: Reached target timers.target - Timer Units. Sep 5 05:42:30.735943 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 05:42:30.735951 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 05:42:30.735958 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 5 05:42:30.735966 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 5 05:42:30.735973 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:42:30.735981 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 05:42:30.735990 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:42:30.735997 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 05:42:30.736005 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 5 05:42:30.736013 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 05:42:30.736020 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 5 05:42:30.736028 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Sep 5 05:42:30.736036 systemd[1]: Starting systemd-fsck-usr.service... Sep 5 05:42:30.736043 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 05:42:30.736051 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 05:42:30.736060 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:42:30.736067 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:42:30.736075 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 5 05:42:30.736083 systemd[1]: Finished systemd-fsck-usr.service. Sep 5 05:42:30.736107 systemd-journald[244]: Collecting audit messages is disabled. Sep 5 05:42:30.736125 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 5 05:42:30.736133 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:42:30.736141 systemd-journald[244]: Journal started Sep 5 05:42:30.736160 systemd-journald[244]: Runtime Journal (/run/log/journal/cacf91b3168349cab0d5f8fc60374450) is 6M, max 48.5M, 42.4M free. Sep 5 05:42:30.731224 systemd-modules-load[245]: Inserted module 'overlay' Sep 5 05:42:30.740298 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 05:42:30.743304 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 5 05:42:30.745009 systemd-modules-load[245]: Inserted module 'br_netfilter' Sep 5 05:42:30.745749 kernel: Bridge firewalling registered Sep 5 05:42:30.747796 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 5 05:42:30.749166 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 05:42:30.750807 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 05:42:30.752604 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 5 05:42:30.757431 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 05:42:30.759722 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 05:42:30.760348 systemd-tmpfiles[265]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 5 05:42:30.766672 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:42:30.772347 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 05:42:30.774158 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 5 05:42:30.775355 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:42:30.777145 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:42:30.788935 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 05:42:30.799998 dracut-cmdline[284]: 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=ad0560d5d82b42c8405832aa39f4f52a20b919c503afe4e7ecc72adb2e451fae Sep 5 05:42:30.818030 systemd-resolved[290]: Positive Trust Anchors: Sep 5 05:42:30.818047 systemd-resolved[290]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 05:42:30.818078 systemd-resolved[290]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 5 05:42:30.822823 systemd-resolved[290]: Defaulting to hostname 'linux'. Sep 5 05:42:30.823717 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 05:42:30.825885 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:42:30.871298 kernel: SCSI subsystem initialized Sep 5 05:42:30.875308 kernel: Loading iSCSI transport class v2.0-870. Sep 5 05:42:30.882329 kernel: iscsi: registered transport (tcp) Sep 5 05:42:30.894605 kernel: iscsi: registered transport (qla4xxx) Sep 5 05:42:30.894640 kernel: QLogic iSCSI HBA Driver Sep 5 05:42:30.910839 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 05:42:30.930614 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:42:30.932472 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 05:42:30.974206 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 5 05:42:30.976348 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 5 05:42:31.041327 kernel: raid6: neonx8 gen() 15776 MB/s Sep 5 05:42:31.058298 kernel: raid6: neonx4 gen() 15807 MB/s Sep 5 05:42:31.075295 kernel: raid6: neonx2 gen() 13217 MB/s Sep 5 05:42:31.092295 kernel: raid6: neonx1 gen() 10470 MB/s Sep 5 05:42:31.109297 kernel: raid6: int64x8 gen() 6890 MB/s Sep 5 05:42:31.126296 kernel: raid6: int64x4 gen() 7346 MB/s Sep 5 05:42:31.143294 kernel: raid6: int64x2 gen() 6102 MB/s Sep 5 05:42:31.160297 kernel: raid6: int64x1 gen() 5047 MB/s Sep 5 05:42:31.160317 kernel: raid6: using algorithm neonx4 gen() 15807 MB/s Sep 5 05:42:31.177313 kernel: raid6: .... xor() 12331 MB/s, rmw enabled Sep 5 05:42:31.177341 kernel: raid6: using neon recovery algorithm Sep 5 05:42:31.182488 kernel: xor: measuring software checksum speed Sep 5 05:42:31.182510 kernel: 8regs : 21607 MB/sec Sep 5 05:42:31.183611 kernel: 32regs : 21676 MB/sec Sep 5 05:42:31.183625 kernel: arm64_neon : 28061 MB/sec Sep 5 05:42:31.183637 kernel: xor: using function: arm64_neon (28061 MB/sec) Sep 5 05:42:31.236326 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 5 05:42:31.243350 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 5 05:42:31.245657 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:42:31.274690 systemd-udevd[498]: Using default interface naming scheme 'v255'. Sep 5 05:42:31.278728 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:42:31.281566 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 5 05:42:31.300847 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Sep 5 05:42:31.324078 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 05:42:31.326259 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 05:42:31.380969 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:42:31.384207 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 5 05:42:31.428308 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 5 05:42:31.430364 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 5 05:42:31.434307 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:42:31.441091 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 05:42:31.441215 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:42:31.445037 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:42:31.449547 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:42:31.458693 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 5 05:42:31.477954 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 5 05:42:31.479211 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:42:31.487319 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 5 05:42:31.496505 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 05:42:31.502467 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 5 05:42:31.503368 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 5 05:42:31.505611 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 05:42:31.507279 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:42:31.509001 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 05:42:31.511208 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 5 05:42:31.512845 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 5 05:42:31.534305 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:42:31.534511 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 5 05:42:31.540355 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:42:32.545231 disk-uuid[593]: The operation has completed successfully. Sep 5 05:42:32.546387 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 5 05:42:32.567002 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 5 05:42:32.567097 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 5 05:42:32.594983 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 5 05:42:32.616169 sh[610]: Success Sep 5 05:42:32.628970 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 5 05:42:32.629002 kernel: device-mapper: uevent: version 1.0.3 Sep 5 05:42:32.629020 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 5 05:42:32.636305 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 5 05:42:32.659014 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 5 05:42:32.676899 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 5 05:42:32.679114 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 5 05:42:32.687832 kernel: BTRFS: device fsid 9394a7fb-1948-4797-93d7-fc7ecccd6bdf devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (622) Sep 5 05:42:32.687862 kernel: BTRFS info (device dm-0): first mount of filesystem 9394a7fb-1948-4797-93d7-fc7ecccd6bdf Sep 5 05:42:32.687872 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:42:32.692303 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 5 05:42:32.692334 kernel: BTRFS info (device dm-0): enabling free space tree Sep 5 05:42:32.693008 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 5 05:42:32.694054 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 5 05:42:32.695158 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 5 05:42:32.695851 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 5 05:42:32.697139 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 5 05:42:32.721319 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (653) Sep 5 05:42:32.723304 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:42:32.723335 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:42:32.725362 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:42:32.725397 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:42:32.729334 kernel: BTRFS info (device vda6): last unmount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:42:32.731334 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 5 05:42:32.733039 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 5 05:42:32.798612 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 05:42:32.801993 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 05:42:32.828226 ignition[696]: Ignition 2.22.0 Sep 5 05:42:32.828242 ignition[696]: Stage: fetch-offline Sep 5 05:42:32.828274 ignition[696]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:32.828294 ignition[696]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:32.828373 ignition[696]: parsed url from cmdline: "" Sep 5 05:42:32.828376 ignition[696]: no config URL provided Sep 5 05:42:32.828380 ignition[696]: reading system config file "/usr/lib/ignition/user.ign" Sep 5 05:42:32.828387 ignition[696]: no config at "/usr/lib/ignition/user.ign" Sep 5 05:42:32.828405 ignition[696]: op(1): [started] loading QEMU firmware config module Sep 5 05:42:32.828409 ignition[696]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 5 05:42:32.834826 ignition[696]: op(1): [finished] loading QEMU firmware config module Sep 5 05:42:32.837991 ignition[696]: parsing config with SHA512: f75f167b3d71701cf97e6df4e9b2054a8a62d6f1bee5c30c178c317333597e69aef3b9dc29d6c8ac310998482460d79179422715570e49920692dc2d7f383b30 Sep 5 05:42:32.838093 systemd-networkd[802]: lo: Link UP Sep 5 05:42:32.838104 systemd-networkd[802]: lo: Gained carrier Sep 5 05:42:32.838822 systemd-networkd[802]: Enumeration completed Sep 5 05:42:32.838992 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 05:42:32.840123 systemd[1]: Reached target network.target - Network. Sep 5 05:42:32.840886 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:42:32.840890 systemd-networkd[802]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 05:42:32.841310 systemd-networkd[802]: eth0: Link UP Sep 5 05:42:32.845857 ignition[696]: fetch-offline: fetch-offline passed Sep 5 05:42:32.841591 systemd-networkd[802]: eth0: Gained carrier Sep 5 05:42:32.845918 ignition[696]: Ignition finished successfully Sep 5 05:42:32.841599 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:42:32.845684 unknown[696]: fetched base config from "system" Sep 5 05:42:32.845691 unknown[696]: fetched user config from "qemu" Sep 5 05:42:32.848190 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 05:42:32.849430 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 5 05:42:32.851624 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 5 05:42:32.856322 systemd-networkd[802]: eth0: DHCPv4 address 10.0.0.49/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 05:42:32.877686 ignition[810]: Ignition 2.22.0 Sep 5 05:42:32.877702 ignition[810]: Stage: kargs Sep 5 05:42:32.877834 ignition[810]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:32.877843 ignition[810]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:32.878354 ignition[810]: kargs: kargs passed Sep 5 05:42:32.878393 ignition[810]: Ignition finished successfully Sep 5 05:42:32.881343 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 5 05:42:32.883459 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 5 05:42:32.911756 ignition[819]: Ignition 2.22.0 Sep 5 05:42:32.911769 ignition[819]: Stage: disks Sep 5 05:42:32.911891 ignition[819]: no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:32.911899 ignition[819]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:32.912408 ignition[819]: disks: disks passed Sep 5 05:42:32.912448 ignition[819]: Ignition finished successfully Sep 5 05:42:32.915341 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 5 05:42:32.916971 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 5 05:42:32.919379 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 5 05:42:32.920944 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 05:42:32.922441 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 05:42:32.923776 systemd[1]: Reached target basic.target - Basic System. Sep 5 05:42:32.925801 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 5 05:42:32.963747 systemd-fsck[829]: ROOT: clean, 15/553520 files, 52789/553472 blocks Sep 5 05:42:32.968904 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 5 05:42:32.972405 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 5 05:42:33.026306 kernel: EXT4-fs (vda9): mounted filesystem f4f5d9cb-0abd-4bb7-89fa-b5d1beb281ac r/w with ordered data mode. Quota mode: none. Sep 5 05:42:33.026799 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 5 05:42:33.027859 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 5 05:42:33.029909 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 05:42:33.031315 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 5 05:42:33.032166 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 5 05:42:33.032203 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 5 05:42:33.032228 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 05:42:33.042488 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 5 05:42:33.046328 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (837) Sep 5 05:42:33.044628 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 5 05:42:33.049301 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:42:33.049329 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:42:33.051585 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:42:33.051623 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:42:33.052552 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 05:42:33.078701 initrd-setup-root[862]: cut: /sysroot/etc/passwd: No such file or directory Sep 5 05:42:33.081470 initrd-setup-root[869]: cut: /sysroot/etc/group: No such file or directory Sep 5 05:42:33.084886 initrd-setup-root[876]: cut: /sysroot/etc/shadow: No such file or directory Sep 5 05:42:33.088602 initrd-setup-root[883]: cut: /sysroot/etc/gshadow: No such file or directory Sep 5 05:42:33.151771 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 5 05:42:33.153794 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 5 05:42:33.156510 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 5 05:42:33.172360 kernel: BTRFS info (device vda6): last unmount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:42:33.179440 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 5 05:42:33.190483 ignition[952]: INFO : Ignition 2.22.0 Sep 5 05:42:33.190483 ignition[952]: INFO : Stage: mount Sep 5 05:42:33.192877 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:33.192877 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:33.192877 ignition[952]: INFO : mount: mount passed Sep 5 05:42:33.192877 ignition[952]: INFO : Ignition finished successfully Sep 5 05:42:33.193027 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 5 05:42:33.195089 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 5 05:42:33.816525 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 5 05:42:33.818030 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 5 05:42:33.834305 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 (254:6) scanned by mount (964) Sep 5 05:42:33.836294 kernel: BTRFS info (device vda6): first mount of filesystem ab813a37-c745-4f2a-8834-a13cfeeae891 Sep 5 05:42:33.836314 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 5 05:42:33.838310 kernel: BTRFS info (device vda6): turning on async discard Sep 5 05:42:33.838327 kernel: BTRFS info (device vda6): enabling free space tree Sep 5 05:42:33.839563 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 5 05:42:33.869696 ignition[981]: INFO : Ignition 2.22.0 Sep 5 05:42:33.869696 ignition[981]: INFO : Stage: files Sep 5 05:42:33.871120 ignition[981]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:33.871120 ignition[981]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:33.871120 ignition[981]: DEBUG : files: compiled without relabeling support, skipping Sep 5 05:42:33.874041 ignition[981]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 5 05:42:33.874041 ignition[981]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 5 05:42:33.874041 ignition[981]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 5 05:42:33.874041 ignition[981]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 5 05:42:33.874041 ignition[981]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 5 05:42:33.873209 unknown[981]: wrote ssh authorized keys file for user: core Sep 5 05:42:33.881012 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 05:42:33.881012 ignition[981]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(4): [started] processing unit "docker.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(4): [finished] processing unit "docker.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Sep 5 05:42:33.881012 ignition[981]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 5 05:42:33.893292 ignition[981]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 05:42:33.895374 ignition[981]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 5 05:42:33.897510 ignition[981]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 5 05:42:33.897510 ignition[981]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 5 05:42:33.897510 ignition[981]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 5 05:42:33.897510 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 5 05:42:33.897510 ignition[981]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 5 05:42:33.897510 ignition[981]: INFO : files: files passed Sep 5 05:42:33.897510 ignition[981]: INFO : Ignition finished successfully Sep 5 05:42:33.898270 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 5 05:42:33.900084 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 5 05:42:33.902491 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 5 05:42:33.921945 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 5 05:42:33.922401 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 5 05:42:33.924308 initrd-setup-root-after-ignition[1010]: grep: /sysroot/oem/oem-release: No such file or directory Sep 5 05:42:33.925654 initrd-setup-root-after-ignition[1012]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:42:33.925654 initrd-setup-root-after-ignition[1012]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:42:33.928373 initrd-setup-root-after-ignition[1016]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 5 05:42:33.927887 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 05:42:33.929626 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 5 05:42:33.933068 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 5 05:42:33.967593 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 5 05:42:33.967734 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 5 05:42:33.969483 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 5 05:42:33.971075 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 5 05:42:33.972551 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 5 05:42:33.973276 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 5 05:42:34.011585 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 05:42:34.013679 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 5 05:42:34.037904 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:42:34.038968 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:42:34.040643 systemd[1]: Stopped target timers.target - Timer Units. Sep 5 05:42:34.042022 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 5 05:42:34.042131 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 5 05:42:34.044113 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 5 05:42:34.045773 systemd[1]: Stopped target basic.target - Basic System. Sep 5 05:42:34.047128 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 5 05:42:34.048459 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 5 05:42:34.050026 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 5 05:42:34.051704 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 5 05:42:34.053207 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 5 05:42:34.054781 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 5 05:42:34.056312 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 5 05:42:34.058051 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 5 05:42:34.059492 systemd[1]: Stopped target swap.target - Swaps. Sep 5 05:42:34.060737 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 5 05:42:34.060851 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 5 05:42:34.062733 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:42:34.064256 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:42:34.065824 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 5 05:42:34.069340 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:42:34.070428 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 5 05:42:34.070538 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 5 05:42:34.072941 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 5 05:42:34.073057 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 5 05:42:34.074674 systemd[1]: Stopped target paths.target - Path Units. Sep 5 05:42:34.075977 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 5 05:42:34.076078 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:42:34.077714 systemd[1]: Stopped target slices.target - Slice Units. Sep 5 05:42:34.078971 systemd[1]: Stopped target sockets.target - Socket Units. Sep 5 05:42:34.080405 systemd[1]: iscsid.socket: Deactivated successfully. Sep 5 05:42:34.080495 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 5 05:42:34.082075 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 5 05:42:34.082146 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 5 05:42:34.083353 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 5 05:42:34.083465 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 5 05:42:34.084903 systemd[1]: ignition-files.service: Deactivated successfully. Sep 5 05:42:34.084998 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 5 05:42:34.087000 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 5 05:42:34.088125 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 5 05:42:34.088241 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:42:34.090575 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 5 05:42:34.092060 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 5 05:42:34.092175 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:42:34.093588 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 5 05:42:34.093683 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 5 05:42:34.098475 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 5 05:42:34.098572 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 5 05:42:34.106712 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 5 05:42:34.109752 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 5 05:42:34.110075 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 5 05:42:34.115840 ignition[1036]: INFO : Ignition 2.22.0 Sep 5 05:42:34.115840 ignition[1036]: INFO : Stage: umount Sep 5 05:42:34.117203 ignition[1036]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 5 05:42:34.117203 ignition[1036]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 5 05:42:34.117203 ignition[1036]: INFO : umount: umount passed Sep 5 05:42:34.117203 ignition[1036]: INFO : Ignition finished successfully Sep 5 05:42:34.118170 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 5 05:42:34.118307 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 5 05:42:34.119912 systemd[1]: Stopped target network.target - Network. Sep 5 05:42:34.120575 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 5 05:42:34.120621 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 5 05:42:34.121339 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 5 05:42:34.121377 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 5 05:42:34.122513 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 5 05:42:34.122554 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 5 05:42:34.123841 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 5 05:42:34.123876 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 5 05:42:34.125144 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 5 05:42:34.125184 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 5 05:42:34.126830 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 5 05:42:34.127975 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 5 05:42:34.138410 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 5 05:42:34.138516 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 5 05:42:34.141694 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Sep 5 05:42:34.141902 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 5 05:42:34.141996 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 5 05:42:34.145326 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 5 05:42:34.145836 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 5 05:42:34.147205 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 5 05:42:34.147239 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:42:34.149625 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 5 05:42:34.150971 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 5 05:42:34.151023 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 5 05:42:34.152716 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 5 05:42:34.152768 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:42:34.155068 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 5 05:42:34.155106 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 5 05:42:34.156679 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 5 05:42:34.156717 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:42:34.159062 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:42:34.176935 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 5 05:42:34.183474 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:42:34.184741 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 5 05:42:34.184847 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 5 05:42:34.186568 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 5 05:42:34.186623 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 5 05:42:34.187552 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 5 05:42:34.187581 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:42:34.188940 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 5 05:42:34.188986 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 5 05:42:34.191113 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 5 05:42:34.191155 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 5 05:42:34.193187 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 5 05:42:34.193236 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 5 05:42:34.196163 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 5 05:42:34.197541 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 5 05:42:34.197597 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:42:34.200071 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 5 05:42:34.200124 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:42:34.202660 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 5 05:42:34.202700 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:42:34.218321 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 5 05:42:34.218437 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 5 05:42:34.220174 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 5 05:42:34.222185 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 5 05:42:34.254647 systemd[1]: Switching root. Sep 5 05:42:34.297213 systemd-journald[244]: Journal stopped Sep 5 05:42:34.923870 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Sep 5 05:42:34.923920 kernel: SELinux: policy capability network_peer_controls=1 Sep 5 05:42:34.923935 kernel: SELinux: policy capability open_perms=1 Sep 5 05:42:34.923944 kernel: SELinux: policy capability extended_socket_class=1 Sep 5 05:42:34.923953 kernel: SELinux: policy capability always_check_network=0 Sep 5 05:42:34.923967 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 5 05:42:34.923979 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 5 05:42:34.923988 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 5 05:42:34.923997 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 5 05:42:34.924006 kernel: SELinux: policy capability userspace_initial_context=0 Sep 5 05:42:34.924016 kernel: audit: type=1403 audit(1757050954.383:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 5 05:42:34.924029 systemd[1]: Successfully loaded SELinux policy in 57.126ms. Sep 5 05:42:34.924049 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.152ms. Sep 5 05:42:34.924066 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 5 05:42:34.924077 systemd[1]: Detected virtualization kvm. Sep 5 05:42:34.924087 systemd[1]: Detected architecture arm64. Sep 5 05:42:34.924097 systemd[1]: Detected first boot. Sep 5 05:42:34.924107 systemd[1]: Initializing machine ID from VM UUID. Sep 5 05:42:34.924116 zram_generator::config[1082]: No configuration found. Sep 5 05:42:34.924127 kernel: NET: Registered PF_VSOCK protocol family Sep 5 05:42:34.924137 systemd[1]: Populated /etc with preset unit settings. Sep 5 05:42:34.924148 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 5 05:42:34.924158 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 5 05:42:34.924168 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 5 05:42:34.924178 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 5 05:42:34.924188 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 5 05:42:34.924200 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 5 05:42:34.924211 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 5 05:42:34.924220 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 5 05:42:34.924230 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 5 05:42:34.924241 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 5 05:42:34.924252 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 5 05:42:34.924262 systemd[1]: Created slice user.slice - User and Session Slice. Sep 5 05:42:34.924273 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 5 05:42:34.924294 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 5 05:42:34.924307 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 5 05:42:34.924317 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 5 05:42:34.924328 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 5 05:42:34.924339 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 5 05:42:34.924349 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 5 05:42:34.924362 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 5 05:42:34.924372 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 5 05:42:34.924382 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 5 05:42:34.924393 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 5 05:42:34.924404 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 5 05:42:34.924415 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 5 05:42:34.924425 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 5 05:42:34.924435 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 5 05:42:34.924445 systemd[1]: Reached target slices.target - Slice Units. Sep 5 05:42:34.924454 systemd[1]: Reached target swap.target - Swaps. Sep 5 05:42:34.924464 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 5 05:42:34.924474 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 5 05:42:34.924487 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 5 05:42:34.924497 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 5 05:42:34.924508 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 5 05:42:34.924518 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 5 05:42:34.924528 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 5 05:42:34.924538 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 5 05:42:34.924548 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 5 05:42:34.924557 systemd[1]: Mounting media.mount - External Media Directory... Sep 5 05:42:34.924567 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 5 05:42:34.924579 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 5 05:42:34.924588 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 5 05:42:34.924599 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 5 05:42:34.924609 systemd[1]: Reached target machines.target - Containers. Sep 5 05:42:34.924619 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 5 05:42:34.924629 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:42:34.924639 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 5 05:42:34.924649 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 5 05:42:34.924659 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:42:34.924671 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 05:42:34.924681 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:42:34.924691 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 5 05:42:34.924702 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:42:34.924712 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 5 05:42:34.924728 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 5 05:42:34.924740 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 5 05:42:34.924750 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 5 05:42:34.924762 systemd[1]: Stopped systemd-fsck-usr.service. Sep 5 05:42:34.924773 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:42:34.924783 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 5 05:42:34.924793 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 5 05:42:34.924802 kernel: loop: module loaded Sep 5 05:42:34.924812 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 5 05:42:34.924822 kernel: ACPI: bus type drm_connector registered Sep 5 05:42:34.924831 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 5 05:42:34.924841 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 5 05:42:34.924853 kernel: fuse: init (API version 7.41) Sep 5 05:42:34.924862 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 5 05:42:34.924872 systemd[1]: verity-setup.service: Deactivated successfully. Sep 5 05:42:34.924882 systemd[1]: Stopped verity-setup.service. Sep 5 05:42:34.924892 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 5 05:42:34.924904 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 5 05:42:34.924933 systemd-journald[1154]: Collecting audit messages is disabled. Sep 5 05:42:34.924956 systemd[1]: Mounted media.mount - External Media Directory. Sep 5 05:42:34.924966 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 5 05:42:34.924976 systemd-journald[1154]: Journal started Sep 5 05:42:34.924997 systemd-journald[1154]: Runtime Journal (/run/log/journal/cacf91b3168349cab0d5f8fc60374450) is 6M, max 48.5M, 42.4M free. Sep 5 05:42:34.720688 systemd[1]: Queued start job for default target multi-user.target. Sep 5 05:42:34.745255 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 5 05:42:34.745596 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 5 05:42:34.927980 systemd[1]: Started systemd-journald.service - Journal Service. Sep 5 05:42:34.928676 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 5 05:42:34.929616 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 5 05:42:34.931385 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 5 05:42:34.932582 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 5 05:42:34.933776 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 5 05:42:34.933946 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 5 05:42:34.935116 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:42:34.935279 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:42:34.936377 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 05:42:34.936523 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 05:42:34.937669 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:42:34.937828 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:42:34.939038 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 5 05:42:34.939203 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 5 05:42:34.940458 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:42:34.940603 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:42:34.941764 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 5 05:42:34.942948 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 5 05:42:34.944380 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 5 05:42:34.945569 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 5 05:42:34.956535 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 5 05:42:34.958508 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 5 05:42:34.960200 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 5 05:42:34.961165 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 5 05:42:34.961195 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 5 05:42:34.962849 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 5 05:42:34.971152 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 5 05:42:34.972146 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:42:34.973436 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 5 05:42:34.975186 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 5 05:42:34.976261 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 05:42:34.978392 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 5 05:42:34.982744 systemd-journald[1154]: Time spent on flushing to /var/log/journal/cacf91b3168349cab0d5f8fc60374450 is 10.499ms for 851 entries. Sep 5 05:42:34.982744 systemd-journald[1154]: System Journal (/var/log/journal/cacf91b3168349cab0d5f8fc60374450) is 8M, max 195.6M, 187.6M free. Sep 5 05:42:35.008393 systemd-journald[1154]: Received client request to flush runtime journal. Sep 5 05:42:34.979540 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 05:42:34.982409 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 5 05:42:34.998263 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 5 05:42:35.002438 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 5 05:42:35.005815 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 5 05:42:35.007137 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 5 05:42:35.008533 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 5 05:42:35.011511 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 5 05:42:35.012849 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 5 05:42:35.017992 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 5 05:42:35.022497 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 5 05:42:35.025263 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 5 05:42:35.031309 kernel: loop0: detected capacity change from 0 to 100608 Sep 5 05:42:35.039351 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 5 05:42:35.044851 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 5 05:42:35.047092 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 5 05:42:35.052302 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 5 05:42:35.065977 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. Sep 5 05:42:35.065996 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. Sep 5 05:42:35.069182 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 5 05:42:35.072406 kernel: loop1: detected capacity change from 0 to 119320 Sep 5 05:42:35.101360 kernel: loop2: detected capacity change from 0 to 100608 Sep 5 05:42:35.109335 kernel: loop3: detected capacity change from 0 to 119320 Sep 5 05:42:35.113470 (sd-merge)[1221]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 5 05:42:35.113899 (sd-merge)[1221]: Merged extensions into '/usr'. Sep 5 05:42:35.116657 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 5 05:42:35.119244 systemd[1]: Starting ensure-sysext.service... Sep 5 05:42:35.123407 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 5 05:42:35.142127 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 5 05:42:35.142465 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 5 05:42:35.142810 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 5 05:42:35.142994 systemd[1]: Reload requested from client PID 1223 ('systemctl') (unit ensure-sysext.service)... Sep 5 05:42:35.143014 systemd[1]: Reloading... Sep 5 05:42:35.143218 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 5 05:42:35.144058 systemd-tmpfiles[1224]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 5 05:42:35.144409 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Sep 5 05:42:35.144535 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Sep 5 05:42:35.147236 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 05:42:35.147362 systemd-tmpfiles[1224]: Skipping /boot Sep 5 05:42:35.153037 systemd-tmpfiles[1224]: Detected autofs mount point /boot during canonicalization of boot. Sep 5 05:42:35.153134 systemd-tmpfiles[1224]: Skipping /boot Sep 5 05:42:35.200309 zram_generator::config[1265]: No configuration found. Sep 5 05:42:35.249249 ldconfig[1193]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 5 05:42:35.343665 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 5 05:42:35.344006 systemd[1]: Reloading finished in 200 ms. Sep 5 05:42:35.377862 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 5 05:42:35.392309 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 5 05:42:35.399523 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:42:35.401469 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 5 05:42:35.420910 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 5 05:42:35.423901 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 5 05:42:35.427108 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 5 05:42:35.429393 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 5 05:42:35.434535 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:42:35.441145 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:42:35.442952 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:42:35.445085 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:42:35.446519 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:42:35.446626 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:42:35.452443 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 5 05:42:35.456102 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 5 05:42:35.458431 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 5 05:42:35.459933 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:42:35.460120 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:42:35.461590 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:42:35.461756 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:42:35.463202 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:42:35.463550 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:42:35.466670 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 5 05:42:35.469439 augenrules[1320]: No rules Sep 5 05:42:35.470391 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:42:35.470581 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:42:35.476839 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 5 05:42:35.480160 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:42:35.481213 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 5 05:42:35.482525 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 5 05:42:35.485603 systemd-udevd[1313]: Using default interface naming scheme 'v255'. Sep 5 05:42:35.498240 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 5 05:42:35.500322 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 5 05:42:35.504545 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 5 05:42:35.505838 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 5 05:42:35.505952 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 5 05:42:35.508443 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 5 05:42:35.509207 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 5 05:42:35.510502 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 5 05:42:35.511294 augenrules[1331]: /sbin/augenrules: No change Sep 5 05:42:35.511969 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 5 05:42:35.512246 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 5 05:42:35.514881 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 5 05:42:35.515040 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 5 05:42:35.518262 augenrules[1358]: No rules Sep 5 05:42:35.518874 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 5 05:42:35.519040 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 5 05:42:35.520426 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:42:35.520592 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:42:35.521896 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 5 05:42:35.522068 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 5 05:42:35.523469 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 5 05:42:35.527097 systemd[1]: Finished ensure-sysext.service. Sep 5 05:42:35.531443 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 5 05:42:35.534699 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 5 05:42:35.537412 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 5 05:42:35.537468 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 5 05:42:35.538961 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 5 05:42:35.562971 systemd-resolved[1292]: Positive Trust Anchors: Sep 5 05:42:35.562988 systemd-resolved[1292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 5 05:42:35.563018 systemd-resolved[1292]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 5 05:42:35.568781 systemd-resolved[1292]: Defaulting to hostname 'linux'. Sep 5 05:42:35.570405 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 5 05:42:35.571698 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 5 05:42:35.591693 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 5 05:42:35.621104 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 5 05:42:35.624305 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 5 05:42:35.651345 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 5 05:42:35.672452 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 5 05:42:35.673547 systemd[1]: Reached target sysinit.target - System Initialization. Sep 5 05:42:35.674434 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 5 05:42:35.675537 systemd-networkd[1377]: lo: Link UP Sep 5 05:42:35.675552 systemd-networkd[1377]: lo: Gained carrier Sep 5 05:42:35.676386 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 5 05:42:35.677335 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 5 05:42:35.678209 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 5 05:42:35.678237 systemd[1]: Reached target paths.target - Path Units. Sep 5 05:42:35.679094 systemd-networkd[1377]: Enumeration completed Sep 5 05:42:35.679566 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:42:35.679575 systemd-networkd[1377]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 5 05:42:35.679893 systemd[1]: Reached target time-set.target - System Time Set. Sep 5 05:42:35.680872 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 5 05:42:35.681779 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 5 05:42:35.682977 systemd-networkd[1377]: eth0: Link UP Sep 5 05:42:35.683091 systemd-networkd[1377]: eth0: Gained carrier Sep 5 05:42:35.683111 systemd-networkd[1377]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 5 05:42:35.683461 systemd[1]: Reached target timers.target - Timer Units. Sep 5 05:42:35.684762 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 5 05:42:35.686958 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 05:42:35.689527 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 5 05:42:35.690650 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 5 05:42:35.691951 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 5 05:42:35.697381 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 5 05:42:35.698432 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 5 05:42:35.699768 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 5 05:42:35.700775 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 05:42:35.701881 systemd[1]: Reached target network.target - Network. Sep 5 05:42:35.703395 systemd[1]: Reached target sockets.target - Socket Units. Sep 5 05:42:35.704080 systemd[1]: Reached target basic.target - Basic System. Sep 5 05:42:35.705108 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 5 05:42:35.705135 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 5 05:42:35.706511 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 05:42:35.710418 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 5 05:42:35.712476 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 5 05:42:35.716334 systemd-networkd[1377]: eth0: DHCPv4 address 10.0.0.49/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 5 05:42:35.716459 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 5 05:42:35.718316 systemd-timesyncd[1390]: Network configuration changed, trying to establish connection. Sep 5 05:42:35.718694 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 5 05:42:35.720546 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 5 05:42:35.721467 systemd-timesyncd[1390]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 5 05:42:35.721579 systemd-timesyncd[1390]: Initial clock synchronization to Fri 2025-09-05 05:42:35.377131 UTC. Sep 5 05:42:35.722402 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 5 05:42:35.725250 jq[1429]: false Sep 5 05:42:35.725800 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 5 05:42:35.728493 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 5 05:42:35.732142 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 5 05:42:35.735895 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 5 05:42:35.739421 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 5 05:42:35.741124 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 5 05:42:35.741583 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 5 05:42:35.743688 systemd[1]: Starting update-engine.service - Update Engine... Sep 5 05:42:35.746023 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 5 05:42:35.750755 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 5 05:42:35.752138 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 5 05:42:35.752356 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 5 05:42:35.752556 extend-filesystems[1430]: Found /dev/vda6 Sep 5 05:42:35.753268 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 5 05:42:35.753519 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 5 05:42:35.765519 extend-filesystems[1430]: Found /dev/vda9 Sep 5 05:42:35.769620 jq[1444]: true Sep 5 05:42:35.770534 extend-filesystems[1430]: Checking size of /dev/vda9 Sep 5 05:42:35.773349 systemd[1]: motdgen.service: Deactivated successfully. Sep 5 05:42:35.773551 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 5 05:42:35.778176 (ntainerd)[1460]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 05:42:35.782536 update_engine[1443]: I20250905 05:42:35.780593 1443 main.cc:92] Flatcar Update Engine starting Sep 5 05:42:35.784884 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 5 05:42:35.789855 jq[1463]: true Sep 5 05:42:35.790989 dbus-daemon[1424]: [system] SELinux support is enabled Sep 5 05:42:35.791164 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 5 05:42:35.794996 update_engine[1443]: I20250905 05:42:35.794662 1443 update_check_scheduler.cc:74] Next update check in 4m9s Sep 5 05:42:35.797189 extend-filesystems[1430]: Old size kept for /dev/vda9 Sep 5 05:42:35.798885 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 5 05:42:35.807033 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 5 05:42:35.811970 systemd[1]: Started update-engine.service - Update Engine. Sep 5 05:42:35.814736 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 5 05:42:35.814924 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 5 05:42:35.816129 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 5 05:42:35.816247 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 5 05:42:35.820541 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 5 05:42:35.826889 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 5 05:42:35.850108 bash[1488]: Updated "/home/core/.ssh/authorized_keys" Sep 5 05:42:35.851588 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 5 05:42:35.854617 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 5 05:42:35.864587 systemd-logind[1435]: Watching system buttons on /dev/input/event0 (Power Button) Sep 5 05:42:35.866560 systemd-logind[1435]: New seat seat0. Sep 5 05:42:35.867824 systemd[1]: Started systemd-logind.service - User Login Management. Sep 5 05:42:35.904168 locksmithd[1476]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 5 05:42:35.910323 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 5 05:42:35.955731 containerd[1460]: time="2025-09-05T05:42:35Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 5 05:42:35.956297 containerd[1460]: time="2025-09-05T05:42:35.956256080Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 05:42:35.964533 containerd[1460]: time="2025-09-05T05:42:35.964493200Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.88µs" Sep 5 05:42:35.964533 containerd[1460]: time="2025-09-05T05:42:35.964524040Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 05:42:35.964533 containerd[1460]: time="2025-09-05T05:42:35.964539520Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 05:42:35.964726 containerd[1460]: time="2025-09-05T05:42:35.964693080Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 05:42:35.964726 containerd[1460]: time="2025-09-05T05:42:35.964721920Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 05:42:35.964777 containerd[1460]: time="2025-09-05T05:42:35.964746600Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:42:35.964815 containerd[1460]: time="2025-09-05T05:42:35.964796320Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:42:35.964837 containerd[1460]: time="2025-09-05T05:42:35.964813720Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965024 containerd[1460]: time="2025-09-05T05:42:35.964993520Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965024 containerd[1460]: time="2025-09-05T05:42:35.965015160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965106 containerd[1460]: time="2025-09-05T05:42:35.965025840Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965106 containerd[1460]: time="2025-09-05T05:42:35.965034040Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965144 containerd[1460]: time="2025-09-05T05:42:35.965107200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965317 containerd[1460]: time="2025-09-05T05:42:35.965279760Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965345 containerd[1460]: time="2025-09-05T05:42:35.965331360Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:42:35.965365 containerd[1460]: time="2025-09-05T05:42:35.965345800Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 05:42:35.965386 containerd[1460]: time="2025-09-05T05:42:35.965379840Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 05:42:35.965659 containerd[1460]: time="2025-09-05T05:42:35.965645000Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 05:42:35.965729 containerd[1460]: time="2025-09-05T05:42:35.965705480Z" level=info msg="metadata content store policy set" policy=shared Sep 5 05:42:35.968554 containerd[1460]: time="2025-09-05T05:42:35.968526160Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 05:42:35.968603 containerd[1460]: time="2025-09-05T05:42:35.968582600Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 05:42:35.968603 containerd[1460]: time="2025-09-05T05:42:35.968597760Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 05:42:35.968636 containerd[1460]: time="2025-09-05T05:42:35.968608760Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 05:42:35.968636 containerd[1460]: time="2025-09-05T05:42:35.968621920Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 05:42:35.968697 containerd[1460]: time="2025-09-05T05:42:35.968674560Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 05:42:35.968697 containerd[1460]: time="2025-09-05T05:42:35.968688120Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 05:42:35.968759 containerd[1460]: time="2025-09-05T05:42:35.968698880Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 05:42:35.968759 containerd[1460]: time="2025-09-05T05:42:35.968709720Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 05:42:35.968759 containerd[1460]: time="2025-09-05T05:42:35.968726920Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 05:42:35.968759 containerd[1460]: time="2025-09-05T05:42:35.968737120Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 05:42:35.968759 containerd[1460]: time="2025-09-05T05:42:35.968748400Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 05:42:35.968867 containerd[1460]: time="2025-09-05T05:42:35.968848440Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 05:42:35.968892 containerd[1460]: time="2025-09-05T05:42:35.968873680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 05:42:35.968892 containerd[1460]: time="2025-09-05T05:42:35.968889040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 05:42:35.968923 containerd[1460]: time="2025-09-05T05:42:35.968899160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 05:42:35.968923 containerd[1460]: time="2025-09-05T05:42:35.968910560Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 05:42:35.968923 containerd[1460]: time="2025-09-05T05:42:35.968920400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 05:42:35.968973 containerd[1460]: time="2025-09-05T05:42:35.968931520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 05:42:35.968973 containerd[1460]: time="2025-09-05T05:42:35.968940880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 05:42:35.968973 containerd[1460]: time="2025-09-05T05:42:35.968951280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 05:42:35.968973 containerd[1460]: time="2025-09-05T05:42:35.968962120Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 05:42:35.968973 containerd[1460]: time="2025-09-05T05:42:35.968971560Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 05:42:35.969170 containerd[1460]: time="2025-09-05T05:42:35.969155640Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 05:42:35.969192 containerd[1460]: time="2025-09-05T05:42:35.969175360Z" level=info msg="Start snapshots syncer" Sep 5 05:42:35.969224 containerd[1460]: time="2025-09-05T05:42:35.969199320Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 05:42:35.970206 containerd[1460]: time="2025-09-05T05:42:35.969793800Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 5 05:42:35.970206 containerd[1460]: time="2025-09-05T05:42:35.969860960Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.969942760Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970047360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970074360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970086360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970106440Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970123720Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970139520Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 05:42:35.970383 containerd[1460]: time="2025-09-05T05:42:35.970151560Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 05:42:35.970519 containerd[1460]: time="2025-09-05T05:42:35.970438680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 05:42:35.970519 containerd[1460]: time="2025-09-05T05:42:35.970495200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 05:42:35.970519 containerd[1460]: time="2025-09-05T05:42:35.970511080Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 05:42:35.970599 containerd[1460]: time="2025-09-05T05:42:35.970571360Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:42:35.970625 containerd[1460]: time="2025-09-05T05:42:35.970594800Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:42:35.970705 containerd[1460]: time="2025-09-05T05:42:35.970674160Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:42:35.970741 containerd[1460]: time="2025-09-05T05:42:35.970713880Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:42:35.970762 containerd[1460]: time="2025-09-05T05:42:35.970739320Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 05:42:35.970787 containerd[1460]: time="2025-09-05T05:42:35.970761760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 05:42:35.970787 containerd[1460]: time="2025-09-05T05:42:35.970782440Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 05:42:35.970878 containerd[1460]: time="2025-09-05T05:42:35.970862680Z" level=info msg="runtime interface created" Sep 5 05:42:35.970902 containerd[1460]: time="2025-09-05T05:42:35.970873120Z" level=info msg="created NRI interface" Sep 5 05:42:35.970902 containerd[1460]: time="2025-09-05T05:42:35.970888040Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 05:42:35.970935 containerd[1460]: time="2025-09-05T05:42:35.970901200Z" level=info msg="Connect containerd service" Sep 5 05:42:35.970957 containerd[1460]: time="2025-09-05T05:42:35.970946760Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 05:42:35.972013 containerd[1460]: time="2025-09-05T05:42:35.971980440Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 5 05:42:36.041554 containerd[1460]: time="2025-09-05T05:42:36.041437665Z" level=info msg="Start subscribing containerd event" Sep 5 05:42:36.041554 containerd[1460]: time="2025-09-05T05:42:36.041514911Z" level=info msg="Start recovering state" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041591468Z" level=info msg="Start event monitor" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041602914Z" level=info msg="Start cni network conf syncer for default" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041613364Z" level=info msg="Start streaming server" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041621517Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041627374Z" level=info msg="runtime interface starting up..." Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041632618Z" level=info msg="starting plugins..." Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041644561Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041700792Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 05:42:36.041842 containerd[1460]: time="2025-09-05T05:42:36.041744851Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 05:42:36.041903 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 05:42:36.043011 containerd[1460]: time="2025-09-05T05:42:36.042988179Z" level=info msg="containerd successfully booted in 0.087578s" Sep 5 05:42:36.235644 sshd_keygen[1446]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 5 05:42:36.253522 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 5 05:42:36.255705 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 5 05:42:36.276508 systemd[1]: issuegen.service: Deactivated successfully. Sep 5 05:42:36.276706 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 5 05:42:36.278877 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 5 05:42:36.302155 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 5 05:42:36.304455 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 5 05:42:36.306104 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 5 05:42:36.307159 systemd[1]: Reached target getty.target - Login Prompts. Sep 5 05:42:37.443456 systemd-networkd[1377]: eth0: Gained IPv6LL Sep 5 05:42:37.445639 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 5 05:42:37.446985 systemd[1]: Reached target network-online.target - Network is Online. Sep 5 05:42:37.448977 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 5 05:42:37.450687 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 5 05:42:37.469861 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 5 05:42:37.470039 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 5 05:42:37.471737 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 5 05:42:37.473362 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 5 05:42:37.473540 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 5 05:42:37.475367 systemd[1]: Startup finished in 1.970s (kernel) + 3.774s (initrd) + 3.149s (userspace) = 8.895s. Sep 5 05:42:42.935408 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 5 05:42:42.936407 systemd[1]: Started sshd@0-10.0.0.49:22-10.0.0.1:44040.service - OpenSSH per-connection server daemon (10.0.0.1:44040). Sep 5 05:42:43.006219 sshd[1559]: Accepted publickey for core from 10.0.0.1 port 44040 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.007713 sshd-session[1559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.013013 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 5 05:42:43.013858 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 5 05:42:43.018665 systemd-logind[1435]: New session 1 of user core. Sep 5 05:42:43.031849 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 5 05:42:43.034387 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 5 05:42:43.048000 (systemd)[1564]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 5 05:42:43.049817 systemd-logind[1435]: New session c1 of user core. Sep 5 05:42:43.145182 systemd[1564]: Queued start job for default target default.target. Sep 5 05:42:43.154146 systemd[1564]: Created slice app.slice - User Application Slice. Sep 5 05:42:43.154174 systemd[1564]: Reached target paths.target - Paths. Sep 5 05:42:43.154205 systemd[1564]: Reached target timers.target - Timers. Sep 5 05:42:43.155256 systemd[1564]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 5 05:42:43.163593 systemd[1564]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 5 05:42:43.163649 systemd[1564]: Reached target sockets.target - Sockets. Sep 5 05:42:43.163682 systemd[1564]: Reached target basic.target - Basic System. Sep 5 05:42:43.163711 systemd[1564]: Reached target default.target - Main User Target. Sep 5 05:42:43.163737 systemd[1564]: Startup finished in 109ms. Sep 5 05:42:43.163855 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 5 05:42:43.165181 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 5 05:42:43.228986 systemd[1]: Started sshd@1-10.0.0.49:22-10.0.0.1:44056.service - OpenSSH per-connection server daemon (10.0.0.1:44056). Sep 5 05:42:43.268658 sshd[1575]: Accepted publickey for core from 10.0.0.1 port 44056 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.269768 sshd-session[1575]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.273261 systemd-logind[1435]: New session 2 of user core. Sep 5 05:42:43.288432 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 5 05:42:43.338202 sshd[1578]: Connection closed by 10.0.0.1 port 44056 Sep 5 05:42:43.338087 sshd-session[1575]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:43.347889 systemd[1]: sshd@1-10.0.0.49:22-10.0.0.1:44056.service: Deactivated successfully. Sep 5 05:42:43.350336 systemd[1]: session-2.scope: Deactivated successfully. Sep 5 05:42:43.350861 systemd-logind[1435]: Session 2 logged out. Waiting for processes to exit. Sep 5 05:42:43.352720 systemd[1]: Started sshd@2-10.0.0.49:22-10.0.0.1:44060.service - OpenSSH per-connection server daemon (10.0.0.1:44060). Sep 5 05:42:43.353132 systemd-logind[1435]: Removed session 2. Sep 5 05:42:43.402270 sshd[1584]: Accepted publickey for core from 10.0.0.1 port 44060 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.403366 sshd-session[1584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.407342 systemd-logind[1435]: New session 3 of user core. Sep 5 05:42:43.422401 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 5 05:42:43.468472 sshd[1587]: Connection closed by 10.0.0.1 port 44060 Sep 5 05:42:43.468871 sshd-session[1584]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:43.477992 systemd[1]: sshd@2-10.0.0.49:22-10.0.0.1:44060.service: Deactivated successfully. Sep 5 05:42:43.480350 systemd[1]: session-3.scope: Deactivated successfully. Sep 5 05:42:43.480894 systemd-logind[1435]: Session 3 logged out. Waiting for processes to exit. Sep 5 05:42:43.484472 systemd[1]: Started sshd@3-10.0.0.49:22-10.0.0.1:44066.service - OpenSSH per-connection server daemon (10.0.0.1:44066). Sep 5 05:42:43.485340 systemd-logind[1435]: Removed session 3. Sep 5 05:42:43.522050 sshd[1593]: Accepted publickey for core from 10.0.0.1 port 44066 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.523086 sshd-session[1593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.527026 systemd-logind[1435]: New session 4 of user core. Sep 5 05:42:43.535440 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 5 05:42:43.584416 sshd[1596]: Connection closed by 10.0.0.1 port 44066 Sep 5 05:42:43.584834 sshd-session[1593]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:43.596969 systemd[1]: sshd@3-10.0.0.49:22-10.0.0.1:44066.service: Deactivated successfully. Sep 5 05:42:43.599352 systemd[1]: session-4.scope: Deactivated successfully. Sep 5 05:42:43.600052 systemd-logind[1435]: Session 4 logged out. Waiting for processes to exit. Sep 5 05:42:43.602046 systemd[1]: Started sshd@4-10.0.0.49:22-10.0.0.1:44072.service - OpenSSH per-connection server daemon (10.0.0.1:44072). Sep 5 05:42:43.602665 systemd-logind[1435]: Removed session 4. Sep 5 05:42:43.651187 sshd[1602]: Accepted publickey for core from 10.0.0.1 port 44072 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.652211 sshd-session[1602]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.656158 systemd-logind[1435]: New session 5 of user core. Sep 5 05:42:43.675405 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 5 05:42:43.730033 sudo[1606]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 5 05:42:43.730293 sudo[1606]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:42:43.743049 sudo[1606]: pam_unix(sudo:session): session closed for user root Sep 5 05:42:43.744316 sshd[1605]: Connection closed by 10.0.0.1 port 44072 Sep 5 05:42:43.744695 sshd-session[1602]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:43.757042 systemd[1]: sshd@4-10.0.0.49:22-10.0.0.1:44072.service: Deactivated successfully. Sep 5 05:42:43.758399 systemd[1]: session-5.scope: Deactivated successfully. Sep 5 05:42:43.759002 systemd-logind[1435]: Session 5 logged out. Waiting for processes to exit. Sep 5 05:42:43.761062 systemd[1]: Started sshd@5-10.0.0.49:22-10.0.0.1:44078.service - OpenSSH per-connection server daemon (10.0.0.1:44078). Sep 5 05:42:43.761902 systemd-logind[1435]: Removed session 5. Sep 5 05:42:43.808487 sshd[1612]: Accepted publickey for core from 10.0.0.1 port 44078 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:43.809656 sshd-session[1612]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:43.813832 systemd-logind[1435]: New session 6 of user core. Sep 5 05:42:43.825439 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 5 05:42:43.874663 sudo[1617]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 5 05:42:43.875181 sudo[1617]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:42:43.879696 sudo[1617]: pam_unix(sudo:session): session closed for user root Sep 5 05:42:43.883888 sudo[1616]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 5 05:42:43.884138 sudo[1616]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:42:43.891621 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 5 05:42:43.926017 augenrules[1639]: No rules Sep 5 05:42:43.927032 systemd[1]: audit-rules.service: Deactivated successfully. Sep 5 05:42:43.927221 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 5 05:42:43.928058 sudo[1616]: pam_unix(sudo:session): session closed for user root Sep 5 05:42:43.929312 sshd[1615]: Connection closed by 10.0.0.1 port 44078 Sep 5 05:42:43.929603 sshd-session[1612]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:43.940062 systemd[1]: sshd@5-10.0.0.49:22-10.0.0.1:44078.service: Deactivated successfully. Sep 5 05:42:43.942445 systemd[1]: session-6.scope: Deactivated successfully. Sep 5 05:42:43.943934 systemd-logind[1435]: Session 6 logged out. Waiting for processes to exit. Sep 5 05:42:43.945897 systemd[1]: Started sshd@6-10.0.0.49:22-10.0.0.1:44082.service - OpenSSH per-connection server daemon (10.0.0.1:44082). Sep 5 05:42:43.946519 systemd-logind[1435]: Removed session 6. Sep 5 05:42:43.999971 sshd[1648]: Accepted publickey for core from 10.0.0.1 port 44082 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:44.001231 sshd-session[1648]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:44.005352 systemd-logind[1435]: New session 7 of user core. Sep 5 05:42:44.017483 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 5 05:42:44.069016 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 05:42:44.093640 (dockerd)[1653]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 5 05:42:44.286584 dockerd[1653]: time="2025-09-05T05:42:44.286474141Z" level=info msg="Starting up" Sep 5 05:42:44.287828 dockerd[1653]: time="2025-09-05T05:42:44.287561461Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 05:42:44.296794 dockerd[1653]: time="2025-09-05T05:42:44.296767884Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 05:42:44.324950 dockerd[1653]: time="2025-09-05T05:42:44.324920231Z" level=info msg="Loading containers: start." Sep 5 05:42:44.332313 kernel: Initializing XFRM netlink socket Sep 5 05:42:44.512574 systemd-networkd[1377]: docker0: Link UP Sep 5 05:42:44.515602 dockerd[1653]: time="2025-09-05T05:42:44.515570833Z" level=info msg="Loading containers: done." Sep 5 05:42:44.527121 dockerd[1653]: time="2025-09-05T05:42:44.527071462Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 5 05:42:44.527242 dockerd[1653]: time="2025-09-05T05:42:44.527145353Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 05:42:44.527242 dockerd[1653]: time="2025-09-05T05:42:44.527224288Z" level=info msg="Initializing buildkit" Sep 5 05:42:44.547768 dockerd[1653]: time="2025-09-05T05:42:44.547500369Z" level=info msg="Completed buildkit initialization" Sep 5 05:42:44.551996 dockerd[1653]: time="2025-09-05T05:42:44.551967640Z" level=info msg="Daemon has completed initialization" Sep 5 05:42:44.552162 dockerd[1653]: time="2025-09-05T05:42:44.552024349Z" level=info msg="API listen on /run/docker.sock" Sep 5 05:42:44.552200 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 05:42:44.561116 sshd[1651]: Connection closed by 10.0.0.1 port 44082 Sep 5 05:42:44.561463 sshd-session[1648]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:44.573047 systemd[1]: sshd@6-10.0.0.49:22-10.0.0.1:44082.service: Deactivated successfully. Sep 5 05:42:44.575470 systemd[1]: session-7.scope: Deactivated successfully. Sep 5 05:42:44.576080 systemd-logind[1435]: Session 7 logged out. Waiting for processes to exit. Sep 5 05:42:44.578170 systemd[1]: Started sshd@7-10.0.0.49:22-10.0.0.1:44098.service - OpenSSH per-connection server daemon (10.0.0.1:44098). Sep 5 05:42:44.578649 systemd-logind[1435]: Removed session 7. Sep 5 05:42:44.627953 sshd[1865]: Accepted publickey for core from 10.0.0.1 port 44098 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:44.629177 sshd-session[1865]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:44.633811 systemd-logind[1435]: New session 8 of user core. Sep 5 05:42:44.650484 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 5 05:42:45.305934 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2930276925-merged.mount: Deactivated successfully. Sep 5 05:42:45.743532 systemd[1]: var-lib-docker-overlay2-3a7420eb3af0fe34ce0e5291ccd9ed81f58f84cda0482984512f8d32f7faa068\x2dinit-merged.mount: Deactivated successfully. Sep 5 05:42:45.765331 systemd[1]: var-lib-docker-overlay2-3a7420eb3af0fe34ce0e5291ccd9ed81f58f84cda0482984512f8d32f7faa068-merged.mount: Deactivated successfully. Sep 5 05:42:45.792930 containerd[1460]: time="2025-09-05T05:42:45.792881428Z" level=info msg="connecting to shim f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf" address="unix:///run/containerd/s/f172199a256b486a9c9d826794dc5b27b17cd920c38fb7dcad82f941a6d7bbb6" namespace=moby protocol=ttrpc version=3 Sep 5 05:42:45.822533 systemd[1]: Started docker-f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf.scope - libcontainer container f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf. Sep 5 05:42:45.833210 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:42:45.851399 kernel: docker0: port 1(veth282487c) entered blocking state Sep 5 05:42:45.851462 kernel: docker0: port 1(veth282487c) entered disabled state Sep 5 05:42:45.851485 kernel: veth282487c: entered allmulticast mode Sep 5 05:42:45.852300 kernel: veth282487c: entered promiscuous mode Sep 5 05:42:45.852516 systemd-networkd[1377]: veth282487c: Link UP Sep 5 05:42:45.861303 kernel: eth0: renamed from vethd79873c Sep 5 05:42:45.862560 kernel: docker0: port 1(veth282487c) entered blocking state Sep 5 05:42:45.862623 kernel: docker0: port 1(veth282487c) entered forwarding state Sep 5 05:42:45.862638 systemd-networkd[1377]: veth282487c: Gained carrier Sep 5 05:42:45.863052 systemd-networkd[1377]: docker0: Gained carrier Sep 5 05:42:45.882841 sshd[1868]: Connection closed by 10.0.0.1 port 44098 Sep 5 05:42:45.883162 sshd-session[1865]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:45.895095 systemd[1]: sshd@7-10.0.0.49:22-10.0.0.1:44098.service: Deactivated successfully. Sep 5 05:42:45.897431 systemd[1]: session-8.scope: Deactivated successfully. Sep 5 05:42:45.898019 systemd-logind[1435]: Session 8 logged out. Waiting for processes to exit. Sep 5 05:42:45.899705 systemd[1]: Started sshd@8-10.0.0.49:22-10.0.0.1:44102.service - OpenSSH per-connection server daemon (10.0.0.1:44102). Sep 5 05:42:45.900695 systemd-logind[1435]: Removed session 8. Sep 5 05:42:45.939750 sshd[1943]: Accepted publickey for core from 10.0.0.1 port 44102 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:45.940951 sshd-session[1943]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:45.944673 systemd-logind[1435]: New session 9 of user core. Sep 5 05:42:45.953469 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 5 05:42:46.006589 sshd[1946]: Connection closed by 10.0.0.1 port 44102 Sep 5 05:42:46.007024 sshd-session[1943]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:46.020080 systemd[1]: sshd@8-10.0.0.49:22-10.0.0.1:44102.service: Deactivated successfully. Sep 5 05:42:46.022583 systemd[1]: session-9.scope: Deactivated successfully. Sep 5 05:42:46.023277 systemd-logind[1435]: Session 9 logged out. Waiting for processes to exit. Sep 5 05:42:46.025346 systemd[1]: Started sshd@9-10.0.0.49:22-10.0.0.1:44106.service - OpenSSH per-connection server daemon (10.0.0.1:44106). Sep 5 05:42:46.025939 systemd-logind[1435]: Removed session 9. Sep 5 05:42:46.078835 sshd[1952]: Accepted publickey for core from 10.0.0.1 port 44106 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:46.079840 sshd-session[1952]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:46.085347 systemd-logind[1435]: New session 10 of user core. Sep 5 05:42:46.095423 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 5 05:42:46.145213 sudo[1957]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1460 Sep 5 05:42:46.145513 sudo[1957]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:42:46.148508 sudo[1957]: pam_unix(sudo:session): session closed for user root Sep 5 05:42:46.148771 containerd[1460]: time="2025-09-05T05:42:46.148702159Z" level=info msg="Stop CRI service" Sep 5 05:42:46.149358 dockerd[1653]: time="2025-09-05T05:42:46.149265311Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 5 05:42:46.149358 dockerd[1653]: time="2025-09-05T05:42:46.149317592Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 5 05:42:46.149619 dockerd[1653]: time="2025-09-05T05:42:46.149318937Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 5 05:42:46.149619 dockerd[1653]: time="2025-09-05T05:42:46.149435799Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 5 05:42:46.150310 sshd[1956]: Connection closed by 10.0.0.1 port 44106 Sep 5 05:42:46.150600 sshd-session[1952]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:46.154368 containerd[1460]: time="2025-09-05T05:42:46.154325329Z" level=info msg="Stop CRI service" Sep 5 05:42:46.154453 containerd[1460]: time="2025-09-05T05:42:46.154396831Z" level=info msg="Event monitor stopped" Sep 5 05:42:46.154453 containerd[1460]: time="2025-09-05T05:42:46.154403870Z" level=info msg="Stream server stopped" Sep 5 05:42:46.158894 systemd[1]: containerd.service: Deactivated successfully. Sep 5 05:42:46.158980 systemd[1]: containerd.service: Unit process 1892 (containerd-shim) remains running after unit stopped. Sep 5 05:42:46.159190 systemd[1]: containerd.service: Consumed 279ms CPU time, 120M memory peak. Sep 5 05:42:46.159534 systemd[1]: sshd@9-10.0.0.49:22-10.0.0.1:44106.service: Deactivated successfully. Sep 5 05:42:46.161020 systemd[1]: session-10.scope: Deactivated successfully. Sep 5 05:42:46.161626 systemd-logind[1435]: Session 10 logged out. Waiting for processes to exit. Sep 5 05:42:46.164148 systemd[1]: Started sshd@10-10.0.0.49:22-10.0.0.1:44108.service - OpenSSH per-connection server daemon (10.0.0.1:44108). Sep 5 05:42:46.164743 systemd-logind[1435]: Removed session 10. Sep 5 05:42:46.213432 sshd[1964]: Accepted publickey for core from 10.0.0.1 port 44108 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:46.214614 sshd-session[1964]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:46.218787 systemd-logind[1435]: New session 11 of user core. Sep 5 05:42:46.227485 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 5 05:42:46.279965 sshd[1967]: Connection closed by 10.0.0.1 port 44108 Sep 5 05:42:46.280184 sshd-session[1964]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:46.282898 systemd[1]: sshd@10-10.0.0.49:22-10.0.0.1:44108.service: Deactivated successfully. Sep 5 05:42:46.284303 systemd[1]: session-11.scope: Deactivated successfully. Sep 5 05:42:46.285337 systemd-logind[1435]: Session 11 logged out. Waiting for processes to exit. Sep 5 05:42:46.286330 systemd-logind[1435]: Removed session 11. Sep 5 05:42:47.171404 systemd-networkd[1377]: docker0: Gained IPv6LL Sep 5 05:42:47.876410 systemd-networkd[1377]: veth282487c: Gained IPv6LL Sep 5 05:42:51.392526 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 5 05:42:51.393293 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 5 05:42:51.393517 dockerd[1653]: time="2025-09-05T05:42:51.393428408Z" level=info msg="Processing signal 'terminated'" Sep 5 05:42:52.245315 systemd[1]: Started sshd@11-10.0.0.49:22-10.0.0.1:36240.service - OpenSSH per-connection server daemon (10.0.0.1:36240). Sep 5 05:42:52.310186 sshd[1973]: Accepted publickey for core from 10.0.0.1 port 36240 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:52.311678 sshd-session[1973]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:52.316337 systemd-logind[1435]: New session 12 of user core. Sep 5 05:42:52.325702 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 5 05:42:52.384113 sshd[1976]: Connection closed by 10.0.0.1 port 36240 Sep 5 05:42:52.384504 sshd-session[1973]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:52.388856 systemd[1]: sshd@11-10.0.0.49:22-10.0.0.1:36240.service: Deactivated successfully. Sep 5 05:42:52.391961 systemd[1]: session-12.scope: Deactivated successfully. Sep 5 05:42:52.393344 systemd-logind[1435]: Session 12 logged out. Waiting for processes to exit. Sep 5 05:42:52.394209 systemd-logind[1435]: Removed session 12. Sep 5 05:42:58.375235 systemd[1]: Started sshd@12-10.0.0.49:22-10.0.0.1:36246.service - OpenSSH per-connection server daemon (10.0.0.1:36246). Sep 5 05:42:58.434474 sshd[1982]: Accepted publickey for core from 10.0.0.1 port 36246 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:42:58.436742 sshd-session[1982]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:42:58.441795 systemd-logind[1435]: New session 13 of user core. Sep 5 05:42:58.454490 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 5 05:42:58.510541 sshd[1985]: Connection closed by 10.0.0.1 port 36246 Sep 5 05:42:58.511953 sshd-session[1982]: pam_unix(sshd:session): session closed for user core Sep 5 05:42:58.516412 systemd[1]: sshd@12-10.0.0.49:22-10.0.0.1:36246.service: Deactivated successfully. Sep 5 05:42:58.521483 systemd[1]: session-13.scope: Deactivated successfully. Sep 5 05:42:58.522567 systemd-logind[1435]: Session 13 logged out. Waiting for processes to exit. Sep 5 05:42:58.524022 systemd-logind[1435]: Removed session 13. Sep 5 05:43:04.520065 systemd[1]: Started sshd@13-10.0.0.49:22-10.0.0.1:56806.service - OpenSSH per-connection server daemon (10.0.0.1:56806). Sep 5 05:43:04.594390 sshd[1991]: Accepted publickey for core from 10.0.0.1 port 56806 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:04.595235 sshd-session[1991]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:04.599619 systemd-logind[1435]: New session 14 of user core. Sep 5 05:43:04.608848 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 5 05:43:04.664086 sshd[1994]: Connection closed by 10.0.0.1 port 56806 Sep 5 05:43:04.665579 sshd-session[1991]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:04.668444 systemd[1]: sshd@13-10.0.0.49:22-10.0.0.1:56806.service: Deactivated successfully. Sep 5 05:43:04.674980 systemd[1]: session-14.scope: Deactivated successfully. Sep 5 05:43:04.680733 systemd-logind[1435]: Session 14 logged out. Waiting for processes to exit. Sep 5 05:43:04.684316 systemd-logind[1435]: Removed session 14. Sep 5 05:43:06.394179 dockerd[1653]: time="2025-09-05T05:43:06.394031188Z" level=error msg="Force shutdown daemon" Sep 5 05:43:06.395090 dockerd[1653]: time="2025-09-05T05:43:06.394609814Z" level=info msg="Daemon shutdown complete" Sep 5 05:43:06.395090 dockerd[1653]: time="2025-09-05T05:43:06.394814733Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: received context error while waiting for new LB policy update: context canceled" Sep 5 05:43:06.395090 dockerd[1653]: time="2025-09-05T05:43:06.394838315Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby Sep 5 05:43:06.395090 dockerd[1653]: time="2025-09-05T05:43:06.394862256Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: received context error while waiting for new LB policy update: context canceled" Sep 5 05:43:06.395090 dockerd[1653]: time="2025-09-05T05:43:06.394873767Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Sep 5 05:43:06.397813 systemd[1]: docker.service: Deactivated successfully. Sep 5 05:43:06.398183 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 5 05:43:06.398267 systemd[1]: docker.service: Consumed 828ms CPU time, 123.1M memory peak. Sep 5 05:43:06.398832 systemd[1]: docker.socket: Deactivated successfully. Sep 5 05:43:06.399093 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 5 05:43:06.399139 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 5 05:43:06.402252 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 05:43:06.402724 systemd[1]: containerd.service: Found left-over process 1892 (containerd-shim) in control group while starting unit. Ignoring. Sep 5 05:43:06.402727 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 5 05:43:06.412912 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 05:43:06.413189 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 05:43:06.427064 systemd[1]: containerd.service: Found left-over process 1892 (containerd-shim) in control group while starting unit. Ignoring. Sep 5 05:43:06.427077 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 5 05:43:06.449541 (ntainerd)[2005]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 05:43:06.468111 containerd[2005]: time="2025-09-05T05:43:06Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 5 05:43:06.468797 containerd[2005]: time="2025-09-05T05:43:06.468755353Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 05:43:06.478711 containerd[2005]: time="2025-09-05T05:43:06.478459384Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.554µs" Sep 5 05:43:06.478711 containerd[2005]: time="2025-09-05T05:43:06.478496035Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 05:43:06.478711 containerd[2005]: time="2025-09-05T05:43:06.478514621Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 05:43:06.478711 containerd[2005]: time="2025-09-05T05:43:06.478545556Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 05:43:06.478711 containerd[2005]: time="2025-09-05T05:43:06.478556508Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 05:43:06.481237 containerd[2005]: time="2025-09-05T05:43:06.478982174Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:43:06.481237 containerd[2005]: time="2025-09-05T05:43:06.481201114Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481365705Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481571584Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481584414Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481595205Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481603119Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481628419Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481724584Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481748365Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481757997Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481794968Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.481993733Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 05:43:06.482492 containerd[2005]: time="2025-09-05T05:43:06.482012798Z" level=info msg="metadata content store policy set" policy=shared Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482122871Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482149810Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482161921Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482172912Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482183424Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482193616Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482203928Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482219276Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482228988Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482238421Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482248293Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 05:43:06.482765 containerd[2005]: time="2025-09-05T05:43:06.482261682Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 05:43:06.484173 containerd[2005]: time="2025-09-05T05:43:06.483189755Z" level=info msg="connecting to shim f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf" address="unix:///run/containerd/s/f172199a256b486a9c9d826794dc5b27b17cd920c38fb7dcad82f941a6d7bbb6" namespace=moby protocol=ttrpc version=3 Sep 5 05:43:06.494784 containerd[2005]: time="2025-09-05T05:43:06.494740897Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494790138Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494808924Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494821194Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494833424Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494843736Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 05:43:06.494859 containerd[2005]: time="2025-09-05T05:43:06.494855327Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 05:43:06.494970 containerd[2005]: time="2025-09-05T05:43:06.494865599Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 05:43:06.494970 containerd[2005]: time="2025-09-05T05:43:06.494880108Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 05:43:06.494970 containerd[2005]: time="2025-09-05T05:43:06.494891539Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 05:43:06.494970 containerd[2005]: time="2025-09-05T05:43:06.494902051Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 05:43:06.494970 containerd[2005]: time="2025-09-05T05:43:06.494959765Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 05:43:06.495064 containerd[2005]: time="2025-09-05T05:43:06.494976512Z" level=info msg="Start snapshots syncer" Sep 5 05:43:06.495064 containerd[2005]: time="2025-09-05T05:43:06.495004930Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 05:43:06.495331 containerd[2005]: time="2025-09-05T05:43:06.495262288Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 5 05:43:06.495490 containerd[2005]: time="2025-09-05T05:43:06.495356055Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 05:43:06.495490 containerd[2005]: time="2025-09-05T05:43:06.495434153Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 05:43:06.495490 containerd[2005]: time="2025-09-05T05:43:06.495482755Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495507816Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495519127Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495528959Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495541109Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495551381Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495562413Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495589072Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495600943Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 05:43:06.495608 containerd[2005]: time="2025-09-05T05:43:06.495612334Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495648066Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495662814Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495671207Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495680320Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495687555Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495696628Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495706740Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495723327Z" level=info msg="runtime interface created" Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495728083Z" level=info msg="created NRI interface" Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495736356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495747707Z" level=info msg="Connect containerd service" Sep 5 05:43:06.495875 containerd[2005]: time="2025-09-05T05:43:06.495772968Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 05:43:06.496313 containerd[2005]: time="2025-09-05T05:43:06.496259306Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508122844Z" level=info msg="Start subscribing containerd event" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508174044Z" level=info msg="Start recovering state" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508269609Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508314733Z" level=info msg="Start event monitor" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508331040Z" level=info msg="Start cni network conf syncer for default" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508336796Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508338555Z" level=info msg="Start streaming server" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508354502Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508361337Z" level=info msg="runtime interface starting up..." Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508366652Z" level=info msg="starting plugins..." Sep 5 05:43:06.508546 containerd[2005]: time="2025-09-05T05:43:06.508375965Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 05:43:06.510385 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 05:43:06.512323 containerd[2005]: time="2025-09-05T05:43:06.512145649Z" level=info msg="containerd successfully booted in 0.044344s" Sep 5 05:43:06.515213 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 05:43:06.534668 (dockerd)[2033]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 5 05:43:06.568088 dockerd[2033]: time="2025-09-05T05:43:06.568026950Z" level=info msg="Starting up" Sep 5 05:43:06.569174 dockerd[2033]: time="2025-09-05T05:43:06.568621404Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 05:43:06.580387 dockerd[2033]: time="2025-09-05T05:43:06.580350407Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 05:43:06.599485 dockerd[2033]: time="2025-09-05T05:43:06.599432404Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 5 05:43:06.607136 dockerd[2033]: time="2025-09-05T05:43:06.607087761Z" level=info msg="Loading containers: start." Sep 5 05:43:10.677093 systemd[1]: Started sshd@14-10.0.0.49:22-10.0.0.1:58642.service - OpenSSH per-connection server daemon (10.0.0.1:58642). Sep 5 05:43:10.742832 sshd[2066]: Accepted publickey for core from 10.0.0.1 port 58642 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:10.743886 sshd-session[2066]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:10.747914 systemd-logind[1435]: New session 15 of user core. Sep 5 05:43:10.756453 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 5 05:43:10.808217 sshd[2069]: Connection closed by 10.0.0.1 port 58642 Sep 5 05:43:10.808503 sshd-session[2066]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:10.820265 systemd[1]: sshd@14-10.0.0.49:22-10.0.0.1:58642.service: Deactivated successfully. Sep 5 05:43:10.822626 systemd[1]: session-15.scope: Deactivated successfully. Sep 5 05:43:10.823316 systemd-logind[1435]: Session 15 logged out. Waiting for processes to exit. Sep 5 05:43:10.825274 systemd[1]: Started sshd@15-10.0.0.49:22-10.0.0.1:58646.service - OpenSSH per-connection server daemon (10.0.0.1:58646). Sep 5 05:43:10.825866 systemd-logind[1435]: Removed session 15. Sep 5 05:43:10.878018 sshd[2075]: Accepted publickey for core from 10.0.0.1 port 58646 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:10.879091 sshd-session[2075]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:10.882651 systemd-logind[1435]: New session 16 of user core. Sep 5 05:43:10.892417 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 5 05:43:10.944551 sshd[2078]: Connection closed by 10.0.0.1 port 58646 Sep 5 05:43:10.944919 sshd-session[2075]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:10.959000 systemd[1]: sshd@15-10.0.0.49:22-10.0.0.1:58646.service: Deactivated successfully. Sep 5 05:43:10.961621 systemd[1]: session-16.scope: Deactivated successfully. Sep 5 05:43:10.962183 systemd-logind[1435]: Session 16 logged out. Waiting for processes to exit. Sep 5 05:43:10.964196 systemd[1]: Started sshd@16-10.0.0.49:22-10.0.0.1:58656.service - OpenSSH per-connection server daemon (10.0.0.1:58656). Sep 5 05:43:10.964818 systemd-logind[1435]: Removed session 16. Sep 5 05:43:11.016890 sshd[2084]: Accepted publickey for core from 10.0.0.1 port 58656 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:11.017896 sshd-session[2084]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:11.021574 systemd-logind[1435]: New session 17 of user core. Sep 5 05:43:11.028421 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 5 05:43:16.627188 dockerd[2033]: time="2025-09-05T05:43:16.627113871Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf Sep 5 05:43:16.635630 systemd[1]: docker-f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf.scope: Deactivated successfully. Sep 5 05:43:16.649901 dockerd[2033]: time="2025-09-05T05:43:16.649858848Z" level=info msg="ignoring event" container=f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Sep 5 05:43:16.650106 containerd[2005]: time="2025-09-05T05:43:16.649786996Z" level=info msg="shim disconnected" id=f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf namespace=moby Sep 5 05:43:16.650106 containerd[2005]: time="2025-09-05T05:43:16.650028757Z" level=warning msg="cleaning up after shim disconnected" id=f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf namespace=moby Sep 5 05:43:16.650106 containerd[2005]: time="2025-09-05T05:43:16.650058642Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:43:16.663424 systemd[1]: var-lib-docker-overlay2-3a7420eb3af0fe34ce0e5291ccd9ed81f58f84cda0482984512f8d32f7faa068-merged.mount: Deactivated successfully. Sep 5 05:43:17.124150 systemd[1]: run-docker-netns-5df74e16a680.mount: Deactivated successfully. Sep 5 05:43:17.124985 systemd-networkd[1377]: veth282487c: Link DOWN Sep 5 05:43:17.124996 systemd-networkd[1377]: veth282487c: Lost carrier Sep 5 05:43:17.125706 kernel: docker0: port 1(veth282487c) entered disabled state Sep 5 05:43:17.127442 kernel: veth282487c (unregistering): left allmulticast mode Sep 5 05:43:17.127491 kernel: veth282487c (unregistering): left promiscuous mode Sep 5 05:43:17.127529 kernel: docker0: port 1(veth282487c) entered disabled state Sep 5 05:43:17.128562 systemd-networkd[1377]: docker0: Lost carrier Sep 5 05:43:17.129269 dockerd[2033]: time="2025-09-05T05:43:17.129235677Z" level=info msg="Removing stale sandbox 5df74e16a680cf322f3e4997c3c14a19facaacb95ce846bb4420c91f75b6137e (f32615c47930cc8a0d65f4a34d47d5bb4e99157ce51812a0b793955485b7accf)" Sep 5 05:43:17.135028 dockerd[2033]: time="2025-09-05T05:43:17.134937104Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 5 05:43:17.135028 dockerd[2033]: time="2025-09-05T05:43:17.134991153Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint cd4814e9b30cb9ebe88acd682acad67a16d8098770f703509d7fc0e6fa974db4 10b697e7f75e0226302e25feb896739831a941694ea91d3b2df78736252b4eb4], retrying...." Sep 5 05:43:17.138397 systemd[1]: run-docker-netns-5df74e16a680.mount: Deactivated successfully. Sep 5 05:43:17.337937 dockerd[2033]: time="2025-09-05T05:43:17.337872925Z" level=warning msg="error locating sandbox id 5df74e16a680cf322f3e4997c3c14a19facaacb95ce846bb4420c91f75b6137e: sandbox 5df74e16a680cf322f3e4997c3c14a19facaacb95ce846bb4420c91f75b6137e not found" Sep 5 05:43:17.338052 dockerd[2033]: time="2025-09-05T05:43:17.337982942Z" level=info msg="Loading containers: done." Sep 5 05:43:17.348389 dockerd[2033]: time="2025-09-05T05:43:17.348340351Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 5 05:43:17.348535 dockerd[2033]: time="2025-09-05T05:43:17.348426244Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 05:43:17.348535 dockerd[2033]: time="2025-09-05T05:43:17.348460250Z" level=info msg="Initializing buildkit" Sep 5 05:43:17.361678 dockerd[2033]: time="2025-09-05T05:43:17.361624745Z" level=info msg="Completed buildkit initialization" Sep 5 05:43:17.370294 dockerd[2033]: time="2025-09-05T05:43:17.370234956Z" level=info msg="Daemon has completed initialization" Sep 5 05:43:17.370437 dockerd[2033]: time="2025-09-05T05:43:17.370385420Z" level=info msg="API listen on /run/docker.sock" Sep 5 05:43:17.370510 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 05:43:17.378193 sshd[2087]: Connection closed by 10.0.0.1 port 58656 Sep 5 05:43:17.378055 sshd-session[2084]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:17.391108 systemd[1]: sshd@16-10.0.0.49:22-10.0.0.1:58656.service: Deactivated successfully. Sep 5 05:43:17.393659 systemd[1]: session-17.scope: Deactivated successfully. Sep 5 05:43:17.394315 systemd-logind[1435]: Session 17 logged out. Waiting for processes to exit. Sep 5 05:43:17.396742 systemd[1]: Started sshd@17-10.0.0.49:22-10.0.0.1:58668.service - OpenSSH per-connection server daemon (10.0.0.1:58668). Sep 5 05:43:17.397325 systemd-logind[1435]: Removed session 17. Sep 5 05:43:17.448356 sshd[2338]: Accepted publickey for core from 10.0.0.1 port 58668 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:17.449642 sshd-session[2338]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:17.455058 systemd-logind[1435]: New session 18 of user core. Sep 5 05:43:17.464507 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 5 05:43:17.560879 containerd[2005]: time="2025-09-05T05:43:17.560835573Z" level=info msg="connecting to shim b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba" address="unix:///run/containerd/s/0ec954616f504edfff94e13250235ff48f7fd998b33d1fde56ea3da576902bd2" namespace=moby protocol=ttrpc version=3 Sep 5 05:43:17.583752 systemd[1]: Started docker-b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba.scope - libcontainer container b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba. Sep 5 05:43:17.594677 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:43:17.610725 kernel: docker0: port 1(vethbbd152c) entered blocking state Sep 5 05:43:17.610820 kernel: docker0: port 1(vethbbd152c) entered disabled state Sep 5 05:43:17.610836 kernel: vethbbd152c: entered allmulticast mode Sep 5 05:43:17.611664 kernel: vethbbd152c: entered promiscuous mode Sep 5 05:43:17.612031 systemd-networkd[1377]: vethbbd152c: Link UP Sep 5 05:43:17.618307 kernel: eth0: renamed from veth286979a Sep 5 05:43:17.620330 kernel: docker0: port 1(vethbbd152c) entered blocking state Sep 5 05:43:17.620393 kernel: docker0: port 1(vethbbd152c) entered forwarding state Sep 5 05:43:17.620383 systemd-networkd[1377]: vethbbd152c: Gained carrier Sep 5 05:43:17.620631 systemd-networkd[1377]: docker0: Gained carrier Sep 5 05:43:17.639413 sshd[2341]: Connection closed by 10.0.0.1 port 58668 Sep 5 05:43:17.639983 sshd-session[2338]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:17.648751 systemd[1]: sshd@17-10.0.0.49:22-10.0.0.1:58668.service: Deactivated successfully. Sep 5 05:43:17.651861 systemd[1]: session-18.scope: Deactivated successfully. Sep 5 05:43:17.652688 systemd-logind[1435]: Session 18 logged out. Waiting for processes to exit. Sep 5 05:43:17.655198 systemd[1]: Started sshd@18-10.0.0.49:22-10.0.0.1:58684.service - OpenSSH per-connection server daemon (10.0.0.1:58684). Sep 5 05:43:17.655864 systemd-logind[1435]: Removed session 18. Sep 5 05:43:17.717232 sshd[2407]: Accepted publickey for core from 10.0.0.1 port 58684 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:17.718620 sshd-session[2407]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:17.724275 systemd-logind[1435]: New session 19 of user core. Sep 5 05:43:17.734516 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 5 05:43:17.787601 sshd[2410]: Connection closed by 10.0.0.1 port 58684 Sep 5 05:43:17.788305 sshd-session[2407]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:17.795263 systemd[1]: sshd@18-10.0.0.49:22-10.0.0.1:58684.service: Deactivated successfully. Sep 5 05:43:17.797028 systemd[1]: session-19.scope: Deactivated successfully. Sep 5 05:43:17.797795 systemd-logind[1435]: Session 19 logged out. Waiting for processes to exit. Sep 5 05:43:17.800786 systemd[1]: Started sshd@19-10.0.0.49:22-10.0.0.1:58686.service - OpenSSH per-connection server daemon (10.0.0.1:58686). Sep 5 05:43:17.801477 systemd-logind[1435]: Removed session 19. Sep 5 05:43:17.858350 sshd[2416]: Accepted publickey for core from 10.0.0.1 port 58686 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:17.859708 sshd-session[2416]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:17.864328 systemd-logind[1435]: New session 20 of user core. Sep 5 05:43:17.871439 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 5 05:43:17.922942 sudo[2420]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2005 Sep 5 05:43:17.923195 sudo[2420]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 5 05:43:17.926048 sudo[2420]: pam_unix(sudo:session): session closed for user root Sep 5 05:43:17.927075 sshd[2419]: Connection closed by 10.0.0.1 port 58686 Sep 5 05:43:17.927493 sshd-session[2416]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:17.928722 dockerd[2033]: time="2025-09-05T05:43:17.928676841Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 5 05:43:17.929082 dockerd[2033]: time="2025-09-05T05:43:17.928727969Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 5 05:43:17.929376 dockerd[2033]: time="2025-09-05T05:43:17.928940043Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 5 05:43:17.929376 dockerd[2033]: time="2025-09-05T05:43:17.929137394Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 5 05:43:17.939206 systemd[1]: containerd.service: Deactivated successfully. Sep 5 05:43:17.939400 systemd[1]: containerd.service: Unit process 2360 (containerd-shim) remains running after unit stopped. Sep 5 05:43:17.939695 systemd[1]: containerd.service: Consumed 184ms CPU time, 121.6M memory peak. Sep 5 05:43:17.940189 systemd[1]: sshd@19-10.0.0.49:22-10.0.0.1:58686.service: Deactivated successfully. Sep 5 05:43:17.942545 systemd[1]: session-20.scope: Deactivated successfully. Sep 5 05:43:17.943239 systemd-logind[1435]: Session 20 logged out. Waiting for processes to exit. Sep 5 05:43:17.945862 systemd[1]: Started sshd@20-10.0.0.49:22-10.0.0.1:58692.service - OpenSSH per-connection server daemon (10.0.0.1:58692). Sep 5 05:43:17.946553 systemd-logind[1435]: Removed session 20. Sep 5 05:43:18.003472 sshd[2427]: Accepted publickey for core from 10.0.0.1 port 58692 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:18.004704 sshd-session[2427]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:18.009038 systemd-logind[1435]: New session 21 of user core. Sep 5 05:43:18.022459 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 5 05:43:18.075775 sshd[2430]: Connection closed by 10.0.0.1 port 58692 Sep 5 05:43:18.076252 sshd-session[2427]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:18.080569 systemd[1]: sshd@20-10.0.0.49:22-10.0.0.1:58692.service: Deactivated successfully. Sep 5 05:43:18.082624 systemd[1]: session-21.scope: Deactivated successfully. Sep 5 05:43:18.083349 systemd-logind[1435]: Session 21 logged out. Waiting for processes to exit. Sep 5 05:43:18.085559 systemd-logind[1435]: Removed session 21. Sep 5 05:43:18.851470 systemd-networkd[1377]: vethbbd152c: Gained IPv6LL Sep 5 05:43:20.583354 update_engine[1443]: I20250905 05:43:20.582827 1443 update_attempter.cc:509] Updating boot flags... Sep 5 05:43:23.142693 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 5 05:43:23.143019 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 5 05:43:23.143198 dockerd[2033]: time="2025-09-05T05:43:23.143168160Z" level=info msg="Processing signal 'terminated'" Sep 5 05:43:24.090903 systemd[1]: Started sshd@21-10.0.0.49:22-10.0.0.1:44710.service - OpenSSH per-connection server daemon (10.0.0.1:44710). Sep 5 05:43:24.131081 sshd[2454]: Accepted publickey for core from 10.0.0.1 port 44710 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:24.132113 sshd-session[2454]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:24.135331 systemd-logind[1435]: New session 22 of user core. Sep 5 05:43:24.144417 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 5 05:43:24.195090 sshd[2457]: Connection closed by 10.0.0.1 port 44710 Sep 5 05:43:24.195591 sshd-session[2454]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:24.198552 systemd[1]: sshd@21-10.0.0.49:22-10.0.0.1:44710.service: Deactivated successfully. Sep 5 05:43:24.200480 systemd[1]: session-22.scope: Deactivated successfully. Sep 5 05:43:24.201457 systemd-logind[1435]: Session 22 logged out. Waiting for processes to exit. Sep 5 05:43:24.202335 systemd-logind[1435]: Removed session 22. Sep 5 05:43:25.145537 dockerd[2033]: time="2025-09-05T05:43:25.145218280Z" level=error msg="Error sending stop (signal 15) to container" container=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba error="Cannot kill container b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 5 05:43:25.145537 dockerd[2033]: time="2025-09-05T05:43:25.145346934Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba Sep 5 05:43:30.211148 systemd[1]: Started sshd@22-10.0.0.49:22-10.0.0.1:54360.service - OpenSSH per-connection server daemon (10.0.0.1:54360). Sep 5 05:43:30.251781 sshd[2463]: Accepted publickey for core from 10.0.0.1 port 54360 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:30.252838 sshd-session[2463]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:30.256879 systemd-logind[1435]: New session 23 of user core. Sep 5 05:43:30.266438 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 5 05:43:30.317912 sshd[2466]: Connection closed by 10.0.0.1 port 54360 Sep 5 05:43:30.318177 sshd-session[2463]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:30.321115 systemd[1]: sshd@22-10.0.0.49:22-10.0.0.1:54360.service: Deactivated successfully. Sep 5 05:43:30.322487 systemd[1]: session-23.scope: Deactivated successfully. Sep 5 05:43:30.323148 systemd-logind[1435]: Session 23 logged out. Waiting for processes to exit. Sep 5 05:43:30.324165 systemd-logind[1435]: Removed session 23. Sep 5 05:43:35.147689 dockerd[2033]: time="2025-09-05T05:43:35.147617407Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba error="context deadline exceeded" Sep 5 05:43:35.148534 systemd[1]: docker-b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba.scope: Deactivated successfully. Sep 5 05:43:36.335415 systemd[1]: Started sshd@23-10.0.0.49:22-10.0.0.1:54362.service - OpenSSH per-connection server daemon (10.0.0.1:54362). Sep 5 05:43:36.400086 sshd[2472]: Accepted publickey for core from 10.0.0.1 port 54362 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:36.401173 sshd-session[2472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:36.406394 systemd-logind[1435]: New session 24 of user core. Sep 5 05:43:36.412417 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 5 05:43:36.465028 sshd[2475]: Connection closed by 10.0.0.1 port 54362 Sep 5 05:43:36.465475 sshd-session[2472]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:36.468450 systemd[1]: sshd@23-10.0.0.49:22-10.0.0.1:54362.service: Deactivated successfully. Sep 5 05:43:36.470011 systemd[1]: session-24.scope: Deactivated successfully. Sep 5 05:43:36.473208 systemd-logind[1435]: Session 24 logged out. Waiting for processes to exit. Sep 5 05:43:36.475317 systemd-logind[1435]: Removed session 24. Sep 5 05:43:38.144228 dockerd[2033]: time="2025-09-05T05:43:38.144126867Z" level=error msg="Force shutdown daemon" Sep 5 05:43:38.144794 dockerd[2033]: time="2025-09-05T05:43:38.144740066Z" level=info msg="Daemon shutdown complete" Sep 5 05:43:38.144940 dockerd[2033]: time="2025-09-05T05:43:38.144911757Z" level=warning msg="Error while testing if containerd API is ready" error="Canceled: latest balancer error: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Sep 5 05:43:38.148575 systemd[1]: docker.service: Deactivated successfully. Sep 5 05:43:38.150336 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 5 05:43:38.150812 systemd[1]: docker.socket: Deactivated successfully. Sep 5 05:43:38.151051 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 5 05:43:38.151094 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 5 05:43:38.152437 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 5 05:43:38.152655 systemd[1]: containerd.service: Found left-over process 2360 (containerd-shim) in control group while starting unit. Ignoring. Sep 5 05:43:38.152658 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 5 05:43:38.159689 systemd[1]: Starting containerd.service - containerd container runtime... Sep 5 05:43:38.159957 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 5 05:43:38.170690 systemd[1]: containerd.service: Found left-over process 2360 (containerd-shim) in control group while starting unit. Ignoring. Sep 5 05:43:38.170701 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 5 05:43:38.174674 (ntainerd)[2486]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 5 05:43:38.188196 containerd[2486]: time="2025-09-05T05:43:38Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 5 05:43:38.188674 containerd[2486]: time="2025-09-05T05:43:38.188586132Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Sep 5 05:43:38.196256 containerd[2486]: time="2025-09-05T05:43:38.196193368Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.641µs" Sep 5 05:43:38.196256 containerd[2486]: time="2025-09-05T05:43:38.196231930Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 5 05:43:38.196256 containerd[2486]: time="2025-09-05T05:43:38.196261332Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 5 05:43:38.196396 containerd[2486]: time="2025-09-05T05:43:38.196305415Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 5 05:43:38.196396 containerd[2486]: time="2025-09-05T05:43:38.196317776Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196603194Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196648837Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196660957Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196942015Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196963856Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196977217Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.196992138Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197117 containerd[2486]: time="2025-09-05T05:43:38.197018940Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197340 containerd[2486]: time="2025-09-05T05:43:38.197167069Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197340 containerd[2486]: time="2025-09-05T05:43:38.197309398Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 5 05:43:38.197340 containerd[2486]: time="2025-09-05T05:43:38.197334919Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 5 05:43:38.197392 containerd[2486]: time="2025-09-05T05:43:38.197375882Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 5 05:43:38.198075 containerd[2486]: time="2025-09-05T05:43:38.197938837Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 5 05:43:38.198390 containerd[2486]: time="2025-09-05T05:43:38.198369304Z" level=info msg="metadata content store policy set" policy=shared Sep 5 05:43:38.199005 containerd[2486]: time="2025-09-05T05:43:38.198915538Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 5 05:43:38.199115 containerd[2486]: time="2025-09-05T05:43:38.199099190Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 5 05:43:38.199189 containerd[2486]: time="2025-09-05T05:43:38.199174395Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 5 05:43:38.199260 containerd[2486]: time="2025-09-05T05:43:38.199244319Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 5 05:43:38.199330 containerd[2486]: time="2025-09-05T05:43:38.199317124Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 5 05:43:38.199397 containerd[2486]: time="2025-09-05T05:43:38.199383528Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 5 05:43:38.199448 containerd[2486]: time="2025-09-05T05:43:38.199435971Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 5 05:43:38.199517 containerd[2486]: time="2025-09-05T05:43:38.199490534Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 5 05:43:38.199571 containerd[2486]: time="2025-09-05T05:43:38.199558299Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 5 05:43:38.199623 containerd[2486]: time="2025-09-05T05:43:38.199609662Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 5 05:43:38.199680 containerd[2486]: time="2025-09-05T05:43:38.199667786Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 5 05:43:38.199735 containerd[2486]: time="2025-09-05T05:43:38.199723109Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 5 05:43:38.200012 containerd[2486]: time="2025-09-05T05:43:38.199989086Z" level=info msg="connecting to shim b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba" address="unix:///run/containerd/s/0ec954616f504edfff94e13250235ff48f7fd998b33d1fde56ea3da576902bd2" namespace=moby protocol=ttrpc version=3 Sep 5 05:43:38.206461 containerd[2486]: time="2025-09-05T05:43:38.206432849Z" level=info msg="cleaning leaked shim process" id=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba namespace=moby Sep 5 05:43:38.215475 containerd[2486]: time="2025-09-05T05:43:38.215423412Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 5 05:43:38.216347 containerd[2486]: time="2025-09-05T05:43:38.216315308Z" level=info msg="shim disconnected" id=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba namespace=moby Sep 5 05:43:38.216397 containerd[2486]: time="2025-09-05T05:43:38.216351870Z" level=warning msg="cleaning up after shim disconnected" id=b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba namespace=moby Sep 5 05:43:38.216397 containerd[2486]: time="2025-09-05T05:43:38.216395273Z" level=info msg="cleaning up dead shim" namespace=moby Sep 5 05:43:38.225914 containerd[2486]: time="2025-09-05T05:43:38.225877627Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 5 05:43:38.225974 containerd[2486]: time="2025-09-05T05:43:38.225925430Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 5 05:43:38.225974 containerd[2486]: time="2025-09-05T05:43:38.225941991Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 5 05:43:38.225974 containerd[2486]: time="2025-09-05T05:43:38.225953592Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 5 05:43:38.225974 containerd[2486]: time="2025-09-05T05:43:38.225963912Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.225975153Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.225986954Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.226002115Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.226016156Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.226027156Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 5 05:43:38.226070 containerd[2486]: time="2025-09-05T05:43:38.226037397Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 5 05:43:38.226173 containerd[2486]: time="2025-09-05T05:43:38.226097681Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 5 05:43:38.226173 containerd[2486]: time="2025-09-05T05:43:38.226115282Z" level=info msg="Start snapshots syncer" Sep 5 05:43:38.226173 containerd[2486]: time="2025-09-05T05:43:38.226138643Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 5 05:43:38.226398 containerd[2486]: time="2025-09-05T05:43:38.226367258Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 5 05:43:38.226474 containerd[2486]: time="2025-09-05T05:43:38.226418781Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 5 05:43:38.226495 containerd[2486]: time="2025-09-05T05:43:38.226483425Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 5 05:43:38.226554 containerd[2486]: time="2025-09-05T05:43:38.226536428Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 5 05:43:38.226580 containerd[2486]: time="2025-09-05T05:43:38.226570350Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 5 05:43:38.226600 containerd[2486]: time="2025-09-05T05:43:38.226584111Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 5 05:43:38.226600 containerd[2486]: time="2025-09-05T05:43:38.226594672Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 5 05:43:38.226640 containerd[2486]: time="2025-09-05T05:43:38.226607033Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 5 05:43:38.226640 containerd[2486]: time="2025-09-05T05:43:38.226618273Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 5 05:43:38.226640 containerd[2486]: time="2025-09-05T05:43:38.226628074Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 5 05:43:38.226689 containerd[2486]: time="2025-09-05T05:43:38.226652475Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 5 05:43:38.226689 containerd[2486]: time="2025-09-05T05:43:38.226664356Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 5 05:43:38.226689 containerd[2486]: time="2025-09-05T05:43:38.226674637Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 5 05:43:38.226739 containerd[2486]: time="2025-09-05T05:43:38.226709439Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:43:38.226739 containerd[2486]: time="2025-09-05T05:43:38.226723720Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 5 05:43:38.226739 containerd[2486]: time="2025-09-05T05:43:38.226732160Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226742001Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226750642Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226760882Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226770843Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226786764Z" level=info msg="runtime interface created" Sep 5 05:43:38.226791 containerd[2486]: time="2025-09-05T05:43:38.226791364Z" level=info msg="created NRI interface" Sep 5 05:43:38.226889 containerd[2486]: time="2025-09-05T05:43:38.226802685Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 5 05:43:38.226889 containerd[2486]: time="2025-09-05T05:43:38.226814006Z" level=info msg="Connect containerd service" Sep 5 05:43:38.226889 containerd[2486]: time="2025-09-05T05:43:38.226837847Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 5 05:43:38.227280 containerd[2486]: time="2025-09-05T05:43:38.227252433Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 5 05:43:38.235694 containerd[2486]: time="2025-09-05T05:43:38.235604116Z" level=info msg="Start subscribing containerd event" Sep 5 05:43:38.235694 containerd[2486]: time="2025-09-05T05:43:38.235663800Z" level=info msg="Start recovering state" Sep 5 05:43:38.236032 containerd[2486]: time="2025-09-05T05:43:38.236005141Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 5 05:43:38.236142 containerd[2486]: time="2025-09-05T05:43:38.236125469Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 5 05:43:38.236415 containerd[2486]: time="2025-09-05T05:43:38.236389485Z" level=info msg="Start event monitor" Sep 5 05:43:38.236452 containerd[2486]: time="2025-09-05T05:43:38.236413687Z" level=info msg="Start cni network conf syncer for default" Sep 5 05:43:38.236452 containerd[2486]: time="2025-09-05T05:43:38.236427888Z" level=info msg="Start streaming server" Sep 5 05:43:38.236452 containerd[2486]: time="2025-09-05T05:43:38.236437808Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 5 05:43:38.236452 containerd[2486]: time="2025-09-05T05:43:38.236447729Z" level=info msg="runtime interface starting up..." Sep 5 05:43:38.236554 containerd[2486]: time="2025-09-05T05:43:38.236458290Z" level=info msg="starting plugins..." Sep 5 05:43:38.236554 containerd[2486]: time="2025-09-05T05:43:38.236467330Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 5 05:43:38.236760 systemd[1]: Started containerd.service - containerd container runtime. Sep 5 05:43:38.237042 containerd[2486]: time="2025-09-05T05:43:38.237018085Z" level=info msg="containerd successfully booted in 0.049004s" Sep 5 05:43:38.238320 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 5 05:43:38.257585 (dockerd)[2534]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 5 05:43:38.282955 dockerd[2534]: time="2025-09-05T05:43:38.282896678Z" level=info msg="Starting up" Sep 5 05:43:38.283397 dockerd[2534]: time="2025-09-05T05:43:38.283378428Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 5 05:43:38.292057 dockerd[2534]: time="2025-09-05T05:43:38.292022809Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 5 05:43:38.307898 dockerd[2534]: time="2025-09-05T05:43:38.307855921Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 5 05:43:38.315422 dockerd[2534]: time="2025-09-05T05:43:38.315358550Z" level=info msg="Loading containers: start." Sep 5 05:43:38.327009 systemd[1]: var-lib-docker-overlay2-066a8eb3d45aa27e781a25b8b9ee9520ecaa8c576c7c1b75a83e662c1d5d1c67-merged.mount: Deactivated successfully. Sep 5 05:43:38.715126 systemd-networkd[1377]: vethbbd152c: Link DOWN Sep 5 05:43:38.715133 systemd-networkd[1377]: vethbbd152c: Lost carrier Sep 5 05:43:38.716348 kernel: docker0: port 1(vethbbd152c) entered disabled state Sep 5 05:43:38.717783 kernel: vethbbd152c (unregistering): left allmulticast mode Sep 5 05:43:38.717821 kernel: vethbbd152c (unregistering): left promiscuous mode Sep 5 05:43:38.717836 kernel: docker0: port 1(vethbbd152c) entered disabled state Sep 5 05:43:38.719519 systemd-networkd[1377]: docker0: Lost carrier Sep 5 05:43:38.720872 dockerd[2534]: time="2025-09-05T05:43:38.720089256Z" level=info msg="Removing stale sandbox fc8d4aa008b14a25f89ca81e13d53a4a6663a88ae0cddb2335b7cb0545d113d3 (b42f36968228225bfd2540a9291fec9fb30eee923bf8c52ffcb1cc3f3fe1b2ba)" Sep 5 05:43:38.723196 dockerd[2534]: time="2025-09-05T05:43:38.723169889Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Sep 5 05:43:38.723364 dockerd[2534]: time="2025-09-05T05:43:38.723310378Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 05d1aca0a8dd1ed0a41e630c512f4853d5bab54b320b5bdbe59f8fa5fc161b59 aa4d38b6146f285407f2e6c29e3adbceeeb4287f9d9d2cc765b5e45e8ebb42a9], retrying...." Sep 5 05:43:38.864208 dockerd[2534]: time="2025-09-05T05:43:38.864165239Z" level=warning msg="error locating sandbox id 5df74e16a680cf322f3e4997c3c14a19facaacb95ce846bb4420c91f75b6137e: sandbox 5df74e16a680cf322f3e4997c3c14a19facaacb95ce846bb4420c91f75b6137e not found" Sep 5 05:43:38.864208 dockerd[2534]: time="2025-09-05T05:43:38.864207801Z" level=warning msg="error locating sandbox id fc8d4aa008b14a25f89ca81e13d53a4a6663a88ae0cddb2335b7cb0545d113d3: sandbox fc8d4aa008b14a25f89ca81e13d53a4a6663a88ae0cddb2335b7cb0545d113d3 not found" Sep 5 05:43:38.864429 dockerd[2534]: time="2025-09-05T05:43:38.864413294Z" level=info msg="Loading containers: done." Sep 5 05:43:38.873379 dockerd[2534]: time="2025-09-05T05:43:38.873334853Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 5 05:43:38.873510 dockerd[2534]: time="2025-09-05T05:43:38.873411538Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Sep 5 05:43:38.873510 dockerd[2534]: time="2025-09-05T05:43:38.873443700Z" level=info msg="Initializing buildkit" Sep 5 05:43:38.885256 dockerd[2534]: time="2025-09-05T05:43:38.885135952Z" level=info msg="Completed buildkit initialization" Sep 5 05:43:38.891829 dockerd[2534]: time="2025-09-05T05:43:38.891794329Z" level=info msg="Daemon has completed initialization" Sep 5 05:43:38.891907 dockerd[2534]: time="2025-09-05T05:43:38.891855213Z" level=info msg="API listen on /run/docker.sock" Sep 5 05:43:38.892075 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 5 05:43:39.299584 systemd[1]: run-docker-netns-fc8d4aa008b1.mount: Deactivated successfully. Sep 5 05:43:42.483397 systemd[1]: Started sshd@24-10.0.0.49:22-10.0.0.1:34526.service - OpenSSH per-connection server daemon (10.0.0.1:34526). Sep 5 05:43:42.541842 sshd[2771]: Accepted publickey for core from 10.0.0.1 port 34526 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:42.542962 sshd-session[2771]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:42.546751 systemd-logind[1435]: New session 25 of user core. Sep 5 05:43:42.561422 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 5 05:43:42.614424 sshd[2774]: Connection closed by 10.0.0.1 port 34526 Sep 5 05:43:42.614714 sshd-session[2771]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:42.626154 systemd[1]: sshd@24-10.0.0.49:22-10.0.0.1:34526.service: Deactivated successfully. Sep 5 05:43:42.628581 systemd[1]: session-25.scope: Deactivated successfully. Sep 5 05:43:42.629195 systemd-logind[1435]: Session 25 logged out. Waiting for processes to exit. Sep 5 05:43:42.631221 systemd[1]: Started sshd@25-10.0.0.49:22-10.0.0.1:34530.service - OpenSSH per-connection server daemon (10.0.0.1:34530). Sep 5 05:43:42.631761 systemd-logind[1435]: Removed session 25. Sep 5 05:43:42.688356 sshd[2780]: Accepted publickey for core from 10.0.0.1 port 34530 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:42.689514 sshd-session[2780]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:42.693375 systemd-logind[1435]: New session 26 of user core. Sep 5 05:43:42.699412 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 5 05:43:42.750778 sshd[2783]: Connection closed by 10.0.0.1 port 34530 Sep 5 05:43:42.751157 sshd-session[2780]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:42.762047 systemd[1]: sshd@25-10.0.0.49:22-10.0.0.1:34530.service: Deactivated successfully. Sep 5 05:43:42.764471 systemd[1]: session-26.scope: Deactivated successfully. Sep 5 05:43:42.765051 systemd-logind[1435]: Session 26 logged out. Waiting for processes to exit. Sep 5 05:43:42.767023 systemd[1]: Started sshd@26-10.0.0.49:22-10.0.0.1:34544.service - OpenSSH per-connection server daemon (10.0.0.1:34544). Sep 5 05:43:42.767468 systemd-logind[1435]: Removed session 26. Sep 5 05:43:42.807612 sshd[2789]: Accepted publickey for core from 10.0.0.1 port 34544 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:42.808738 sshd-session[2789]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:42.812305 systemd-logind[1435]: New session 27 of user core. Sep 5 05:43:42.820421 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 5 05:43:42.875240 sshd[2792]: Connection closed by 10.0.0.1 port 34544 Sep 5 05:43:42.875545 sshd-session[2789]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:42.889198 systemd[1]: sshd@26-10.0.0.49:22-10.0.0.1:34544.service: Deactivated successfully. Sep 5 05:43:42.892483 systemd[1]: session-27.scope: Deactivated successfully. Sep 5 05:43:42.893088 systemd-logind[1435]: Session 27 logged out. Waiting for processes to exit. Sep 5 05:43:42.895561 systemd[1]: Started sshd@27-10.0.0.49:22-10.0.0.1:34550.service - OpenSSH per-connection server daemon (10.0.0.1:34550). Sep 5 05:43:42.896851 systemd-logind[1435]: Removed session 27. Sep 5 05:43:42.941154 sshd[2806]: Accepted publickey for core from 10.0.0.1 port 34550 ssh2: RSA SHA256:xkXFnONh5NSK++8uJoUtZG7bJt4aRGla06bk3BJ3qjE Sep 5 05:43:42.942423 sshd-session[2806]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 5 05:43:42.946865 systemd-logind[1435]: New session 28 of user core. Sep 5 05:43:42.964443 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 5 05:43:43.032243 systemd[1]: var-lib-docker-overlay2-326d9fa37e60bc8385468e590205f10770994a1e13ad2a85bf5c460843fce03e\x2dinit-merged.mount: Deactivated successfully. Sep 5 05:43:43.063700 containerd[2486]: time="2025-09-05T05:43:43.063662695Z" level=info msg="connecting to shim 59128dfe4cdbfde688394ac4b5b07b22c81f311a25468c794cd0fca325d65da0" address="unix:///run/containerd/s/4e87e2eea895ced2d568036b924dfc352b148ad15c0f2af3897497302923b69c" namespace=moby protocol=ttrpc version=3 Sep 5 05:43:43.093481 systemd[1]: Started docker-59128dfe4cdbfde688394ac4b5b07b22c81f311a25468c794cd0fca325d65da0.scope - libcontainer container 59128dfe4cdbfde688394ac4b5b07b22c81f311a25468c794cd0fca325d65da0. Sep 5 05:43:43.103268 systemd-resolved[1292]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 5 05:43:43.118570 kernel: docker0: port 1(veth3bce736) entered blocking state Sep 5 05:43:43.118636 kernel: docker0: port 1(veth3bce736) entered disabled state Sep 5 05:43:43.118652 kernel: veth3bce736: entered allmulticast mode Sep 5 05:43:43.119531 kernel: veth3bce736: entered promiscuous mode Sep 5 05:43:43.119882 systemd-networkd[1377]: veth3bce736: Link UP Sep 5 05:43:43.124309 kernel: eth0: renamed from vethfeb42df Sep 5 05:43:43.125729 kernel: docker0: port 1(veth3bce736) entered blocking state Sep 5 05:43:43.125797 kernel: docker0: port 1(veth3bce736) entered forwarding state Sep 5 05:43:43.125837 systemd-networkd[1377]: veth3bce736: Gained carrier Sep 5 05:43:43.126171 systemd-networkd[1377]: docker0: Gained carrier Sep 5 05:43:43.144610 sshd[2809]: Connection closed by 10.0.0.1 port 34550 Sep 5 05:43:43.144916 sshd-session[2806]: pam_unix(sshd:session): session closed for user core Sep 5 05:43:43.148504 systemd[1]: sshd@27-10.0.0.49:22-10.0.0.1:34550.service: Deactivated successfully. Sep 5 05:43:43.149948 systemd[1]: session-28.scope: Deactivated successfully. Sep 5 05:43:43.150579 systemd-logind[1435]: Session 28 logged out. Waiting for processes to exit. Sep 5 05:43:43.151458 systemd-logind[1435]: Removed session 28. Sep 5 05:43:44.707423 systemd-networkd[1377]: veth3bce736: Gained IPv6LL