Jul 12 09:51:51.780316 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 12 09:51:51.780337 kernel: Linux version 6.12.36-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 p1) 2.44.0) #1 SMP PREEMPT Sat Jul 12 08:24:03 -00 2025 Jul 12 09:51:51.780346 kernel: KASLR enabled Jul 12 09:51:51.780352 kernel: efi: EFI v2.7 by EDK II Jul 12 09:51:51.780358 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb832018 ACPI 2.0=0xdbfd0018 RNG=0xdbfd0a18 MEMRESERVE=0xdb838218 Jul 12 09:51:51.780363 kernel: random: crng init done Jul 12 09:51:51.780370 kernel: secureboot: Secure boot disabled Jul 12 09:51:51.780376 kernel: ACPI: Early table checksum verification disabled Jul 12 09:51:51.780382 kernel: ACPI: RSDP 0x00000000DBFD0018 000024 (v02 BOCHS ) Jul 12 09:51:51.780388 kernel: ACPI: XSDT 0x00000000DBFD0F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 12 09:51:51.780394 kernel: ACPI: FACP 0x00000000DBFD0B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780400 kernel: ACPI: DSDT 0x00000000DBF0E018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780405 kernel: ACPI: APIC 0x00000000DBFD0C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780411 kernel: ACPI: PPTT 0x00000000DBFD0098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780418 kernel: ACPI: GTDT 0x00000000DBFD0818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780425 kernel: ACPI: MCFG 0x00000000DBFD0A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780431 kernel: ACPI: SPCR 0x00000000DBFD0918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780437 kernel: ACPI: DBG2 0x00000000DBFD0998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780443 kernel: ACPI: IORT 0x00000000DBFD0198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 12 09:51:51.780449 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 12 09:51:51.780455 kernel: ACPI: Use ACPI SPCR as default console: Yes Jul 12 09:51:51.780461 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 12 09:51:51.780467 kernel: NODE_DATA(0) allocated [mem 0xdc965a00-0xdc96cfff] Jul 12 09:51:51.780473 kernel: Zone ranges: Jul 12 09:51:51.780479 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 12 09:51:51.780487 kernel: DMA32 empty Jul 12 09:51:51.780493 kernel: Normal empty Jul 12 09:51:51.780499 kernel: Device empty Jul 12 09:51:51.780505 kernel: Movable zone start for each node Jul 12 09:51:51.780510 kernel: Early memory node ranges Jul 12 09:51:51.780516 kernel: node 0: [mem 0x0000000040000000-0x00000000db81ffff] Jul 12 09:51:51.780522 kernel: node 0: [mem 0x00000000db820000-0x00000000db82ffff] Jul 12 09:51:51.780528 kernel: node 0: [mem 0x00000000db830000-0x00000000dc09ffff] Jul 12 09:51:51.780534 kernel: node 0: [mem 0x00000000dc0a0000-0x00000000dc2dffff] Jul 12 09:51:51.780540 kernel: node 0: [mem 0x00000000dc2e0000-0x00000000dc36ffff] Jul 12 09:51:51.780546 kernel: node 0: [mem 0x00000000dc370000-0x00000000dc45ffff] Jul 12 09:51:51.780553 kernel: node 0: [mem 0x00000000dc460000-0x00000000dc52ffff] Jul 12 09:51:51.780560 kernel: node 0: [mem 0x00000000dc530000-0x00000000dc5cffff] Jul 12 09:51:51.780566 kernel: node 0: [mem 0x00000000dc5d0000-0x00000000dce1ffff] Jul 12 09:51:51.780572 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Jul 12 09:51:51.780580 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Jul 12 09:51:51.780587 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Jul 12 09:51:51.780593 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 12 09:51:51.780601 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 12 09:51:51.780607 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 12 09:51:51.780613 kernel: cma: Reserved 16 MiB at 0x00000000d8000000 on node -1 Jul 12 09:51:51.780620 kernel: psci: probing for conduit method from ACPI. Jul 12 09:51:51.780626 kernel: psci: PSCIv1.1 detected in firmware. Jul 12 09:51:51.780632 kernel: psci: Using standard PSCI v0.2 function IDs Jul 12 09:51:51.780639 kernel: psci: Trusted OS migration not required Jul 12 09:51:51.780645 kernel: psci: SMC Calling Convention v1.1 Jul 12 09:51:51.780651 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 12 09:51:51.780658 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jul 12 09:51:51.780665 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jul 12 09:51:51.780672 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 12 09:51:51.780678 kernel: Detected PIPT I-cache on CPU0 Jul 12 09:51:51.780685 kernel: CPU features: detected: GIC system register CPU interface Jul 12 09:51:51.780691 kernel: CPU features: detected: Spectre-v4 Jul 12 09:51:51.780697 kernel: CPU features: detected: Spectre-BHB Jul 12 09:51:51.780703 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 12 09:51:51.780710 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 12 09:51:51.780716 kernel: CPU features: detected: ARM erratum 1418040 Jul 12 09:51:51.780722 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 12 09:51:51.780729 kernel: alternatives: applying boot alternatives Jul 12 09:51:51.780736 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=2eed6122ab9d95fa96c8f5511b96c1220a0caf18bbf7b84035ef573d9ba90496 Jul 12 09:51:51.780744 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 12 09:51:51.780750 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 12 09:51:51.780757 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 12 09:51:51.780763 kernel: Fallback order for Node 0: 0 Jul 12 09:51:51.780770 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Jul 12 09:51:51.780784 kernel: Policy zone: DMA Jul 12 09:51:51.780790 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 12 09:51:51.780797 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Jul 12 09:51:51.780803 kernel: software IO TLB: area num 4. Jul 12 09:51:51.780810 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Jul 12 09:51:51.780816 kernel: software IO TLB: mapped [mem 0x00000000d7c00000-0x00000000d8000000] (4MB) Jul 12 09:51:51.780824 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 12 09:51:51.780831 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 12 09:51:51.780838 kernel: rcu: RCU event tracing is enabled. Jul 12 09:51:51.780844 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 12 09:51:51.780851 kernel: Trampoline variant of Tasks RCU enabled. Jul 12 09:51:51.780857 kernel: Tracing variant of Tasks RCU enabled. Jul 12 09:51:51.780863 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 12 09:51:51.780870 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 12 09:51:51.780876 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 12 09:51:51.780883 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 12 09:51:51.780889 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 12 09:51:51.780897 kernel: GICv3: 256 SPIs implemented Jul 12 09:51:51.780903 kernel: GICv3: 0 Extended SPIs implemented Jul 12 09:51:51.780909 kernel: Root IRQ handler: gic_handle_irq Jul 12 09:51:51.780916 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 12 09:51:51.780922 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Jul 12 09:51:51.780928 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 12 09:51:51.780935 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 12 09:51:51.780962 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Jul 12 09:51:51.780968 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Jul 12 09:51:51.780975 kernel: GICv3: using LPI property table @0x0000000040130000 Jul 12 09:51:51.780981 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Jul 12 09:51:51.780988 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 12 09:51:51.780996 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 12 09:51:51.781002 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 12 09:51:51.781009 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 12 09:51:51.781015 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 12 09:51:51.781022 kernel: arm-pv: using stolen time PV Jul 12 09:51:51.781028 kernel: Console: colour dummy device 80x25 Jul 12 09:51:51.781035 kernel: ACPI: Core revision 20240827 Jul 12 09:51:51.781042 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 12 09:51:51.781048 kernel: pid_max: default: 32768 minimum: 301 Jul 12 09:51:51.781055 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 12 09:51:51.781062 kernel: landlock: Up and running. Jul 12 09:51:51.781069 kernel: SELinux: Initializing. Jul 12 09:51:51.781075 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 12 09:51:51.781082 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 12 09:51:51.781089 kernel: rcu: Hierarchical SRCU implementation. Jul 12 09:51:51.781095 kernel: rcu: Max phase no-delay instances is 400. Jul 12 09:51:51.781102 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 12 09:51:51.781109 kernel: Remapping and enabling EFI services. Jul 12 09:51:51.781115 kernel: smp: Bringing up secondary CPUs ... Jul 12 09:51:51.781127 kernel: Detected PIPT I-cache on CPU1 Jul 12 09:51:51.781134 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 12 09:51:51.781141 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Jul 12 09:51:51.781149 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 12 09:51:51.781156 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 12 09:51:51.781162 kernel: Detected PIPT I-cache on CPU2 Jul 12 09:51:51.781170 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 12 09:51:51.781176 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Jul 12 09:51:51.781185 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 12 09:51:51.781192 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 12 09:51:51.781198 kernel: Detected PIPT I-cache on CPU3 Jul 12 09:51:51.781205 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 12 09:51:51.781212 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Jul 12 09:51:51.781219 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 12 09:51:51.781226 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 12 09:51:51.781233 kernel: smp: Brought up 1 node, 4 CPUs Jul 12 09:51:51.781239 kernel: SMP: Total of 4 processors activated. Jul 12 09:51:51.781247 kernel: CPU: All CPU(s) started at EL1 Jul 12 09:51:51.781254 kernel: CPU features: detected: 32-bit EL0 Support Jul 12 09:51:51.781262 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 12 09:51:51.781269 kernel: CPU features: detected: Common not Private translations Jul 12 09:51:51.781275 kernel: CPU features: detected: CRC32 instructions Jul 12 09:51:51.781282 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 12 09:51:51.781289 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 12 09:51:51.781296 kernel: CPU features: detected: LSE atomic instructions Jul 12 09:51:51.781303 kernel: CPU features: detected: Privileged Access Never Jul 12 09:51:51.781311 kernel: CPU features: detected: RAS Extension Support Jul 12 09:51:51.781318 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 12 09:51:51.781325 kernel: alternatives: applying system-wide alternatives Jul 12 09:51:51.781332 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Jul 12 09:51:51.781339 kernel: Memory: 2424032K/2572288K available (11136K kernel code, 2436K rwdata, 9056K rodata, 39424K init, 1038K bss, 125920K reserved, 16384K cma-reserved) Jul 12 09:51:51.781346 kernel: devtmpfs: initialized Jul 12 09:51:51.781353 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 12 09:51:51.781360 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 12 09:51:51.781367 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 12 09:51:51.781375 kernel: 0 pages in range for non-PLT usage Jul 12 09:51:51.781382 kernel: 508448 pages in range for PLT usage Jul 12 09:51:51.781389 kernel: pinctrl core: initialized pinctrl subsystem Jul 12 09:51:51.781396 kernel: SMBIOS 3.0.0 present. Jul 12 09:51:51.781403 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jul 12 09:51:51.781410 kernel: DMI: Memory slots populated: 1/1 Jul 12 09:51:51.781417 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 12 09:51:51.781424 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 12 09:51:51.781431 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 12 09:51:51.781439 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 12 09:51:51.781446 kernel: audit: initializing netlink subsys (disabled) Jul 12 09:51:51.781453 kernel: audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 Jul 12 09:51:51.781460 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 12 09:51:51.781467 kernel: cpuidle: using governor menu Jul 12 09:51:51.781473 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 12 09:51:51.781480 kernel: ASID allocator initialised with 32768 entries Jul 12 09:51:51.781487 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 12 09:51:51.781494 kernel: Serial: AMBA PL011 UART driver Jul 12 09:51:51.781502 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 12 09:51:51.781509 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 12 09:51:51.781516 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 12 09:51:51.781522 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 12 09:51:51.781529 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 12 09:51:51.781536 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 12 09:51:51.781543 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 12 09:51:51.781550 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 12 09:51:51.781557 kernel: ACPI: Added _OSI(Module Device) Jul 12 09:51:51.781565 kernel: ACPI: Added _OSI(Processor Device) Jul 12 09:51:51.781572 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 12 09:51:51.781579 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 12 09:51:51.781586 kernel: ACPI: Interpreter enabled Jul 12 09:51:51.781593 kernel: ACPI: Using GIC for interrupt routing Jul 12 09:51:51.781599 kernel: ACPI: MCFG table detected, 1 entries Jul 12 09:51:51.781606 kernel: ACPI: CPU0 has been hot-added Jul 12 09:51:51.781613 kernel: ACPI: CPU1 has been hot-added Jul 12 09:51:51.781620 kernel: ACPI: CPU2 has been hot-added Jul 12 09:51:51.781626 kernel: ACPI: CPU3 has been hot-added Jul 12 09:51:51.781635 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 12 09:51:51.781641 kernel: printk: legacy console [ttyAMA0] enabled Jul 12 09:51:51.781649 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 12 09:51:51.781800 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 12 09:51:51.781869 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 12 09:51:51.781927 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 12 09:51:51.782023 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 12 09:51:51.782086 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 12 09:51:51.782095 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 12 09:51:51.782102 kernel: PCI host bridge to bus 0000:00 Jul 12 09:51:51.782166 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 12 09:51:51.782220 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 12 09:51:51.782272 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 12 09:51:51.782323 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 12 09:51:51.782402 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Jul 12 09:51:51.782471 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 12 09:51:51.782530 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Jul 12 09:51:51.782589 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Jul 12 09:51:51.782647 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Jul 12 09:51:51.782705 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Jul 12 09:51:51.782763 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Jul 12 09:51:51.782834 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Jul 12 09:51:51.782888 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 12 09:51:51.782950 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 12 09:51:51.783006 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 12 09:51:51.783015 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 12 09:51:51.783023 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 12 09:51:51.783030 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 12 09:51:51.783039 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 12 09:51:51.783046 kernel: iommu: Default domain type: Translated Jul 12 09:51:51.783053 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 12 09:51:51.783060 kernel: efivars: Registered efivars operations Jul 12 09:51:51.783067 kernel: vgaarb: loaded Jul 12 09:51:51.783073 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 12 09:51:51.783080 kernel: VFS: Disk quotas dquot_6.6.0 Jul 12 09:51:51.783087 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 12 09:51:51.783094 kernel: pnp: PnP ACPI init Jul 12 09:51:51.783163 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 12 09:51:51.783173 kernel: pnp: PnP ACPI: found 1 devices Jul 12 09:51:51.783180 kernel: NET: Registered PF_INET protocol family Jul 12 09:51:51.783187 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 12 09:51:51.783194 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 12 09:51:51.783201 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 12 09:51:51.783208 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 12 09:51:51.783215 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 12 09:51:51.783224 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 12 09:51:51.783231 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 12 09:51:51.783238 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 12 09:51:51.783245 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 12 09:51:51.783251 kernel: PCI: CLS 0 bytes, default 64 Jul 12 09:51:51.783258 kernel: kvm [1]: HYP mode not available Jul 12 09:51:51.783265 kernel: Initialise system trusted keyrings Jul 12 09:51:51.783272 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 12 09:51:51.783279 kernel: Key type asymmetric registered Jul 12 09:51:51.783287 kernel: Asymmetric key parser 'x509' registered Jul 12 09:51:51.783294 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 12 09:51:51.783301 kernel: io scheduler mq-deadline registered Jul 12 09:51:51.783308 kernel: io scheduler kyber registered Jul 12 09:51:51.783315 kernel: io scheduler bfq registered Jul 12 09:51:51.783322 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 12 09:51:51.783329 kernel: ACPI: button: Power Button [PWRB] Jul 12 09:51:51.783336 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 12 09:51:51.783394 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 12 09:51:51.783405 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 12 09:51:51.783412 kernel: thunder_xcv, ver 1.0 Jul 12 09:51:51.783419 kernel: thunder_bgx, ver 1.0 Jul 12 09:51:51.783426 kernel: nicpf, ver 1.0 Jul 12 09:51:51.783432 kernel: nicvf, ver 1.0 Jul 12 09:51:51.783502 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 12 09:51:51.783558 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-12T09:51:51 UTC (1752313911) Jul 12 09:51:51.783568 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 12 09:51:51.783576 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Jul 12 09:51:51.783583 kernel: watchdog: NMI not fully supported Jul 12 09:51:51.783590 kernel: watchdog: Hard watchdog permanently disabled Jul 12 09:51:51.783597 kernel: NET: Registered PF_INET6 protocol family Jul 12 09:51:51.783604 kernel: Segment Routing with IPv6 Jul 12 09:51:51.783611 kernel: In-situ OAM (IOAM) with IPv6 Jul 12 09:51:51.783618 kernel: NET: Registered PF_PACKET protocol family Jul 12 09:51:51.783625 kernel: Key type dns_resolver registered Jul 12 09:51:51.783632 kernel: registered taskstats version 1 Jul 12 09:51:51.783639 kernel: Loading compiled-in X.509 certificates Jul 12 09:51:51.783647 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: 5833903fd926e330df1283c2ccd9d99e7cfa4219' Jul 12 09:51:51.783654 kernel: Demotion targets for Node 0: null Jul 12 09:51:51.783661 kernel: Key type .fscrypt registered Jul 12 09:51:51.783668 kernel: Key type fscrypt-provisioning registered Jul 12 09:51:51.783675 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 12 09:51:51.783682 kernel: ima: Allocated hash algorithm: sha1 Jul 12 09:51:51.783689 kernel: ima: No architecture policies found Jul 12 09:51:51.783696 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 12 09:51:51.783704 kernel: clk: Disabling unused clocks Jul 12 09:51:51.783711 kernel: PM: genpd: Disabling unused power domains Jul 12 09:51:51.783718 kernel: Warning: unable to open an initial console. Jul 12 09:51:51.783725 kernel: Freeing unused kernel memory: 39424K Jul 12 09:51:51.783732 kernel: Run /init as init process Jul 12 09:51:51.783739 kernel: with arguments: Jul 12 09:51:51.783746 kernel: /init Jul 12 09:51:51.783753 kernel: with environment: Jul 12 09:51:51.783760 kernel: HOME=/ Jul 12 09:51:51.783768 kernel: TERM=linux Jul 12 09:51:51.783783 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 12 09:51:51.783792 systemd[1]: Successfully made /usr/ read-only. Jul 12 09:51:51.783802 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) Jul 12 09:51:51.783810 systemd[1]: Detected virtualization kvm. Jul 12 09:51:51.783817 systemd[1]: Detected architecture arm64. Jul 12 09:51:51.783824 systemd[1]: Running in initrd. Jul 12 09:51:51.783831 systemd[1]: No hostname configured, using default hostname. Jul 12 09:51:51.783840 systemd[1]: Hostname set to . Jul 12 09:51:51.783848 systemd[1]: Initializing machine ID from VM UUID. Jul 12 09:51:51.783855 systemd[1]: Queued start job for default target initrd.target. Jul 12 09:51:51.783862 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 12 09:51:51.783870 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 12 09:51:51.783878 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 12 09:51:51.783886 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 12 09:51:51.783893 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 12 09:51:51.783902 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 12 09:51:51.783911 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 12 09:51:51.783918 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 12 09:51:51.783926 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 12 09:51:51.783933 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 12 09:51:51.783949 systemd[1]: Reached target paths.target - Path Units. Jul 12 09:51:51.783958 systemd[1]: Reached target slices.target - Slice Units. Jul 12 09:51:51.783966 systemd[1]: Reached target swap.target - Swaps. Jul 12 09:51:51.783973 systemd[1]: Reached target timers.target - Timer Units. Jul 12 09:51:51.783981 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 12 09:51:51.783988 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 12 09:51:51.783996 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 12 09:51:51.784004 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 12 09:51:51.784011 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 12 09:51:51.784019 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 12 09:51:51.784028 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 12 09:51:51.784035 systemd[1]: Reached target sockets.target - Socket Units. Jul 12 09:51:51.784043 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 12 09:51:51.784050 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 12 09:51:51.784058 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 12 09:51:51.784065 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). Jul 12 09:51:51.784073 systemd[1]: Starting systemd-fsck-usr.service... Jul 12 09:51:51.784080 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 12 09:51:51.784089 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 12 09:51:51.784096 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 12 09:51:51.784104 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 12 09:51:51.784112 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 12 09:51:51.784119 systemd[1]: Finished systemd-fsck-usr.service. Jul 12 09:51:51.784128 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 12 09:51:51.784155 systemd-journald[244]: Collecting audit messages is disabled. Jul 12 09:51:51.784173 systemd-journald[244]: Journal started Jul 12 09:51:51.784193 systemd-journald[244]: Runtime Journal (/run/log/journal/fef6edd1f4c24456b84e1230ad376002) is 6M, max 48.5M, 42.4M free. Jul 12 09:51:51.773631 systemd-modules-load[245]: Inserted module 'overlay' Jul 12 09:51:51.793540 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 12 09:51:51.793561 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 12 09:51:51.794864 systemd-modules-load[245]: Inserted module 'br_netfilter' Jul 12 09:51:51.796116 kernel: Bridge firewalling registered Jul 12 09:51:51.796133 systemd[1]: Started systemd-journald.service - Journal Service. Jul 12 09:51:51.797176 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 12 09:51:51.798968 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 12 09:51:51.801845 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 12 09:51:51.803373 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 12 09:51:51.806088 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 12 09:51:51.810345 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 12 09:51:51.818505 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 12 09:51:51.820585 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 12 09:51:51.821437 systemd-tmpfiles[271]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 12 09:51:51.824054 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 12 09:51:51.825994 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 12 09:51:51.828062 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 12 09:51:51.829971 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 12 09:51:51.859176 dracut-cmdline[288]: 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=2eed6122ab9d95fa96c8f5511b96c1220a0caf18bbf7b84035ef573d9ba90496 Jul 12 09:51:51.875630 systemd-resolved[289]: Positive Trust Anchors: Jul 12 09:51:51.875651 systemd-resolved[289]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 12 09:51:51.875683 systemd-resolved[289]: 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 Jul 12 09:51:51.880540 systemd-resolved[289]: Defaulting to hostname 'linux'. Jul 12 09:51:51.881537 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 12 09:51:51.883390 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 12 09:51:51.941976 kernel: SCSI subsystem initialized Jul 12 09:51:51.946957 kernel: Loading iSCSI transport class v2.0-870. Jul 12 09:51:51.953964 kernel: iscsi: registered transport (tcp) Jul 12 09:51:51.966980 kernel: iscsi: registered transport (qla4xxx) Jul 12 09:51:51.967040 kernel: QLogic iSCSI HBA Driver Jul 12 09:51:51.983977 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 12 09:51:52.002719 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 12 09:51:52.004724 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 12 09:51:52.049012 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 12 09:51:52.052104 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 12 09:51:52.116971 kernel: raid6: neonx8 gen() 15789 MB/s Jul 12 09:51:52.133968 kernel: raid6: neonx4 gen() 15834 MB/s Jul 12 09:51:52.150962 kernel: raid6: neonx2 gen() 13223 MB/s Jul 12 09:51:52.167962 kernel: raid6: neonx1 gen() 10460 MB/s Jul 12 09:51:52.184954 kernel: raid6: int64x8 gen() 6905 MB/s Jul 12 09:51:52.201962 kernel: raid6: int64x4 gen() 7365 MB/s Jul 12 09:51:52.218962 kernel: raid6: int64x2 gen() 6109 MB/s Jul 12 09:51:52.235956 kernel: raid6: int64x1 gen() 5056 MB/s Jul 12 09:51:52.235970 kernel: raid6: using algorithm neonx4 gen() 15834 MB/s Jul 12 09:51:52.252960 kernel: raid6: .... xor() 12333 MB/s, rmw enabled Jul 12 09:51:52.252979 kernel: raid6: using neon recovery algorithm Jul 12 09:51:52.257955 kernel: xor: measuring software checksum speed Jul 12 09:51:52.257970 kernel: 8regs : 21601 MB/sec Jul 12 09:51:52.259330 kernel: 32regs : 19313 MB/sec Jul 12 09:51:52.259359 kernel: arm64_neon : 28061 MB/sec Jul 12 09:51:52.259377 kernel: xor: using function: arm64_neon (28061 MB/sec) Jul 12 09:51:52.314967 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 12 09:51:52.322029 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 12 09:51:52.324402 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 12 09:51:52.355461 systemd-udevd[500]: Using default interface naming scheme 'v255'. Jul 12 09:51:52.360302 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 12 09:51:52.362182 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 12 09:51:52.385513 dracut-pre-trigger[508]: rd.md=0: removing MD RAID activation Jul 12 09:51:52.408342 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 12 09:51:52.410546 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 12 09:51:52.466622 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 12 09:51:52.468637 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 12 09:51:52.521964 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 12 09:51:52.522165 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 12 09:51:52.525317 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 12 09:51:52.525454 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 12 09:51:52.533750 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 12 09:51:52.536060 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 12 09:51:52.535962 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 12 09:51:52.561915 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 12 09:51:52.570819 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 12 09:51:52.577115 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 12 09:51:52.585235 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 12 09:51:52.592699 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 12 09:51:52.593619 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 12 09:51:52.602974 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 12 09:51:52.603855 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 12 09:51:52.605332 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 12 09:51:52.606756 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 12 09:51:52.608902 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 12 09:51:52.610469 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 12 09:51:52.630337 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 12 09:51:52.632813 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 12 09:51:53.644983 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 12 09:51:53.645898 disk-uuid[596]: The operation has completed successfully. Jul 12 09:51:53.670068 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 12 09:51:53.670172 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 12 09:51:53.702446 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 12 09:51:53.732930 sh[612]: Success Jul 12 09:51:53.749379 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 12 09:51:53.749423 kernel: device-mapper: uevent: version 1.0.3 Jul 12 09:51:53.749443 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 12 09:51:53.759525 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jul 12 09:51:53.788672 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 12 09:51:53.791245 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 12 09:51:53.808065 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 12 09:51:53.814488 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 12 09:51:53.814529 kernel: BTRFS: device fsid 61a6979b-5b23-4687-8775-cb04acb91b0a devid 1 transid 37 /dev/mapper/usr (253:0) scanned by mount (624) Jul 12 09:51:53.815551 kernel: BTRFS info (device dm-0): first mount of filesystem 61a6979b-5b23-4687-8775-cb04acb91b0a Jul 12 09:51:53.815582 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 12 09:51:53.816949 kernel: BTRFS info (device dm-0): using free-space-tree Jul 12 09:51:53.819737 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 12 09:51:53.820843 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 12 09:51:53.821751 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 12 09:51:53.822526 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 12 09:51:53.824992 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 12 09:51:53.848972 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (653) Jul 12 09:51:53.851207 kernel: BTRFS info (device vda6): first mount of filesystem e5a719e8-42e4-4055-8ce0-9ce9f50475f2 Jul 12 09:51:53.851250 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 12 09:51:53.851963 kernel: BTRFS info (device vda6): using free-space-tree Jul 12 09:51:53.856971 kernel: BTRFS info (device vda6): last unmount of filesystem e5a719e8-42e4-4055-8ce0-9ce9f50475f2 Jul 12 09:51:53.858905 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 12 09:51:53.861050 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 12 09:51:53.941369 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 12 09:51:53.943900 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 12 09:51:53.983114 systemd-networkd[802]: lo: Link UP Jul 12 09:51:53.983125 systemd-networkd[802]: lo: Gained carrier Jul 12 09:51:53.983871 systemd-networkd[802]: Enumeration completed Jul 12 09:51:53.983968 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 12 09:51:53.984812 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 12 09:51:53.984815 systemd-networkd[802]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 12 09:51:53.985150 systemd[1]: Reached target network.target - Network. Jul 12 09:51:53.985777 systemd-networkd[802]: eth0: Link UP Jul 12 09:51:53.985782 systemd-networkd[802]: eth0: Gained carrier Jul 12 09:51:53.985791 systemd-networkd[802]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 12 09:51:54.013831 ignition[698]: Ignition 2.21.0 Jul 12 09:51:54.013844 ignition[698]: Stage: fetch-offline Jul 12 09:51:54.013982 systemd-networkd[802]: eth0: DHCPv4 address 10.0.0.140/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 12 09:51:54.013881 ignition[698]: no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:54.013890 ignition[698]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:54.014110 ignition[698]: parsed url from cmdline: "" Jul 12 09:51:54.014114 ignition[698]: no config URL provided Jul 12 09:51:54.014119 ignition[698]: reading system config file "/usr/lib/ignition/user.ign" Jul 12 09:51:54.014126 ignition[698]: no config at "/usr/lib/ignition/user.ign" Jul 12 09:51:54.014147 ignition[698]: op(1): [started] loading QEMU firmware config module Jul 12 09:51:54.014151 ignition[698]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 12 09:51:54.022396 ignition[698]: op(1): [finished] loading QEMU firmware config module Jul 12 09:51:54.022424 ignition[698]: QEMU firmware config was not found. Ignoring... Jul 12 09:51:54.025908 ignition[698]: parsing config with SHA512: 74c6f07ea3f700fd415dc64668e1c4f7c259b5fb6cb4c89777aa0b06294e29e9760cd5105a8dffffd7e462a10c4281548cc99b3d0fe747a7f7bab69d6f6b7dd9 Jul 12 09:51:54.031000 unknown[698]: fetched base config from "system" Jul 12 09:51:54.031011 unknown[698]: fetched user config from "qemu" Jul 12 09:51:54.031189 ignition[698]: fetch-offline: fetch-offline passed Jul 12 09:51:54.031376 ignition[698]: Ignition finished successfully Jul 12 09:51:54.033473 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 12 09:51:54.034831 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 12 09:51:54.035623 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 12 09:51:54.066652 ignition[815]: Ignition 2.21.0 Jul 12 09:51:54.066666 ignition[815]: Stage: kargs Jul 12 09:51:54.066877 ignition[815]: no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:54.066887 ignition[815]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:54.067796 ignition[815]: kargs: kargs passed Jul 12 09:51:54.067960 ignition[815]: Ignition finished successfully Jul 12 09:51:54.071598 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 12 09:51:54.073454 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 12 09:51:54.105371 ignition[823]: Ignition 2.21.0 Jul 12 09:51:54.105391 ignition[823]: Stage: disks Jul 12 09:51:54.105541 ignition[823]: no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:54.105550 ignition[823]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:54.106255 ignition[823]: disks: disks passed Jul 12 09:51:54.108764 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 12 09:51:54.107113 ignition[823]: Ignition finished successfully Jul 12 09:51:54.109717 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 12 09:51:54.110660 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 12 09:51:54.112113 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 12 09:51:54.113187 systemd[1]: Reached target sysinit.target - System Initialization. Jul 12 09:51:54.114613 systemd[1]: Reached target basic.target - Basic System. Jul 12 09:51:54.116995 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 12 09:51:54.143527 systemd-resolved[289]: Detected conflict on linux IN A 10.0.0.140 Jul 12 09:51:54.143538 systemd-resolved[289]: Hostname conflict, changing published hostname from 'linux' to 'linux11'. Jul 12 09:51:54.145790 systemd-fsck[833]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 12 09:51:54.149845 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 12 09:51:54.151717 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 12 09:51:54.219971 kernel: EXT4-fs (vda9): mounted filesystem 016d0f7f-22a0-4255-85cc-97a6d773acb9 r/w with ordered data mode. Quota mode: none. Jul 12 09:51:54.220662 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 12 09:51:54.221669 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 12 09:51:54.224028 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 12 09:51:54.225788 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 12 09:51:54.226610 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 12 09:51:54.226648 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 12 09:51:54.226670 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 12 09:51:54.243794 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 12 09:51:54.245821 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 12 09:51:54.250467 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (841) Jul 12 09:51:54.250521 kernel: BTRFS info (device vda6): first mount of filesystem e5a719e8-42e4-4055-8ce0-9ce9f50475f2 Jul 12 09:51:54.250533 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 12 09:51:54.250543 kernel: BTRFS info (device vda6): using free-space-tree Jul 12 09:51:54.254212 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 12 09:51:54.303209 initrd-setup-root[865]: cut: /sysroot/etc/passwd: No such file or directory Jul 12 09:51:54.306491 initrd-setup-root[872]: cut: /sysroot/etc/group: No such file or directory Jul 12 09:51:54.309644 initrd-setup-root[879]: cut: /sysroot/etc/shadow: No such file or directory Jul 12 09:51:54.312975 initrd-setup-root[886]: cut: /sysroot/etc/gshadow: No such file or directory Jul 12 09:51:54.384929 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 12 09:51:54.386637 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 12 09:51:54.388658 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 12 09:51:54.403257 kernel: BTRFS info (device vda6): last unmount of filesystem e5a719e8-42e4-4055-8ce0-9ce9f50475f2 Jul 12 09:51:54.413021 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 12 09:51:54.430398 ignition[956]: INFO : Ignition 2.21.0 Jul 12 09:51:54.430398 ignition[956]: INFO : Stage: mount Jul 12 09:51:54.432543 ignition[956]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:54.432543 ignition[956]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:54.432543 ignition[956]: INFO : mount: mount passed Jul 12 09:51:54.434465 ignition[956]: INFO : Ignition finished successfully Jul 12 09:51:54.435147 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 12 09:51:54.437612 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 12 09:51:54.814087 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 12 09:51:54.815722 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 12 09:51:54.833614 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (967) Jul 12 09:51:54.833650 kernel: BTRFS info (device vda6): first mount of filesystem e5a719e8-42e4-4055-8ce0-9ce9f50475f2 Jul 12 09:51:54.833669 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 12 09:51:54.834322 kernel: BTRFS info (device vda6): using free-space-tree Jul 12 09:51:54.837449 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 12 09:51:54.868965 ignition[984]: INFO : Ignition 2.21.0 Jul 12 09:51:54.868965 ignition[984]: INFO : Stage: files Jul 12 09:51:54.868965 ignition[984]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:54.868965 ignition[984]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:54.871842 ignition[984]: DEBUG : files: compiled without relabeling support, skipping Jul 12 09:51:54.871842 ignition[984]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 12 09:51:54.871842 ignition[984]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 12 09:51:54.874722 ignition[984]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 12 09:51:54.874722 ignition[984]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 12 09:51:54.874722 ignition[984]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 12 09:51:54.872891 unknown[984]: wrote ssh authorized keys file for user: core Jul 12 09:51:54.879069 ignition[984]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 12 09:51:54.879069 ignition[984]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 12 09:51:54.879069 ignition[984]: INFO : files: op(4): [started] processing unit "docker.service" Jul 12 09:51:54.879069 ignition[984]: INFO : files: op(4): [finished] processing unit "docker.service" Jul 12 09:51:54.879069 ignition[984]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Jul 12 09:51:54.879069 ignition[984]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 12 09:51:54.885664 ignition[984]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 12 09:51:54.885664 ignition[984]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Jul 12 09:51:54.885664 ignition[984]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Jul 12 09:51:54.896650 ignition[984]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 12 09:51:54.900319 ignition[984]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 12 09:51:54.902008 ignition[984]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Jul 12 09:51:54.902008 ignition[984]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Jul 12 09:51:54.902008 ignition[984]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Jul 12 09:51:54.902008 ignition[984]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 12 09:51:54.902008 ignition[984]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 12 09:51:54.902008 ignition[984]: INFO : files: files passed Jul 12 09:51:54.902008 ignition[984]: INFO : Ignition finished successfully Jul 12 09:51:54.902871 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 12 09:51:54.904715 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 12 09:51:54.906851 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 12 09:51:54.924434 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 12 09:51:54.924574 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 12 09:51:54.926603 initrd-setup-root-after-ignition[1013]: grep: /sysroot/oem/oem-release: No such file or directory Jul 12 09:51:54.927611 initrd-setup-root-after-ignition[1015]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 12 09:51:54.927611 initrd-setup-root-after-ignition[1015]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 12 09:51:54.929771 initrd-setup-root-after-ignition[1019]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 12 09:51:54.929712 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 12 09:51:54.930842 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 12 09:51:54.933293 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 12 09:51:54.990159 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 12 09:51:54.990965 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 12 09:51:54.994232 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 12 09:51:54.994991 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 12 09:51:54.995709 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 12 09:51:54.996572 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 12 09:51:55.026364 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 12 09:51:55.028521 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 12 09:51:55.057821 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 12 09:51:55.058814 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 12 09:51:55.060268 systemd[1]: Stopped target timers.target - Timer Units. Jul 12 09:51:55.061509 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 12 09:51:55.061642 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 12 09:51:55.063384 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 12 09:51:55.064177 systemd[1]: Stopped target basic.target - Basic System. Jul 12 09:51:55.065530 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 12 09:51:55.066771 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 12 09:51:55.068083 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 12 09:51:55.069397 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 12 09:51:55.070738 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 12 09:51:55.072046 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 12 09:51:55.073459 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 12 09:51:55.074701 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 12 09:51:55.076169 systemd[1]: Stopped target swap.target - Swaps. Jul 12 09:51:55.077335 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 12 09:51:55.077471 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 12 09:51:55.079113 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 12 09:51:55.080467 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 12 09:51:55.081747 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 12 09:51:55.085017 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 12 09:51:55.085916 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 12 09:51:55.086072 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 12 09:51:55.088019 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 12 09:51:55.088135 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 12 09:51:55.089504 systemd[1]: Stopped target paths.target - Path Units. Jul 12 09:51:55.090592 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 12 09:51:55.090708 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 12 09:51:55.092079 systemd[1]: Stopped target slices.target - Slice Units. Jul 12 09:51:55.093169 systemd[1]: Stopped target sockets.target - Socket Units. Jul 12 09:51:55.094395 systemd[1]: iscsid.socket: Deactivated successfully. Jul 12 09:51:55.094483 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 12 09:51:55.095900 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 12 09:51:55.095991 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 12 09:51:55.097091 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 12 09:51:55.097214 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 12 09:51:55.098397 systemd[1]: ignition-files.service: Deactivated successfully. Jul 12 09:51:55.098501 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 12 09:51:55.100363 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 12 09:51:55.101916 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 12 09:51:55.103168 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 12 09:51:55.103301 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 12 09:51:55.104830 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 12 09:51:55.104931 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 12 09:51:55.109551 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 12 09:51:55.112353 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 12 09:51:55.121259 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 12 09:51:55.125579 ignition[1040]: INFO : Ignition 2.21.0 Jul 12 09:51:55.125579 ignition[1040]: INFO : Stage: umount Jul 12 09:51:55.127420 ignition[1040]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 12 09:51:55.127420 ignition[1040]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 12 09:51:55.127420 ignition[1040]: INFO : umount: umount passed Jul 12 09:51:55.127420 ignition[1040]: INFO : Ignition finished successfully Jul 12 09:51:55.125820 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 12 09:51:55.125963 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 12 09:51:55.127226 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 12 09:51:55.129000 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 12 09:51:55.130667 systemd[1]: Stopped target network.target - Network. Jul 12 09:51:55.131422 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 12 09:51:55.131490 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 12 09:51:55.132255 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 12 09:51:55.132300 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 12 09:51:55.133513 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 12 09:51:55.133564 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 12 09:51:55.134650 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 12 09:51:55.134689 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 12 09:51:55.135989 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 12 09:51:55.136036 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 12 09:51:55.137472 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 12 09:51:55.138550 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 12 09:51:55.147514 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 12 09:51:55.147638 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 12 09:51:55.150867 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 12 09:51:55.151483 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 12 09:51:55.151564 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 12 09:51:55.154245 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jul 12 09:51:55.156678 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 12 09:51:55.156826 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 12 09:51:55.158914 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 12 09:51:55.159735 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 12 09:51:55.159781 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 12 09:51:55.162205 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 12 09:51:55.163394 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 12 09:51:55.163454 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 12 09:51:55.164784 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 12 09:51:55.164825 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 12 09:51:55.167012 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 12 09:51:55.167054 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 12 09:51:55.168384 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 12 09:51:55.188687 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 12 09:51:55.192101 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 12 09:51:55.193267 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 12 09:51:55.193306 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 12 09:51:55.194575 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 12 09:51:55.194605 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 12 09:51:55.195855 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 12 09:51:55.195901 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 12 09:51:55.197947 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 12 09:51:55.197997 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 12 09:51:55.199935 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 12 09:51:55.199996 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 12 09:51:55.202845 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 12 09:51:55.204063 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 12 09:51:55.204117 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 12 09:51:55.206455 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 12 09:51:55.206500 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 12 09:51:55.208817 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jul 12 09:51:55.208863 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 12 09:51:55.211163 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 12 09:51:55.211229 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 12 09:51:55.212684 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 12 09:51:55.212725 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 12 09:51:55.215623 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 12 09:51:55.215706 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 12 09:51:55.218414 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 12 09:51:55.218497 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 12 09:51:55.219530 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 12 09:51:55.222816 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 12 09:51:55.246307 systemd[1]: Switching root. Jul 12 09:51:55.291514 systemd-journald[244]: Journal stopped Jul 12 09:51:55.959571 systemd-journald[244]: Received SIGTERM from PID 1 (systemd). Jul 12 09:51:55.959626 kernel: SELinux: policy capability network_peer_controls=1 Jul 12 09:51:55.959639 kernel: SELinux: policy capability open_perms=1 Jul 12 09:51:55.959648 kernel: SELinux: policy capability extended_socket_class=1 Jul 12 09:51:55.959661 kernel: SELinux: policy capability always_check_network=0 Jul 12 09:51:55.959670 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 12 09:51:55.959686 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 12 09:51:55.959695 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 12 09:51:55.959710 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 12 09:51:55.959719 kernel: SELinux: policy capability userspace_initial_context=0 Jul 12 09:51:55.959733 kernel: audit: type=1403 audit(1752313915.388:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 12 09:51:55.959745 systemd[1]: Successfully loaded SELinux policy in 66.473ms. Jul 12 09:51:55.959775 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 5.302ms. Jul 12 09:51:55.959788 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) Jul 12 09:51:55.959799 systemd[1]: Detected virtualization kvm. Jul 12 09:51:55.959809 systemd[1]: Detected architecture arm64. Jul 12 09:51:55.959819 systemd[1]: Detected first boot. Jul 12 09:51:55.959828 systemd[1]: Initializing machine ID from VM UUID. Jul 12 09:51:55.959838 zram_generator::config[1087]: No configuration found. Jul 12 09:51:55.959849 kernel: NET: Registered PF_VSOCK protocol family Jul 12 09:51:55.959860 systemd[1]: Populated /etc with preset unit settings. Jul 12 09:51:55.959871 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 12 09:51:55.959882 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 12 09:51:55.959893 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 12 09:51:55.959903 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 12 09:51:55.959914 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 12 09:51:55.959924 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 12 09:51:55.959951 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 12 09:51:55.959962 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 12 09:51:55.959972 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 12 09:51:55.959988 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 12 09:51:55.959998 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 12 09:51:55.960010 systemd[1]: Created slice user.slice - User and Session Slice. Jul 12 09:51:55.960020 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 12 09:51:55.960032 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 12 09:51:55.960043 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 12 09:51:55.960053 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 12 09:51:55.960064 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 12 09:51:55.960074 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 12 09:51:55.960085 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 12 09:51:55.960095 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 12 09:51:55.960105 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 12 09:51:55.960118 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 12 09:51:55.960128 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 12 09:51:55.960152 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 12 09:51:55.960162 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 12 09:51:55.960173 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 12 09:51:55.960183 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 12 09:51:55.960193 systemd[1]: Reached target slices.target - Slice Units. Jul 12 09:51:55.960203 systemd[1]: Reached target swap.target - Swaps. Jul 12 09:51:55.960213 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 12 09:51:55.960226 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 12 09:51:55.960237 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 12 09:51:55.960247 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 12 09:51:55.960257 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 12 09:51:55.960268 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 12 09:51:55.960278 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 12 09:51:55.960292 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 12 09:51:55.960303 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 12 09:51:55.960313 systemd[1]: Mounting media.mount - External Media Directory... Jul 12 09:51:55.960326 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 12 09:51:55.960336 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 12 09:51:55.960346 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 12 09:51:55.960356 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). Jul 12 09:51:55.960443 systemd[1]: Reached target machines.target - Containers. Jul 12 09:51:55.960457 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 12 09:51:55.960468 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 12 09:51:55.960478 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 12 09:51:55.960492 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 12 09:51:55.960502 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 12 09:51:55.960512 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 12 09:51:55.960522 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 12 09:51:55.960533 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 12 09:51:55.960543 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 12 09:51:55.960553 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 12 09:51:55.960563 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 12 09:51:55.960574 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 12 09:51:55.960585 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 12 09:51:55.960595 systemd[1]: Stopped systemd-fsck-usr.service. Jul 12 09:51:55.960605 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). Jul 12 09:51:55.960615 kernel: loop: module loaded Jul 12 09:51:55.960624 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 12 09:51:55.960663 kernel: fuse: init (API version 7.41) Jul 12 09:51:55.960680 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 12 09:51:55.960691 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 12 09:51:55.960701 kernel: ACPI: bus type drm_connector registered Jul 12 09:51:55.960713 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 12 09:51:55.960724 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 12 09:51:55.960734 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 12 09:51:55.960744 systemd[1]: verity-setup.service: Deactivated successfully. Jul 12 09:51:55.960766 systemd[1]: Stopped verity-setup.service. Jul 12 09:51:55.960777 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 12 09:51:55.960816 systemd-journald[1155]: Collecting audit messages is disabled. Jul 12 09:51:55.960843 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 12 09:51:55.960854 systemd[1]: Mounted media.mount - External Media Directory. Jul 12 09:51:55.960865 systemd-journald[1155]: Journal started Jul 12 09:51:55.960887 systemd-journald[1155]: Runtime Journal (/run/log/journal/fef6edd1f4c24456b84e1230ad376002) is 6M, max 48.5M, 42.4M free. Jul 12 09:51:55.753331 systemd[1]: Queued start job for default target multi-user.target. Jul 12 09:51:55.778986 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 12 09:51:55.779354 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 12 09:51:55.962326 systemd[1]: Started systemd-journald.service - Journal Service. Jul 12 09:51:55.963628 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 12 09:51:55.964600 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 12 09:51:55.965583 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 12 09:51:55.966630 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 12 09:51:55.968972 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 12 09:51:55.970197 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 12 09:51:55.970369 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 12 09:51:55.971523 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 12 09:51:55.971699 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 12 09:51:55.972957 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 12 09:51:55.973110 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 12 09:51:55.974142 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 12 09:51:55.975988 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 12 09:51:55.977271 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 12 09:51:55.977431 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 12 09:51:55.978466 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 12 09:51:55.978623 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 12 09:51:55.980981 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 12 09:51:55.982331 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 12 09:51:55.983500 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 12 09:51:55.984700 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 12 09:51:55.996854 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 12 09:51:55.999027 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 12 09:51:56.000733 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 12 09:51:56.001579 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 12 09:51:56.001610 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 12 09:51:56.003287 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 12 09:51:56.012149 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 12 09:51:56.013250 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 12 09:51:56.014551 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 12 09:51:56.016294 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 12 09:51:56.017388 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 12 09:51:56.018353 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 12 09:51:56.019323 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 12 09:51:56.020599 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 12 09:51:56.025100 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 12 09:51:56.026435 systemd-journald[1155]: Time spent on flushing to /var/log/journal/fef6edd1f4c24456b84e1230ad376002 is 18.741ms for 855 entries. Jul 12 09:51:56.026435 systemd-journald[1155]: System Journal (/var/log/journal/fef6edd1f4c24456b84e1230ad376002) is 8M, max 195.6M, 187.6M free. Jul 12 09:51:56.060050 systemd-journald[1155]: Received client request to flush runtime journal. Jul 12 09:51:56.060083 kernel: loop0: detected capacity change from 0 to 134232 Jul 12 09:51:56.028675 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 12 09:51:56.031319 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 12 09:51:56.033287 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 12 09:51:56.035888 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 12 09:51:56.037122 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 12 09:51:56.043533 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 12 09:51:56.050314 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Jul 12 09:51:56.050327 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Jul 12 09:51:56.050607 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 12 09:51:56.055153 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 12 09:51:56.056342 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 12 09:51:56.060149 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 12 09:51:56.064380 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 12 09:51:56.077950 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 12 09:51:56.078378 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 12 09:51:56.088553 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 12 09:51:56.090628 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 12 09:51:56.098013 kernel: loop1: detected capacity change from 0 to 105936 Jul 12 09:51:56.113889 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Jul 12 09:51:56.113908 systemd-tmpfiles[1224]: ACLs are not supported, ignoring. Jul 12 09:51:56.117038 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 12 09:51:56.122993 kernel: loop2: detected capacity change from 0 to 134232 Jul 12 09:51:56.131954 kernel: loop3: detected capacity change from 0 to 105936 Jul 12 09:51:56.137528 (sd-merge)[1229]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 12 09:51:56.137900 (sd-merge)[1229]: Merged extensions into '/usr'. Jul 12 09:51:56.140965 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 12 09:51:56.143281 systemd[1]: Starting ensure-sysext.service... Jul 12 09:51:56.147129 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 12 09:51:56.169732 systemd[1]: Reload requested from client PID 1232 ('systemctl') (unit ensure-sysext.service)... Jul 12 09:51:56.169748 systemd[1]: Reloading... Jul 12 09:51:56.175870 systemd-tmpfiles[1233]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 12 09:51:56.175901 systemd-tmpfiles[1233]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 12 09:51:56.176141 systemd-tmpfiles[1233]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 12 09:51:56.176317 systemd-tmpfiles[1233]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 12 09:51:56.176925 systemd-tmpfiles[1233]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 12 09:51:56.177148 systemd-tmpfiles[1233]: ACLs are not supported, ignoring. Jul 12 09:51:56.177190 systemd-tmpfiles[1233]: ACLs are not supported, ignoring. Jul 12 09:51:56.180562 systemd-tmpfiles[1233]: Detected autofs mount point /boot during canonicalization of boot. Jul 12 09:51:56.180576 systemd-tmpfiles[1233]: Skipping /boot Jul 12 09:51:56.186387 systemd-tmpfiles[1233]: Detected autofs mount point /boot during canonicalization of boot. Jul 12 09:51:56.186401 systemd-tmpfiles[1233]: Skipping /boot Jul 12 09:51:56.235053 zram_generator::config[1261]: No configuration found. Jul 12 09:51:56.312023 ldconfig[1198]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 12 09:51:56.317957 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jul 12 09:51:56.380128 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 12 09:51:56.380446 systemd[1]: Reloading finished in 210 ms. Jul 12 09:51:56.415978 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 12 09:51:56.436038 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 12 09:51:56.443362 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 12 09:51:56.445691 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 12 09:51:56.457904 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 12 09:51:56.461273 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 12 09:51:56.463235 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 12 09:51:56.466513 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 12 09:51:56.469150 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 12 09:51:56.472497 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 12 09:51:56.485224 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 12 09:51:56.486116 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 12 09:51:56.486226 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). Jul 12 09:51:56.488137 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 12 09:51:56.489556 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 12 09:51:56.492675 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 12 09:51:56.492840 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 12 09:51:56.494426 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 12 09:51:56.495308 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 12 09:51:56.497033 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 12 09:51:56.497193 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 12 09:51:56.506984 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 12 09:51:56.511713 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 12 09:51:56.513046 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 12 09:51:56.514714 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 12 09:51:56.516463 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 12 09:51:56.518579 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 12 09:51:56.518690 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). Jul 12 09:51:56.526632 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 12 09:51:56.529088 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 12 09:51:56.530303 augenrules[1337]: No rules Jul 12 09:51:56.532884 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 12 09:51:56.533777 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). Jul 12 09:51:56.535368 systemd[1]: audit-rules.service: Deactivated successfully. Jul 12 09:51:56.535833 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 12 09:51:56.537257 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 12 09:51:56.538609 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 12 09:51:56.538771 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 12 09:51:56.540046 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 12 09:51:56.540186 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 12 09:51:56.541536 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 12 09:51:56.541665 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 12 09:51:56.542979 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 12 09:51:56.552130 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 12 09:51:56.552924 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 12 09:51:56.554184 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 12 09:51:56.556976 systemd-udevd[1335]: Using default interface naming scheme 'v255'. Jul 12 09:51:56.562287 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 12 09:51:56.564434 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 12 09:51:56.566537 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 12 09:51:56.567506 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 12 09:51:56.567616 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). Jul 12 09:51:56.567721 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). Jul 12 09:51:56.568699 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 12 09:51:56.573966 systemd[1]: Finished ensure-sysext.service. Jul 12 09:51:56.577461 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 12 09:51:56.578897 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 12 09:51:56.580540 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 12 09:51:56.580730 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 12 09:51:56.584616 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 12 09:51:56.584877 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 12 09:51:56.586795 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 12 09:51:56.588993 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 12 09:51:56.590816 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 12 09:51:56.590995 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 12 09:51:56.591667 augenrules[1350]: /sbin/augenrules: No change Jul 12 09:51:56.601428 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 12 09:51:56.602241 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 12 09:51:56.602300 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 12 09:51:56.605552 augenrules[1407]: No rules Jul 12 09:51:56.606557 systemd[1]: audit-rules.service: Deactivated successfully. Jul 12 09:51:56.608014 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 12 09:51:56.627847 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jul 12 09:51:56.680172 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 12 09:51:56.683072 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 12 09:51:56.710981 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 12 09:51:56.733791 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 12 09:51:56.771839 systemd-networkd[1406]: lo: Link UP Jul 12 09:51:56.771846 systemd-networkd[1406]: lo: Gained carrier Jul 12 09:51:56.772552 systemd-networkd[1406]: Enumeration completed Jul 12 09:51:56.772648 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 12 09:51:56.774529 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 12 09:51:56.775614 systemd-networkd[1406]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 12 09:51:56.775623 systemd-networkd[1406]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 12 09:51:56.776117 systemd-networkd[1406]: eth0: Link UP Jul 12 09:51:56.777054 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 12 09:51:56.780155 systemd-networkd[1406]: eth0: Gained carrier Jul 12 09:51:56.780176 systemd-networkd[1406]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 12 09:51:56.791136 systemd-resolved[1302]: Positive Trust Anchors: Jul 12 09:51:56.791152 systemd-resolved[1302]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 12 09:51:56.791182 systemd-resolved[1302]: 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 Jul 12 09:51:56.802076 systemd-resolved[1302]: Defaulting to hostname 'linux'. Jul 12 09:51:56.810981 systemd-networkd[1406]: eth0: DHCPv4 address 10.0.0.140/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 12 09:51:56.811786 systemd-timesyncd[1371]: Network configuration changed, trying to establish connection. Jul 12 09:51:56.811954 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 12 09:51:56.813021 systemd-timesyncd[1371]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 12 09:51:56.813050 systemd[1]: Reached target time-set.target - System Time Set. Jul 12 09:51:56.813227 systemd-timesyncd[1371]: Initial clock synchronization to Sat 2025-07-12 09:51:56.682737 UTC. Jul 12 09:51:56.814680 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 12 09:51:56.815648 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 12 09:51:56.818445 systemd[1]: Reached target network.target - Network. Jul 12 09:51:56.819528 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 12 09:51:56.823092 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 12 09:51:56.825105 systemd[1]: Reached target sysinit.target - System Initialization. Jul 12 09:51:56.825925 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 12 09:51:56.826798 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 12 09:51:56.827870 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 12 09:51:56.828723 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 12 09:51:56.829628 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 12 09:51:56.830486 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 12 09:51:56.830519 systemd[1]: Reached target paths.target - Path Units. Jul 12 09:51:56.831275 systemd[1]: Reached target timers.target - Timer Units. Jul 12 09:51:56.832568 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 12 09:51:56.834409 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 12 09:51:56.836797 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 12 09:51:56.837873 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 12 09:51:56.838796 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 12 09:51:56.841606 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 12 09:51:56.842623 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 12 09:51:56.843971 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 12 09:51:56.844780 systemd[1]: Reached target sockets.target - Socket Units. Jul 12 09:51:56.845505 systemd[1]: Reached target basic.target - Basic System. Jul 12 09:51:56.846197 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 12 09:51:56.846228 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 12 09:51:56.847043 systemd[1]: Starting containerd.service - containerd container runtime... Jul 12 09:51:56.848643 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 12 09:51:56.850256 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 12 09:51:56.852212 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 12 09:51:56.854029 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 12 09:51:56.854845 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). Jul 12 09:51:56.855890 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 12 09:51:56.857719 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 12 09:51:56.861056 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 12 09:51:56.864051 jq[1457]: false Jul 12 09:51:56.866894 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 12 09:51:56.869869 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 12 09:51:56.872783 extend-filesystems[1458]: Found /dev/vda6 Jul 12 09:51:56.874199 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 12 09:51:56.874873 systemd[1]: Starting update-engine.service - Update Engine... Jul 12 09:51:56.878094 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 12 09:51:56.882005 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 12 09:51:56.883177 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 12 09:51:56.883340 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 12 09:51:56.883573 systemd[1]: motdgen.service: Deactivated successfully. Jul 12 09:51:56.883728 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 12 09:51:56.884669 extend-filesystems[1458]: Found /dev/vda9 Jul 12 09:51:56.885136 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 12 09:51:56.885293 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 12 09:51:56.887852 jq[1473]: true Jul 12 09:51:56.888435 extend-filesystems[1458]: Checking size of /dev/vda9 Jul 12 09:51:56.902173 (ntainerd)[1484]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 12 09:51:56.909329 extend-filesystems[1458]: Old size kept for /dev/vda9 Jul 12 09:51:56.910302 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 12 09:51:56.910513 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 12 09:51:56.912379 jq[1482]: true Jul 12 09:51:56.934483 update_engine[1472]: I20250712 09:51:56.933161 1472 main.cc:92] Flatcar Update Engine starting Jul 12 09:51:56.938041 dbus-daemon[1455]: [system] SELinux support is enabled Jul 12 09:51:56.938981 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 12 09:51:56.941591 update_engine[1472]: I20250712 09:51:56.941540 1472 update_check_scheduler.cc:74] Next update check in 11m2s Jul 12 09:51:56.942950 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). Jul 12 09:51:56.942979 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 12 09:51:56.945104 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). Jul 12 09:51:56.945142 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 12 09:51:56.948323 systemd[1]: Started update-engine.service - Update Engine. Jul 12 09:51:56.953156 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 12 09:51:56.955339 systemd-logind[1469]: Watching system buttons on /dev/input/event0 (Power Button) Jul 12 09:51:56.955519 systemd-logind[1469]: New seat seat0. Jul 12 09:51:56.956715 systemd[1]: Started systemd-logind.service - User Login Management. Jul 12 09:51:56.964482 bash[1509]: Updated "/home/core/.ssh/authorized_keys" Jul 12 09:51:56.967072 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 12 09:51:56.970909 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 12 09:51:57.008507 locksmithd[1510]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 12 09:51:57.122386 containerd[1484]: time="2025-07-12T09:51:57Z" 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 Jul 12 09:51:57.123037 containerd[1484]: time="2025-07-12T09:51:57.123007016Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Jul 12 09:51:57.132395 containerd[1484]: time="2025-07-12T09:51:57.132350063Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.342µs" Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132463821Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132486879Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132633100Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132650689Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132672055Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132720612Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132731865Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132916333Z" 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 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132953479Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132964850Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.132972287Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133313 containerd[1484]: time="2025-07-12T09:51:57.133044965Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133218612Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133246077Z" 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 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133256190Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133293650Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133485279Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 12 09:51:57.133569 containerd[1484]: time="2025-07-12T09:51:57.133548788Z" level=info msg="metadata content store policy set" policy=shared Jul 12 09:51:57.136615 containerd[1484]: time="2025-07-12T09:51:57.136579954Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 12 09:51:57.136685 containerd[1484]: time="2025-07-12T09:51:57.136631855Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 12 09:51:57.136685 containerd[1484]: time="2025-07-12T09:51:57.136646571Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 12 09:51:57.136685 containerd[1484]: time="2025-07-12T09:51:57.136657510Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 12 09:51:57.136685 containerd[1484]: time="2025-07-12T09:51:57.136668921Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 12 09:51:57.136685 containerd[1484]: time="2025-07-12T09:51:57.136681356Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136692728Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136705083Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136715511Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136725269Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136734634Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.136828993Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.137018930Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.137050685Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 12 09:51:57.137645 containerd[1484]: time="2025-07-12T09:51:57.137624077Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137650952Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137667007Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137681369Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137699509Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137711235Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137727368Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137740865Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 12 09:51:57.137813 containerd[1484]: time="2025-07-12T09:51:57.137755896Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 12 09:51:57.138032 containerd[1484]: time="2025-07-12T09:51:57.137964799Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 12 09:51:57.138060 containerd[1484]: time="2025-07-12T09:51:57.138036926Z" level=info msg="Start snapshots syncer" Jul 12 09:51:57.138077 containerd[1484]: time="2025-07-12T09:51:57.138061873Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 12 09:51:57.138536 containerd[1484]: time="2025-07-12T09:51:57.138479011Z" 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\"}" Jul 12 09:51:57.138640 containerd[1484]: time="2025-07-12T09:51:57.138546613Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 12 09:51:57.138640 containerd[1484]: time="2025-07-12T09:51:57.138619290Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 12 09:51:57.138784 containerd[1484]: time="2025-07-12T09:51:57.138723328Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 12 09:51:57.138784 containerd[1484]: time="2025-07-12T09:51:57.138751817Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 12 09:51:57.138784 containerd[1484]: time="2025-07-12T09:51:57.138763189Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 12 09:51:57.138784 containerd[1484]: time="2025-07-12T09:51:57.138776371Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138793920Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138805214Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138815720Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138838031Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138849088Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 12 09:51:57.138861 containerd[1484]: time="2025-07-12T09:51:57.138859161Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138886430Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138898313Z" 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 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138905750Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138915115Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138923300Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138960327Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 12 09:51:57.138981 containerd[1484]: time="2025-07-12T09:51:57.138970518Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 12 09:51:57.139092 containerd[1484]: time="2025-07-12T09:51:57.139047091Z" level=info msg="runtime interface created" Jul 12 09:51:57.139092 containerd[1484]: time="2025-07-12T09:51:57.139052167Z" level=info msg="created NRI interface" Jul 12 09:51:57.139092 containerd[1484]: time="2025-07-12T09:51:57.139059919Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 12 09:51:57.139092 containerd[1484]: time="2025-07-12T09:51:57.139070386Z" level=info msg="Connect containerd service" Jul 12 09:51:57.139152 containerd[1484]: time="2025-07-12T09:51:57.139094271Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 12 09:51:57.139739 containerd[1484]: time="2025-07-12T09:51:57.139711773Z" 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" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231423005Z" level=info msg="Start subscribing containerd event" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231489387Z" level=info msg="Start recovering state" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231459364Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231573200Z" level=info msg="Start event monitor" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231587405Z" level=info msg="Start cni network conf syncer for default" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231594370Z" level=info msg="Start streaming server" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231602554Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231608496Z" level=info msg="runtime interface starting up..." Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231613966Z" level=info msg="starting plugins..." Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231609047Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 12 09:51:57.232659 containerd[1484]: time="2025-07-12T09:51:57.231626479Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 12 09:51:57.231849 systemd[1]: Started containerd.service - containerd container runtime. Jul 12 09:51:57.233030 containerd[1484]: time="2025-07-12T09:51:57.233007153Z" level=info msg="containerd successfully booted in 0.111277s" Jul 12 09:51:57.674147 sshd_keygen[1483]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 12 09:51:57.693983 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 12 09:51:57.696269 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 12 09:51:57.714256 systemd[1]: issuegen.service: Deactivated successfully. Jul 12 09:51:57.714462 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 12 09:51:57.716691 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 12 09:51:57.743504 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 12 09:51:57.745790 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 12 09:51:57.747587 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 12 09:51:57.748613 systemd[1]: Reached target getty.target - Login Prompts. Jul 12 09:51:57.927178 systemd-networkd[1406]: eth0: Gained IPv6LL Jul 12 09:51:57.929460 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 12 09:51:57.930786 systemd[1]: Reached target network-online.target - Network is Online. Jul 12 09:51:57.933035 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 12 09:51:57.934763 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 12 09:51:57.977110 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 12 09:51:57.978383 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 12 09:51:57.978549 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 12 09:51:57.980528 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 12 09:51:57.980735 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 12 09:51:57.984992 systemd[1]: Startup finished in 2.051s (kernel) + 3.760s (initrd) + 2.661s (userspace) = 8.473s. Jul 12 09:52:04.051431 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 12 09:52:04.052437 systemd[1]: Started sshd@0-10.0.0.140:22-10.0.0.1:60906.service - OpenSSH per-connection server daemon (10.0.0.1:60906). Jul 12 09:52:04.138722 sshd[1576]: Accepted publickey for core from 10.0.0.1 port 60906 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:04.140349 sshd-session[1576]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:04.147608 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 12 09:52:04.148440 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 12 09:52:04.154427 systemd-logind[1469]: New session 1 of user core. Jul 12 09:52:04.171808 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 12 09:52:04.175992 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 12 09:52:04.181467 (systemd)[1581]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 12 09:52:04.183311 systemd-logind[1469]: New session c1 of user core. Jul 12 09:52:04.295903 systemd[1581]: Queued start job for default target default.target. Jul 12 09:52:04.302734 systemd[1581]: Created slice app.slice - User Application Slice. Jul 12 09:52:04.302762 systemd[1581]: Reached target paths.target - Paths. Jul 12 09:52:04.302793 systemd[1581]: Reached target timers.target - Timers. Jul 12 09:52:04.303819 systemd[1581]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 12 09:52:04.312091 systemd[1581]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 12 09:52:04.312145 systemd[1581]: Reached target sockets.target - Sockets. Jul 12 09:52:04.312177 systemd[1581]: Reached target basic.target - Basic System. Jul 12 09:52:04.312204 systemd[1581]: Reached target default.target - Main User Target. Jul 12 09:52:04.312227 systemd[1581]: Startup finished in 123ms. Jul 12 09:52:04.312317 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 12 09:52:04.313421 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 12 09:52:04.379240 systemd[1]: Started sshd@1-10.0.0.140:22-10.0.0.1:60916.service - OpenSSH per-connection server daemon (10.0.0.1:60916). Jul 12 09:52:04.422522 sshd[1592]: Accepted publickey for core from 10.0.0.1 port 60916 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:04.423564 sshd-session[1592]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:04.427818 systemd-logind[1469]: New session 2 of user core. Jul 12 09:52:04.444055 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 12 09:52:04.493622 sshd[1595]: Connection closed by 10.0.0.1 port 60916 Jul 12 09:52:04.494000 sshd-session[1592]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:04.509453 systemd[1]: sshd@1-10.0.0.140:22-10.0.0.1:60916.service: Deactivated successfully. Jul 12 09:52:04.512163 systemd[1]: session-2.scope: Deactivated successfully. Jul 12 09:52:04.513206 systemd-logind[1469]: Session 2 logged out. Waiting for processes to exit. Jul 12 09:52:04.514745 systemd[1]: Started sshd@2-10.0.0.140:22-10.0.0.1:60922.service - OpenSSH per-connection server daemon (10.0.0.1:60922). Jul 12 09:52:04.515559 systemd-logind[1469]: Removed session 2. Jul 12 09:52:04.565293 sshd[1601]: Accepted publickey for core from 10.0.0.1 port 60922 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:04.566454 sshd-session[1601]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:04.570092 systemd-logind[1469]: New session 3 of user core. Jul 12 09:52:04.581133 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 12 09:52:04.627980 sshd[1604]: Connection closed by 10.0.0.1 port 60922 Jul 12 09:52:04.628126 sshd-session[1601]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:04.648872 systemd[1]: sshd@2-10.0.0.140:22-10.0.0.1:60922.service: Deactivated successfully. Jul 12 09:52:04.650277 systemd[1]: session-3.scope: Deactivated successfully. Jul 12 09:52:04.652499 systemd-logind[1469]: Session 3 logged out. Waiting for processes to exit. Jul 12 09:52:04.654506 systemd[1]: Started sshd@3-10.0.0.140:22-10.0.0.1:60926.service - OpenSSH per-connection server daemon (10.0.0.1:60926). Jul 12 09:52:04.655129 systemd-logind[1469]: Removed session 3. Jul 12 09:52:04.713592 sshd[1610]: Accepted publickey for core from 10.0.0.1 port 60926 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:04.714695 sshd-session[1610]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:04.719117 systemd-logind[1469]: New session 4 of user core. Jul 12 09:52:04.735142 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 12 09:52:04.785816 sshd[1613]: Connection closed by 10.0.0.1 port 60926 Jul 12 09:52:04.786181 sshd-session[1610]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:04.798746 systemd[1]: sshd@3-10.0.0.140:22-10.0.0.1:60926.service: Deactivated successfully. Jul 12 09:52:04.800131 systemd[1]: session-4.scope: Deactivated successfully. Jul 12 09:52:04.802594 systemd-logind[1469]: Session 4 logged out. Waiting for processes to exit. Jul 12 09:52:04.804543 systemd[1]: Started sshd@4-10.0.0.140:22-10.0.0.1:60934.service - OpenSSH per-connection server daemon (10.0.0.1:60934). Jul 12 09:52:04.805207 systemd-logind[1469]: Removed session 4. Jul 12 09:52:04.853333 sshd[1619]: Accepted publickey for core from 10.0.0.1 port 60934 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:04.854623 sshd-session[1619]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:04.858670 systemd-logind[1469]: New session 5 of user core. Jul 12 09:52:04.867128 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 12 09:52:04.928517 sudo[1623]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 12 09:52:04.929021 sudo[1623]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 12 09:52:04.941808 sudo[1623]: pam_unix(sudo:session): session closed for user root Jul 12 09:52:04.943074 sshd[1622]: Connection closed by 10.0.0.1 port 60934 Jul 12 09:52:04.943540 sshd-session[1619]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:04.956699 systemd[1]: sshd@4-10.0.0.140:22-10.0.0.1:60934.service: Deactivated successfully. Jul 12 09:52:04.958123 systemd[1]: session-5.scope: Deactivated successfully. Jul 12 09:52:04.960501 systemd-logind[1469]: Session 5 logged out. Waiting for processes to exit. Jul 12 09:52:04.962476 systemd[1]: Started sshd@5-10.0.0.140:22-10.0.0.1:60936.service - OpenSSH per-connection server daemon (10.0.0.1:60936). Jul 12 09:52:04.962892 systemd-logind[1469]: Removed session 5. Jul 12 09:52:05.023829 sshd[1629]: Accepted publickey for core from 10.0.0.1 port 60936 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:05.024864 sshd-session[1629]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:05.028112 systemd-logind[1469]: New session 6 of user core. Jul 12 09:52:05.040059 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 12 09:52:05.088292 sudo[1634]: 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 Jul 12 09:52:05.088531 sudo[1634]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 12 09:52:05.092626 sudo[1634]: pam_unix(sudo:session): session closed for user root Jul 12 09:52:05.096677 sudo[1633]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 12 09:52:05.096921 sudo[1633]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 12 09:52:05.104775 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 12 09:52:05.142159 augenrules[1656]: No rules Jul 12 09:52:05.143143 systemd[1]: audit-rules.service: Deactivated successfully. Jul 12 09:52:05.143350 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 12 09:52:05.144450 sudo[1633]: pam_unix(sudo:session): session closed for user root Jul 12 09:52:05.145947 sshd[1632]: Connection closed by 10.0.0.1 port 60936 Jul 12 09:52:05.145811 sshd-session[1629]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:05.152685 systemd[1]: sshd@5-10.0.0.140:22-10.0.0.1:60936.service: Deactivated successfully. Jul 12 09:52:05.153929 systemd[1]: session-6.scope: Deactivated successfully. Jul 12 09:52:05.156446 systemd-logind[1469]: Session 6 logged out. Waiting for processes to exit. Jul 12 09:52:05.157864 systemd[1]: Started sshd@6-10.0.0.140:22-10.0.0.1:60944.service - OpenSSH per-connection server daemon (10.0.0.1:60944). Jul 12 09:52:05.158754 systemd-logind[1469]: Removed session 6. Jul 12 09:52:05.206235 sshd[1665]: Accepted publickey for core from 10.0.0.1 port 60944 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:05.207239 sshd-session[1665]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:05.211237 systemd-logind[1469]: New session 7 of user core. Jul 12 09:52:05.223133 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 12 09:52:05.275186 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 12 09:52:05.287235 (dockerd)[1670]: 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 Jul 12 09:52:05.523909 dockerd[1670]: time="2025-07-12T09:52:05.523786465Z" level=info msg="Starting up" Jul 12 09:52:05.524874 dockerd[1670]: time="2025-07-12T09:52:05.524845310Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 12 09:52:05.534865 dockerd[1670]: time="2025-07-12T09:52:05.534833214Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jul 12 09:52:05.570121 dockerd[1670]: time="2025-07-12T09:52:05.570049583Z" level=info msg="Loading containers: start." Jul 12 09:52:05.578800 kernel: Initializing XFRM netlink socket Jul 12 09:52:05.776736 systemd-networkd[1406]: docker0: Link UP Jul 12 09:52:05.780458 dockerd[1670]: time="2025-07-12T09:52:05.780421329Z" level=info msg="Loading containers: done." Jul 12 09:52:05.794793 dockerd[1670]: time="2025-07-12T09:52:05.794750099Z" 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 Jul 12 09:52:05.794909 dockerd[1670]: time="2025-07-12T09:52:05.794824083Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jul 12 09:52:05.794909 dockerd[1670]: time="2025-07-12T09:52:05.794896356Z" level=info msg="Initializing buildkit" Jul 12 09:52:05.817021 dockerd[1670]: time="2025-07-12T09:52:05.816984205Z" level=info msg="Completed buildkit initialization" Jul 12 09:52:05.821626 dockerd[1670]: time="2025-07-12T09:52:05.821593521Z" level=info msg="Daemon has completed initialization" Jul 12 09:52:05.821961 dockerd[1670]: time="2025-07-12T09:52:05.821653026Z" level=info msg="API listen on /run/docker.sock" Jul 12 09:52:05.821785 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 12 09:52:05.831413 sshd[1668]: Connection closed by 10.0.0.1 port 60944 Jul 12 09:52:05.832389 sshd-session[1665]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:05.841765 systemd[1]: sshd@6-10.0.0.140:22-10.0.0.1:60944.service: Deactivated successfully. Jul 12 09:52:05.843236 systemd[1]: session-7.scope: Deactivated successfully. Jul 12 09:52:05.844051 systemd-logind[1469]: Session 7 logged out. Waiting for processes to exit. Jul 12 09:52:05.846150 systemd[1]: Started sshd@7-10.0.0.140:22-10.0.0.1:60946.service - OpenSSH per-connection server daemon (10.0.0.1:60946). Jul 12 09:52:05.847165 systemd-logind[1469]: Removed session 7. Jul 12 09:52:05.899471 sshd[1883]: Accepted publickey for core from 10.0.0.1 port 60946 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:05.900474 sshd-session[1883]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:05.904779 systemd-logind[1469]: New session 8 of user core. Jul 12 09:52:05.911114 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 12 09:52:06.544739 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck747349082-merged.mount: Deactivated successfully. Jul 12 09:52:06.973326 systemd[1]: var-lib-docker-overlay2-3636e196dcf9f147f8fb3fbd2b226069c4b72a241cfde10b872fcc1e3c43aa5b-merged.mount: Deactivated successfully. Jul 12 09:52:06.996641 containerd[1484]: time="2025-07-12T09:52:06.996572558Z" level=info msg="connecting to shim bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548" address="unix:///run/containerd/s/12a76e39168e31db2d66c27f8cd93c0a5d6e1674f7f614715c6b566d60aa8684" namespace=moby protocol=ttrpc version=3 Jul 12 09:52:07.021081 systemd[1]: Started docker-bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548.scope - libcontainer container bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548. Jul 12 09:52:07.031879 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 12 09:52:07.049260 kernel: docker0: port 1(veth1190131) entered blocking state Jul 12 09:52:07.049331 kernel: docker0: port 1(veth1190131) entered disabled state Jul 12 09:52:07.049347 kernel: veth1190131: entered allmulticast mode Jul 12 09:52:07.049363 kernel: veth1190131: entered promiscuous mode Jul 12 09:52:07.049811 systemd-networkd[1406]: veth1190131: Link UP Jul 12 09:52:07.056960 kernel: eth0: renamed from veth65df17f Jul 12 09:52:07.058059 kernel: docker0: port 1(veth1190131) entered blocking state Jul 12 09:52:07.058083 kernel: docker0: port 1(veth1190131) entered forwarding state Jul 12 09:52:07.058060 systemd-networkd[1406]: veth1190131: Gained carrier Jul 12 09:52:07.058265 systemd-networkd[1406]: docker0: Gained carrier Jul 12 09:52:07.079289 sshd[1886]: Connection closed by 10.0.0.1 port 60946 Jul 12 09:52:07.080136 sshd-session[1883]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:07.087363 systemd[1]: sshd@7-10.0.0.140:22-10.0.0.1:60946.service: Deactivated successfully. Jul 12 09:52:07.088929 systemd[1]: session-8.scope: Deactivated successfully. Jul 12 09:52:07.089636 systemd-logind[1469]: Session 8 logged out. Waiting for processes to exit. Jul 12 09:52:07.092208 systemd[1]: Started sshd@8-10.0.0.140:22-10.0.0.1:60958.service - OpenSSH per-connection server daemon (10.0.0.1:60958). Jul 12 09:52:07.093473 systemd-logind[1469]: Removed session 8. Jul 12 09:52:07.144074 sshd[1959]: Accepted publickey for core from 10.0.0.1 port 60958 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:07.145125 sshd-session[1959]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:07.148787 systemd-logind[1469]: New session 9 of user core. Jul 12 09:52:07.164111 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 12 09:52:07.215401 sshd[1962]: Connection closed by 10.0.0.1 port 60958 Jul 12 09:52:07.215656 sshd-session[1959]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:07.234022 systemd[1]: sshd@8-10.0.0.140:22-10.0.0.1:60958.service: Deactivated successfully. Jul 12 09:52:07.235733 systemd[1]: session-9.scope: Deactivated successfully. Jul 12 09:52:07.236923 systemd-logind[1469]: Session 9 logged out. Waiting for processes to exit. Jul 12 09:52:07.238450 systemd[1]: Started sshd@9-10.0.0.140:22-10.0.0.1:60960.service - OpenSSH per-connection server daemon (10.0.0.1:60960). Jul 12 09:52:07.239280 systemd-logind[1469]: Removed session 9. Jul 12 09:52:07.292638 sshd[1968]: Accepted publickey for core from 10.0.0.1 port 60960 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:07.293724 sshd-session[1968]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:07.297409 systemd-logind[1469]: New session 10 of user core. Jul 12 09:52:07.306079 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 12 09:52:07.357757 sudo[1972]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1484 Jul 12 09:52:07.358045 sudo[1972]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 12 09:52:07.362967 sudo[1972]: pam_unix(sudo:session): session closed for user root Jul 12 09:52:07.363528 containerd[1484]: time="2025-07-12T09:52:07.363431462Z" level=info msg="Stop CRI service" Jul 12 09:52:07.363756 dockerd[1670]: time="2025-07-12T09:52:07.363714844Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 12 09:52:07.363756 dockerd[1670]: time="2025-07-12T09:52:07.363751605Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 12 09:52:07.364055 dockerd[1670]: time="2025-07-12T09:52:07.363999579Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 12 09:52:07.364055 dockerd[1670]: time="2025-07-12T09:52:07.364017940Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 12 09:52:07.364102 containerd[1484]: time="2025-07-12T09:52:07.363852253Z" level=info msg="Stop CRI service" Jul 12 09:52:07.364102 containerd[1484]: time="2025-07-12T09:52:07.363894192Z" level=info msg="Event monitor stopped" Jul 12 09:52:07.364102 containerd[1484]: time="2025-07-12T09:52:07.363899848Z" level=info msg="Stream server stopped" Jul 12 09:52:07.365117 sshd[1971]: Connection closed by 10.0.0.1 port 60960 Jul 12 09:52:07.364629 sshd-session[1968]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:07.374926 systemd[1]: containerd.service: Deactivated successfully. Jul 12 09:52:07.375062 systemd[1]: containerd.service: Unit process 1910 (containerd-shim) remains running after unit stopped. Jul 12 09:52:07.375284 systemd[1]: containerd.service: Consumed 334ms CPU time, 125.1M memory peak. Jul 12 09:52:07.375637 systemd[1]: sshd@9-10.0.0.140:22-10.0.0.1:60960.service: Deactivated successfully. Jul 12 09:52:07.377147 systemd[1]: session-10.scope: Deactivated successfully. Jul 12 09:52:07.378303 systemd-logind[1469]: Session 10 logged out. Waiting for processes to exit. Jul 12 09:52:07.380729 systemd[1]: Started sshd@10-10.0.0.140:22-10.0.0.1:60974.service - OpenSSH per-connection server daemon (10.0.0.1:60974). Jul 12 09:52:07.381486 systemd-logind[1469]: Removed session 10. Jul 12 09:52:07.432544 sshd[1979]: Accepted publickey for core from 10.0.0.1 port 60974 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:07.433559 sshd-session[1979]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:07.437811 systemd-logind[1469]: New session 11 of user core. Jul 12 09:52:07.449134 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 12 09:52:07.501053 sshd[1982]: Connection closed by 10.0.0.1 port 60974 Jul 12 09:52:07.501259 sshd-session[1979]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:07.504335 systemd[1]: sshd@10-10.0.0.140:22-10.0.0.1:60974.service: Deactivated successfully. Jul 12 09:52:07.505848 systemd[1]: session-11.scope: Deactivated successfully. Jul 12 09:52:07.506494 systemd-logind[1469]: Session 11 logged out. Waiting for processes to exit. Jul 12 09:52:07.507447 systemd-logind[1469]: Removed session 11. Jul 12 09:52:08.359125 systemd-networkd[1406]: docker0: Gained IPv6LL Jul 12 09:52:08.936120 systemd-networkd[1406]: veth1190131: Gained IPv6LL Jul 12 09:52:12.625655 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jul 12 09:52:12.626034 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 12 09:52:12.626230 dockerd[1670]: time="2025-07-12T09:52:12.626180970Z" level=info msg="Processing signal 'terminated'" Jul 12 09:52:13.494717 systemd[1]: Started sshd@11-10.0.0.140:22-10.0.0.1:36660.service - OpenSSH per-connection server daemon (10.0.0.1:36660). Jul 12 09:52:13.538581 sshd[1988]: Accepted publickey for core from 10.0.0.1 port 36660 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:13.539759 sshd-session[1988]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:13.543358 systemd-logind[1469]: New session 12 of user core. Jul 12 09:52:13.552066 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 12 09:52:13.604375 sshd[1991]: Connection closed by 10.0.0.1 port 36660 Jul 12 09:52:13.604267 sshd-session[1988]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:13.607559 systemd[1]: sshd@11-10.0.0.140:22-10.0.0.1:36660.service: Deactivated successfully. Jul 12 09:52:13.609071 systemd[1]: session-12.scope: Deactivated successfully. Jul 12 09:52:13.610442 systemd-logind[1469]: Session 12 logged out. Waiting for processes to exit. Jul 12 09:52:13.611309 systemd-logind[1469]: Removed session 12. Jul 12 09:52:19.611782 systemd[1]: Started sshd@12-10.0.0.140:22-10.0.0.1:36666.service - OpenSSH per-connection server daemon (10.0.0.1:36666). Jul 12 09:52:19.667156 sshd[1997]: Accepted publickey for core from 10.0.0.1 port 36666 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:19.668224 sshd-session[1997]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:19.672566 systemd-logind[1469]: New session 13 of user core. Jul 12 09:52:19.687128 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 12 09:52:19.738928 sshd[2000]: Connection closed by 10.0.0.1 port 36666 Jul 12 09:52:19.738864 sshd-session[1997]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:19.742157 systemd[1]: sshd@12-10.0.0.140:22-10.0.0.1:36666.service: Deactivated successfully. Jul 12 09:52:19.744187 systemd[1]: session-13.scope: Deactivated successfully. Jul 12 09:52:19.744997 systemd-logind[1469]: Session 13 logged out. Waiting for processes to exit. Jul 12 09:52:19.746262 systemd-logind[1469]: Removed session 13. Jul 12 09:52:25.757771 systemd[1]: Started sshd@13-10.0.0.140:22-10.0.0.1:48422.service - OpenSSH per-connection server daemon (10.0.0.1:48422). Jul 12 09:52:25.804435 sshd[2006]: Accepted publickey for core from 10.0.0.1 port 48422 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:25.805737 sshd-session[2006]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:25.810037 systemd-logind[1469]: New session 14 of user core. Jul 12 09:52:25.820096 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 12 09:52:25.873979 sshd[2009]: Connection closed by 10.0.0.1 port 48422 Jul 12 09:52:25.874285 sshd-session[2006]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:25.877260 systemd[1]: sshd@13-10.0.0.140:22-10.0.0.1:48422.service: Deactivated successfully. Jul 12 09:52:25.878805 systemd[1]: session-14.scope: Deactivated successfully. Jul 12 09:52:25.882253 systemd-logind[1469]: Session 14 logged out. Waiting for processes to exit. Jul 12 09:52:25.883763 systemd-logind[1469]: Removed session 14. Jul 12 09:52:27.627363 dockerd[1670]: time="2025-07-12T09:52:27.627263382Z" level=error msg="Force shutdown daemon" Jul 12 09:52:27.628108 dockerd[1670]: time="2025-07-12T09:52:27.627769432Z" level=info msg="Daemon shutdown complete" Jul 12 09:52:27.628108 dockerd[1670]: time="2025-07-12T09:52:27.627980970Z" 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" Jul 12 09:52:27.628108 dockerd[1670]: time="2025-07-12T09:52:27.628007882Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby Jul 12 09:52:27.628108 dockerd[1670]: time="2025-07-12T09:52:27.628013560Z" 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" Jul 12 09:52:27.628108 dockerd[1670]: time="2025-07-12T09:52:27.628029915Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Jul 12 09:52:27.631177 systemd[1]: docker.service: Deactivated successfully. Jul 12 09:52:27.631504 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 12 09:52:27.631575 systemd[1]: docker.service: Consumed 863ms CPU time, 123.2M memory peak. Jul 12 09:52:27.632030 systemd[1]: docker.socket: Deactivated successfully. Jul 12 09:52:27.632325 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 12 09:52:27.632368 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 12 09:52:27.633828 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 12 09:52:27.634028 systemd[1]: containerd.service: Found left-over process 1910 (containerd-shim) in control group while starting unit. Ignoring. Jul 12 09:52:27.634037 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 12 09:52:27.643561 systemd[1]: Starting containerd.service - containerd container runtime... Jul 12 09:52:27.643851 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 12 09:52:27.655159 systemd[1]: containerd.service: Found left-over process 1910 (containerd-shim) in control group while starting unit. Ignoring. Jul 12 09:52:27.655172 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 12 09:52:27.659812 (ntainerd)[2020]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 12 09:52:27.673114 containerd[2020]: time="2025-07-12T09:52:27Z" 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 Jul 12 09:52:27.673623 containerd[2020]: time="2025-07-12T09:52:27.673588170Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Jul 12 09:52:27.681322 containerd[2020]: time="2025-07-12T09:52:27.681254097Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="11.277µs" Jul 12 09:52:27.681469 containerd[2020]: time="2025-07-12T09:52:27.681447920Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 12 09:52:27.681556 containerd[2020]: time="2025-07-12T09:52:27.681541052Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 12 09:52:27.681634 containerd[2020]: time="2025-07-12T09:52:27.681620428Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 12 09:52:27.681743 containerd[2020]: time="2025-07-12T09:52:27.681727397Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 12 09:52:27.682033 containerd[2020]: time="2025-07-12T09:52:27.682013432Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682118 containerd[2020]: time="2025-07-12T09:52:27.682102246Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682179 containerd[2020]: time="2025-07-12T09:52:27.682165747Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682462 containerd[2020]: time="2025-07-12T09:52:27.682437746Z" 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 Jul 12 09:52:27.682530 containerd[2020]: time="2025-07-12T09:52:27.682515643Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682590 containerd[2020]: time="2025-07-12T09:52:27.682574905Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682638 containerd[2020]: time="2025-07-12T09:52:27.682626170Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682706 containerd[2020]: time="2025-07-12T09:52:27.682692711Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682847 containerd[2020]: time="2025-07-12T09:52:27.682829630Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 12 09:52:27.682917 containerd[2020]: time="2025-07-12T09:52:27.682901689Z" 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 Jul 12 09:52:27.683012 containerd[2020]: time="2025-07-12T09:52:27.682995461Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 12 09:52:27.683092 containerd[2020]: time="2025-07-12T09:52:27.683078356Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 12 09:52:27.683378 containerd[2020]: time="2025-07-12T09:52:27.683349596Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 12 09:52:27.683445 containerd[2020]: time="2025-07-12T09:52:27.683432811Z" level=info msg="metadata content store policy set" policy=shared Jul 12 09:52:27.683638 containerd[2020]: time="2025-07-12T09:52:27.683618116Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 12 09:52:27.683735 containerd[2020]: time="2025-07-12T09:52:27.683717967Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 12 09:52:27.683792 containerd[2020]: time="2025-07-12T09:52:27.683779148Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 12 09:52:27.683851 containerd[2020]: time="2025-07-12T09:52:27.683838171Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 12 09:52:27.683899 containerd[2020]: time="2025-07-12T09:52:27.683886996Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 12 09:52:27.683981 containerd[2020]: time="2025-07-12T09:52:27.683966453Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 12 09:52:27.684052 containerd[2020]: time="2025-07-12T09:52:27.684037232Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 12 09:52:27.684114 containerd[2020]: time="2025-07-12T09:52:27.684100973Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 12 09:52:27.684171 containerd[2020]: time="2025-07-12T09:52:27.684157156Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 12 09:52:27.684229 containerd[2020]: time="2025-07-12T09:52:27.684215739Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 12 09:52:27.684284 containerd[2020]: time="2025-07-12T09:52:27.684271323Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 12 09:52:27.684350 containerd[2020]: time="2025-07-12T09:52:27.684335184Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 12 09:52:27.684647 containerd[2020]: time="2025-07-12T09:52:27.684620579Z" level=info msg="connecting to shim bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548" address="unix:///run/containerd/s/12a76e39168e31db2d66c27f8cd93c0a5d6e1674f7f614715c6b566d60aa8684" namespace=moby protocol=ttrpc version=3 Jul 12 09:52:27.691470 containerd[2020]: time="2025-07-12T09:52:27.691431560Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691483784Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691500419Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691511936Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691523173Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691533610Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691545006Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691555043Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691569359Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 12 09:52:27.691576 containerd[2020]: time="2025-07-12T09:52:27.691579716Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 12 09:52:27.691739 containerd[2020]: time="2025-07-12T09:52:27.691590513Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 12 09:52:27.691739 containerd[2020]: time="2025-07-12T09:52:27.691649535Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 12 09:52:27.691739 containerd[2020]: time="2025-07-12T09:52:27.691665930Z" level=info msg="Start snapshots syncer" Jul 12 09:52:27.691739 containerd[2020]: time="2025-07-12T09:52:27.691698721Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 12 09:52:27.691957 containerd[2020]: time="2025-07-12T09:52:27.691903180Z" 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\"}" Jul 12 09:52:27.692043 containerd[2020]: time="2025-07-12T09:52:27.691980557Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 12 09:52:27.692101 containerd[2020]: time="2025-07-12T09:52:27.692082367Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692143549Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692163183Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692173820Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692184817Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692196613Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692207730Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 12 09:52:27.692225 containerd[2020]: time="2025-07-12T09:52:27.692218047Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692248238Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692261834Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692272311Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692308540Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692323615Z" 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 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692336292Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692345729Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:52:27.692371 containerd[2020]: time="2025-07-12T09:52:27.692364043Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692382638Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692394354Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692411709Z" level=info msg="runtime interface created" Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692417068Z" level=info msg="created NRI interface" Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692426665Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692437902Z" level=info msg="Connect containerd service" Jul 12 09:52:27.692510 containerd[2020]: time="2025-07-12T09:52:27.692473691Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 12 09:52:27.693015 containerd[2020]: time="2025-07-12T09:52:27.692992777Z" 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" Jul 12 09:52:27.701715 containerd[2020]: time="2025-07-12T09:52:27.701662687Z" level=info msg="Start subscribing containerd event" Jul 12 09:52:27.701835 containerd[2020]: time="2025-07-12T09:52:27.701734985Z" level=info msg="Start recovering state" Jul 12 09:52:27.701835 containerd[2020]: time="2025-07-12T09:52:27.701802565Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 12 09:52:27.701835 containerd[2020]: time="2025-07-12T09:52:27.701814882Z" level=info msg="Start event monitor" Jul 12 09:52:27.701916 containerd[2020]: time="2025-07-12T09:52:27.701844593Z" level=info msg="Start cni network conf syncer for default" Jul 12 09:52:27.701916 containerd[2020]: time="2025-07-12T09:52:27.701848832Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 12 09:52:27.701916 containerd[2020]: time="2025-07-12T09:52:27.701852351Z" level=info msg="Start streaming server" Jul 12 09:52:27.701916 containerd[2020]: time="2025-07-12T09:52:27.701906175Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 12 09:52:27.701916 containerd[2020]: time="2025-07-12T09:52:27.701914532Z" level=info msg="runtime interface starting up..." Jul 12 09:52:27.702019 containerd[2020]: time="2025-07-12T09:52:27.701920810Z" level=info msg="starting plugins..." Jul 12 09:52:27.702019 containerd[2020]: time="2025-07-12T09:52:27.701944843Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 12 09:52:27.702091 containerd[2020]: time="2025-07-12T09:52:27.702074485Z" level=info msg="containerd successfully booted in 0.029146s" Jul 12 09:52:27.702182 systemd[1]: Started containerd.service - containerd container runtime. Jul 12 09:52:27.705746 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 12 09:52:27.718316 (dockerd)[2048]: 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 Jul 12 09:52:27.743450 dockerd[2048]: time="2025-07-12T09:52:27.743392876Z" level=info msg="Starting up" Jul 12 09:52:27.744189 dockerd[2048]: time="2025-07-12T09:52:27.744164128Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 12 09:52:27.753511 dockerd[2048]: time="2025-07-12T09:52:27.753470609Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jul 12 09:52:27.776876 systemd[1]: var-lib-docker-overlay2-metacopy\x2dcheck724596033-merged.mount: Deactivated successfully. Jul 12 09:52:27.781817 dockerd[2048]: time="2025-07-12T09:52:27.781770899Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 12 09:52:27.790051 dockerd[2048]: time="2025-07-12T09:52:27.790009737Z" level=info msg="Loading containers: start." Jul 12 09:52:31.888701 systemd[1]: Started sshd@14-10.0.0.140:22-10.0.0.1:48438.service - OpenSSH per-connection server daemon (10.0.0.1:48438). Jul 12 09:52:31.956496 sshd[2079]: Accepted publickey for core from 10.0.0.1 port 48438 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:31.957573 sshd-session[2079]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:31.961686 systemd-logind[1469]: New session 15 of user core. Jul 12 09:52:31.969080 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 12 09:52:32.021097 sshd[2082]: Connection closed by 10.0.0.1 port 48438 Jul 12 09:52:32.021478 sshd-session[2079]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:32.034538 systemd[1]: sshd@14-10.0.0.140:22-10.0.0.1:48438.service: Deactivated successfully. Jul 12 09:52:32.037051 systemd[1]: session-15.scope: Deactivated successfully. Jul 12 09:52:32.037618 systemd-logind[1469]: Session 15 logged out. Waiting for processes to exit. Jul 12 09:52:32.039425 systemd[1]: Started sshd@15-10.0.0.140:22-10.0.0.1:48448.service - OpenSSH per-connection server daemon (10.0.0.1:48448). Jul 12 09:52:32.040109 systemd-logind[1469]: Removed session 15. Jul 12 09:52:32.090845 sshd[2088]: Accepted publickey for core from 10.0.0.1 port 48448 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:32.091884 sshd-session[2088]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:32.095185 systemd-logind[1469]: New session 16 of user core. Jul 12 09:52:32.104122 systemd[1]: Started session-16.scope - Session 16 of User core. Jul 12 09:52:32.155023 sshd[2091]: Connection closed by 10.0.0.1 port 48448 Jul 12 09:52:32.155517 sshd-session[2088]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:32.169598 systemd[1]: sshd@15-10.0.0.140:22-10.0.0.1:48448.service: Deactivated successfully. Jul 12 09:52:32.172095 systemd[1]: session-16.scope: Deactivated successfully. Jul 12 09:52:32.172879 systemd-logind[1469]: Session 16 logged out. Waiting for processes to exit. Jul 12 09:52:32.174967 systemd[1]: Started sshd@16-10.0.0.140:22-10.0.0.1:48456.service - OpenSSH per-connection server daemon (10.0.0.1:48456). Jul 12 09:52:32.176150 systemd-logind[1469]: Removed session 16. Jul 12 09:52:32.232690 sshd[2097]: Accepted publickey for core from 10.0.0.1 port 48456 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:32.233742 sshd-session[2097]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:32.237101 systemd-logind[1469]: New session 17 of user core. Jul 12 09:52:32.259078 systemd[1]: Started session-17.scope - Session 17 of User core. Jul 12 09:52:37.809001 dockerd[2048]: time="2025-07-12T09:52:37.808649070Z" level=info msg="Container failed to exit within 10s of signal 15 - using the force" container=bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548 Jul 12 09:52:37.818956 systemd[1]: docker-bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548.scope: Deactivated successfully. Jul 12 09:52:37.830834 dockerd[2048]: time="2025-07-12T09:52:37.830461918Z" level=info msg="ignoring event" container=bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete" Jul 12 09:52:37.830915 containerd[2020]: time="2025-07-12T09:52:37.830806109Z" level=info msg="shim disconnected" id=bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548 namespace=moby Jul 12 09:52:37.830915 containerd[2020]: time="2025-07-12T09:52:37.830843028Z" level=warning msg="cleaning up after shim disconnected" id=bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548 namespace=moby Jul 12 09:52:37.830915 containerd[2020]: time="2025-07-12T09:52:37.830870947Z" level=info msg="cleaning up dead shim" namespace=moby Jul 12 09:52:37.843175 systemd[1]: var-lib-docker-overlay2-3636e196dcf9f147f8fb3fbd2b226069c4b72a241cfde10b872fcc1e3c43aa5b-merged.mount: Deactivated successfully. Jul 12 09:52:38.253809 systemd-networkd[1406]: veth1190131: Link DOWN Jul 12 09:52:38.253814 systemd-networkd[1406]: veth1190131: Lost carrier Jul 12 09:52:38.254579 systemd[1]: run-docker-netns-4a3344b00f78.mount: Deactivated successfully. Jul 12 09:52:38.255497 kernel: docker0: port 1(veth1190131) entered disabled state Jul 12 09:52:38.255565 kernel: veth1190131 (unregistering): left allmulticast mode Jul 12 09:52:38.256952 kernel: veth1190131 (unregistering): left promiscuous mode Jul 12 09:52:38.256993 kernel: docker0: port 1(veth1190131) entered disabled state Jul 12 09:52:38.259276 systemd-networkd[1406]: docker0: Lost carrier Jul 12 09:52:38.259977 dockerd[2048]: time="2025-07-12T09:52:38.259927828Z" level=info msg="Removing stale sandbox 4a3344b00f78245e2d193db332ae985a98b64991ac1496a9fdddf9a12420200c (bf7450f09a5382425a68f43f4b2aa5f1367e8afd8e6820d2f13025042c6a7548)" Jul 12 09:52:38.263894 dockerd[2048]: time="2025-07-12T09:52:38.263850854Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 12 09:52:38.263994 dockerd[2048]: time="2025-07-12T09:52:38.263900173Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 83dfe0a3b045a17bff8a8f6ebb55abd6c69a3b9e0fd36eaec01f3e9c1634df6e ef9d1f3ada12faacdf57aacd0805848fb143e0484bf778e186dd84fe0815cb6f], retrying...." Jul 12 09:52:38.267782 systemd[1]: run-docker-netns-4a3344b00f78.mount: Deactivated successfully. Jul 12 09:52:38.446574 dockerd[2048]: time="2025-07-12T09:52:38.446529430Z" level=warning msg="error locating sandbox id 4a3344b00f78245e2d193db332ae985a98b64991ac1496a9fdddf9a12420200c: sandbox 4a3344b00f78245e2d193db332ae985a98b64991ac1496a9fdddf9a12420200c not found" Jul 12 09:52:38.446738 dockerd[2048]: time="2025-07-12T09:52:38.446610548Z" level=info msg="Loading containers: done." Jul 12 09:52:38.459618 dockerd[2048]: time="2025-07-12T09:52:38.459563517Z" 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 Jul 12 09:52:38.459770 dockerd[2048]: time="2025-07-12T09:52:38.459650635Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jul 12 09:52:38.459770 dockerd[2048]: time="2025-07-12T09:52:38.459696554Z" level=info msg="Initializing buildkit" Jul 12 09:52:38.473637 dockerd[2048]: time="2025-07-12T09:52:38.473601020Z" level=info msg="Completed buildkit initialization" Jul 12 09:52:38.478102 dockerd[2048]: time="2025-07-12T09:52:38.478077073Z" level=info msg="Daemon has completed initialization" Jul 12 09:52:38.478264 dockerd[2048]: time="2025-07-12T09:52:38.478130512Z" level=info msg="API listen on /run/docker.sock" Jul 12 09:52:38.478331 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 12 09:52:38.487043 sshd[2100]: Connection closed by 10.0.0.1 port 48456 Jul 12 09:52:38.487790 sshd-session[2097]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:38.497856 systemd[1]: sshd@16-10.0.0.140:22-10.0.0.1:48456.service: Deactivated successfully. Jul 12 09:52:38.501768 systemd[1]: session-17.scope: Deactivated successfully. Jul 12 09:52:38.502758 systemd-logind[1469]: Session 17 logged out. Waiting for processes to exit. Jul 12 09:52:38.505076 systemd[1]: Started sshd@17-10.0.0.140:22-10.0.0.1:60564.service - OpenSSH per-connection server daemon (10.0.0.1:60564). Jul 12 09:52:38.507142 systemd-logind[1469]: Removed session 17. Jul 12 09:52:38.565016 sshd[2350]: Accepted publickey for core from 10.0.0.1 port 60564 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:38.566113 sshd-session[2350]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:38.570334 systemd-logind[1469]: New session 18 of user core. Jul 12 09:52:38.586090 systemd[1]: Started session-18.scope - Session 18 of User core. Jul 12 09:52:38.694496 containerd[2020]: time="2025-07-12T09:52:38.694452320Z" level=info msg="connecting to shim ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2" address="unix:///run/containerd/s/b20edf048db2f91db5c9c7d483f8a0612222e02cf303e8040c25e1049f5e06cb" namespace=moby protocol=ttrpc version=3 Jul 12 09:52:38.717082 systemd[1]: Started docker-ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2.scope - libcontainer container ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2. Jul 12 09:52:38.726900 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 12 09:52:38.740225 kernel: docker0: port 1(veth7e9cf23) entered blocking state Jul 12 09:52:38.740295 kernel: docker0: port 1(veth7e9cf23) entered disabled state Jul 12 09:52:38.741230 kernel: veth7e9cf23: entered allmulticast mode Jul 12 09:52:38.741268 kernel: veth7e9cf23: entered promiscuous mode Jul 12 09:52:38.741503 systemd-networkd[1406]: veth7e9cf23: Link UP Jul 12 09:52:38.747801 kernel: eth0: renamed from veth9faf7ae Jul 12 09:52:38.747863 kernel: docker0: port 1(veth7e9cf23) entered blocking state Jul 12 09:52:38.747878 kernel: docker0: port 1(veth7e9cf23) entered forwarding state Jul 12 09:52:38.748759 systemd-networkd[1406]: veth7e9cf23: Gained carrier Jul 12 09:52:38.749018 systemd-networkd[1406]: docker0: Gained carrier Jul 12 09:52:38.766746 sshd[2354]: Connection closed by 10.0.0.1 port 60564 Jul 12 09:52:38.767317 sshd-session[2350]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:38.778857 systemd[1]: sshd@17-10.0.0.140:22-10.0.0.1:60564.service: Deactivated successfully. Jul 12 09:52:38.781372 systemd[1]: session-18.scope: Deactivated successfully. Jul 12 09:52:38.783191 systemd-logind[1469]: Session 18 logged out. Waiting for processes to exit. Jul 12 09:52:38.784011 systemd[1]: Started sshd@18-10.0.0.140:22-10.0.0.1:60578.service - OpenSSH per-connection server daemon (10.0.0.1:60578). Jul 12 09:52:38.784832 systemd-logind[1469]: Removed session 18. Jul 12 09:52:38.841181 sshd[2421]: Accepted publickey for core from 10.0.0.1 port 60578 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:38.842452 sshd-session[2421]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:38.849700 systemd-logind[1469]: New session 19 of user core. Jul 12 09:52:38.860090 systemd[1]: Started session-19.scope - Session 19 of User core. Jul 12 09:52:38.913756 sshd[2424]: Connection closed by 10.0.0.1 port 60578 Jul 12 09:52:38.913620 sshd-session[2421]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:38.922837 systemd[1]: sshd@18-10.0.0.140:22-10.0.0.1:60578.service: Deactivated successfully. Jul 12 09:52:38.925454 systemd[1]: session-19.scope: Deactivated successfully. Jul 12 09:52:38.927089 systemd-logind[1469]: Session 19 logged out. Waiting for processes to exit. Jul 12 09:52:38.929277 systemd[1]: Started sshd@19-10.0.0.140:22-10.0.0.1:60582.service - OpenSSH per-connection server daemon (10.0.0.1:60582). Jul 12 09:52:38.929719 systemd-logind[1469]: Removed session 19. Jul 12 09:52:38.983086 sshd[2430]: Accepted publickey for core from 10.0.0.1 port 60582 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:38.984180 sshd-session[2430]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:38.988188 systemd-logind[1469]: New session 20 of user core. Jul 12 09:52:39.000090 systemd[1]: Started session-20.scope - Session 20 of User core. Jul 12 09:52:39.050834 sudo[2434]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 2020 Jul 12 09:52:39.051148 sudo[2434]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 12 09:52:39.053963 sudo[2434]: pam_unix(sudo:session): session closed for user root Jul 12 09:52:39.054893 sshd[2433]: Connection closed by 10.0.0.1 port 60582 Jul 12 09:52:39.055340 sshd-session[2430]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:39.056636 dockerd[2048]: time="2025-07-12T09:52:39.056546979Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 12 09:52:39.056867 dockerd[2048]: time="2025-07-12T09:52:39.056637337Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 12 09:52:39.056867 dockerd[2048]: time="2025-07-12T09:52:39.056621577Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 12 09:52:39.056867 dockerd[2048]: time="2025-07-12T09:52:39.056749654Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 12 09:52:39.068168 systemd[1]: containerd.service: Deactivated successfully. Jul 12 09:52:39.068263 systemd[1]: containerd.service: Unit process 2372 (containerd-shim) remains running after unit stopped. Jul 12 09:52:39.068458 systemd[1]: containerd.service: Consumed 166ms CPU time, 126.7M memory peak. Jul 12 09:52:39.068818 systemd[1]: sshd@19-10.0.0.140:22-10.0.0.1:60582.service: Deactivated successfully. Jul 12 09:52:39.070179 systemd[1]: session-20.scope: Deactivated successfully. Jul 12 09:52:39.072430 systemd-logind[1469]: Session 20 logged out. Waiting for processes to exit. Jul 12 09:52:39.075256 systemd[1]: Started sshd@20-10.0.0.140:22-10.0.0.1:60592.service - OpenSSH per-connection server daemon (10.0.0.1:60592). Jul 12 09:52:39.075927 systemd-logind[1469]: Removed session 20. Jul 12 09:52:39.131466 sshd[2441]: Accepted publickey for core from 10.0.0.1 port 60592 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:39.132844 sshd-session[2441]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:39.137454 systemd-logind[1469]: New session 21 of user core. Jul 12 09:52:39.149083 systemd[1]: Started session-21.scope - Session 21 of User core. Jul 12 09:52:39.201355 sshd[2444]: Connection closed by 10.0.0.1 port 60592 Jul 12 09:52:39.201793 sshd-session[2441]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:39.205762 systemd[1]: sshd@20-10.0.0.140:22-10.0.0.1:60592.service: Deactivated successfully. Jul 12 09:52:39.207429 systemd[1]: session-21.scope: Deactivated successfully. Jul 12 09:52:39.209714 systemd-logind[1469]: Session 21 logged out. Waiting for processes to exit. Jul 12 09:52:39.210579 systemd-logind[1469]: Removed session 21. Jul 12 09:52:39.911229 systemd-networkd[1406]: veth7e9cf23: Gained IPv6LL Jul 12 09:52:42.515386 update_engine[1472]: I20250712 09:52:42.515296 1472 update_attempter.cc:509] Updating boot flags... Jul 12 09:52:44.082401 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jul 12 09:52:44.082851 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 12 09:52:44.083279 dockerd[2048]: time="2025-07-12T09:52:44.082934791Z" level=info msg="Processing signal 'terminated'" Jul 12 09:52:45.212611 systemd[1]: Started sshd@21-10.0.0.140:22-10.0.0.1:42222.service - OpenSSH per-connection server daemon (10.0.0.1:42222). Jul 12 09:52:45.270534 sshd[2464]: Accepted publickey for core from 10.0.0.1 port 42222 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:45.271529 sshd-session[2464]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:45.275080 systemd-logind[1469]: New session 22 of user core. Jul 12 09:52:45.281068 systemd[1]: Started session-22.scope - Session 22 of User core. Jul 12 09:52:45.333617 sshd[2467]: Connection closed by 10.0.0.1 port 42222 Jul 12 09:52:45.333995 sshd-session[2464]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:45.336865 systemd[1]: sshd@21-10.0.0.140:22-10.0.0.1:42222.service: Deactivated successfully. Jul 12 09:52:45.338213 systemd[1]: session-22.scope: Deactivated successfully. Jul 12 09:52:45.340743 systemd-logind[1469]: Session 22 logged out. Waiting for processes to exit. Jul 12 09:52:45.341594 systemd-logind[1469]: Removed session 22. Jul 12 09:52:46.085073 dockerd[2048]: time="2025-07-12T09:52:46.084751096Z" level=error msg="Error sending stop (signal 15) to container" container=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 error="Cannot kill container ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jul 12 09:52:46.085073 dockerd[2048]: time="2025-07-12T09:52:46.084844135Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 Jul 12 09:52:51.348882 systemd[1]: Started sshd@22-10.0.0.140:22-10.0.0.1:42226.service - OpenSSH per-connection server daemon (10.0.0.1:42226). Jul 12 09:52:51.405806 sshd[2473]: Accepted publickey for core from 10.0.0.1 port 42226 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:51.406828 sshd-session[2473]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:51.410862 systemd-logind[1469]: New session 23 of user core. Jul 12 09:52:51.421066 systemd[1]: Started session-23.scope - Session 23 of User core. Jul 12 09:52:51.472918 sshd[2476]: Connection closed by 10.0.0.1 port 42226 Jul 12 09:52:51.472854 sshd-session[2473]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:51.476130 systemd[1]: sshd@22-10.0.0.140:22-10.0.0.1:42226.service: Deactivated successfully. Jul 12 09:52:51.479216 systemd[1]: session-23.scope: Deactivated successfully. Jul 12 09:52:51.479783 systemd-logind[1469]: Session 23 logged out. Waiting for processes to exit. Jul 12 09:52:51.480681 systemd-logind[1469]: Removed session 23. Jul 12 09:52:56.085955 dockerd[2048]: time="2025-07-12T09:52:56.085901886Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 error="context deadline exceeded" Jul 12 09:52:56.086642 systemd[1]: docker-ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2.scope: Deactivated successfully. Jul 12 09:52:57.494536 systemd[1]: Started sshd@23-10.0.0.140:22-10.0.0.1:60190.service - OpenSSH per-connection server daemon (10.0.0.1:60190). Jul 12 09:52:57.538679 sshd[2482]: Accepted publickey for core from 10.0.0.1 port 60190 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:52:57.539729 sshd-session[2482]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:52:57.543682 systemd-logind[1469]: New session 24 of user core. Jul 12 09:52:57.551066 systemd[1]: Started session-24.scope - Session 24 of User core. Jul 12 09:52:57.602487 sshd[2485]: Connection closed by 10.0.0.1 port 60190 Jul 12 09:52:57.602428 sshd-session[2482]: pam_unix(sshd:session): session closed for user core Jul 12 09:52:57.605583 systemd[1]: sshd@23-10.0.0.140:22-10.0.0.1:60190.service: Deactivated successfully. Jul 12 09:52:57.607024 systemd[1]: session-24.scope: Deactivated successfully. Jul 12 09:52:57.607693 systemd-logind[1469]: Session 24 logged out. Waiting for processes to exit. Jul 12 09:52:57.608688 systemd-logind[1469]: Removed session 24. Jul 12 09:52:59.084105 dockerd[2048]: time="2025-07-12T09:52:59.084051846Z" level=error msg="Force shutdown daemon" Jul 12 09:52:59.084488 dockerd[2048]: time="2025-07-12T09:52:59.084158205Z" level=info msg="Daemon shutdown complete" Jul 12 09:52:59.084488 dockerd[2048]: time="2025-07-12T09:52:59.084252644Z" 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\"" Jul 12 09:52:59.084488 dockerd[2048]: time="2025-07-12T09:52:59.084276004Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Jul 12 09:52:59.084488 dockerd[2048]: time="2025-07-12T09:52:59.084313564Z" 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\"" Jul 12 09:52:59.084488 dockerd[2048]: time="2025-07-12T09:52:59.084327403Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=moby Jul 12 09:52:59.088107 systemd[1]: docker.service: Deactivated successfully. Jul 12 09:52:59.088454 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 12 09:52:59.088901 systemd[1]: docker.socket: Deactivated successfully. Jul 12 09:52:59.089807 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 12 09:52:59.089867 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 12 09:52:59.091336 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 12 09:52:59.091557 systemd[1]: containerd.service: Found left-over process 2372 (containerd-shim) in control group while starting unit. Ignoring. Jul 12 09:52:59.091568 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 12 09:52:59.098292 systemd[1]: Starting containerd.service - containerd container runtime... Jul 12 09:52:59.099188 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 12 09:52:59.108813 systemd[1]: containerd.service: Found left-over process 2372 (containerd-shim) in control group while starting unit. Ignoring. Jul 12 09:52:59.108825 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 12 09:52:59.112755 (ntainerd)[2496]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 12 09:52:59.124919 containerd[2496]: time="2025-07-12T09:52:59Z" 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 Jul 12 09:52:59.125341 containerd[2496]: time="2025-07-12T09:52:59.125307337Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Jul 12 09:52:59.133146 containerd[2496]: time="2025-07-12T09:52:59.133106623Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="8.92µs" Jul 12 09:52:59.133239 containerd[2496]: time="2025-07-12T09:52:59.133224822Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 12 09:52:59.133304 containerd[2496]: time="2025-07-12T09:52:59.133279061Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 12 09:52:59.133391 containerd[2496]: time="2025-07-12T09:52:59.133377220Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 12 09:52:59.133445 containerd[2496]: time="2025-07-12T09:52:59.133432980Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 12 09:52:59.133669 containerd[2496]: time="2025-07-12T09:52:59.133649378Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:52:59.133755 containerd[2496]: time="2025-07-12T09:52:59.133738817Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 12 09:52:59.133806 containerd[2496]: time="2025-07-12T09:52:59.133793536Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134079 containerd[2496]: time="2025-07-12T09:52:59.134058694Z" 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 Jul 12 09:52:59.134139 containerd[2496]: time="2025-07-12T09:52:59.134126693Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134200 containerd[2496]: time="2025-07-12T09:52:59.134187093Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134258 containerd[2496]: time="2025-07-12T09:52:59.134245812Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134341 containerd[2496]: time="2025-07-12T09:52:59.134327131Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134470 containerd[2496]: time="2025-07-12T09:52:59.134453970Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 12 09:52:59.134544 containerd[2496]: time="2025-07-12T09:52:59.134529729Z" 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 Jul 12 09:52:59.134593 containerd[2496]: time="2025-07-12T09:52:59.134580929Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 12 09:52:59.134669 containerd[2496]: time="2025-07-12T09:52:59.134654248Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 12 09:52:59.135215 containerd[2496]: time="2025-07-12T09:52:59.135182563Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 12 09:52:59.135326 containerd[2496]: time="2025-07-12T09:52:59.135310242Z" level=info msg="metadata content store policy set" policy=shared Jul 12 09:52:59.135698 containerd[2496]: time="2025-07-12T09:52:59.135649279Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 12 09:52:59.135734 containerd[2496]: time="2025-07-12T09:52:59.135704998Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 12 09:52:59.135734 containerd[2496]: time="2025-07-12T09:52:59.135722798Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 12 09:52:59.135787 containerd[2496]: time="2025-07-12T09:52:59.135737838Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 12 09:52:59.135816 containerd[2496]: time="2025-07-12T09:52:59.135786558Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 12 09:52:59.135816 containerd[2496]: time="2025-07-12T09:52:59.135801397Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 12 09:52:59.135853 containerd[2496]: time="2025-07-12T09:52:59.135815397Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 12 09:52:59.135853 containerd[2496]: time="2025-07-12T09:52:59.135827717Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 12 09:52:59.135853 containerd[2496]: time="2025-07-12T09:52:59.135842957Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 12 09:52:59.135907 containerd[2496]: time="2025-07-12T09:52:59.135856117Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 12 09:52:59.135907 containerd[2496]: time="2025-07-12T09:52:59.135869357Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 12 09:52:59.135907 containerd[2496]: time="2025-07-12T09:52:59.135881437Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 12 09:52:59.136173 containerd[2496]: time="2025-07-12T09:52:59.136148034Z" level=info msg="connecting to shim ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2" address="unix:///run/containerd/s/b20edf048db2f91db5c9c7d483f8a0612222e02cf303e8040c25e1049f5e06cb" namespace=moby protocol=ttrpc version=3 Jul 12 09:52:59.142150 containerd[2496]: time="2025-07-12T09:52:59.142091018Z" level=info msg="cleaning leaked shim process" id=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 namespace=moby Jul 12 09:52:59.149864 containerd[2496]: time="2025-07-12T09:52:59.149815745Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 12 09:52:59.149983 containerd[2496]: time="2025-07-12T09:52:59.149925184Z" level=info msg="shim disconnected" id=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 namespace=moby Jul 12 09:52:59.150028 containerd[2496]: time="2025-07-12T09:52:59.149982984Z" level=warning msg="cleaning up after shim disconnected" id=ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2 namespace=moby Jul 12 09:52:59.150028 containerd[2496]: time="2025-07-12T09:52:59.149991464Z" level=info msg="cleaning up dead shim" namespace=moby Jul 12 09:52:59.159686 containerd[2496]: time="2025-07-12T09:52:59.159646092Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 12 09:52:59.159686 containerd[2496]: time="2025-07-12T09:52:59.159689612Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159713492Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159725372Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159736972Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159746971Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159758731Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159772931Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 12 09:52:59.159789 containerd[2496]: time="2025-07-12T09:52:59.159784811Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 12 09:52:59.159918 containerd[2496]: time="2025-07-12T09:52:59.159795851Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 12 09:52:59.159918 containerd[2496]: time="2025-07-12T09:52:59.159806171Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 12 09:52:59.159918 containerd[2496]: time="2025-07-12T09:52:59.159861930Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 12 09:52:59.159918 containerd[2496]: time="2025-07-12T09:52:59.159875930Z" level=info msg="Start snapshots syncer" Jul 12 09:52:59.159918 containerd[2496]: time="2025-07-12T09:52:59.159907570Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 12 09:52:59.160197 containerd[2496]: time="2025-07-12T09:52:59.160151368Z" 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\"}" Jul 12 09:52:59.160278 containerd[2496]: time="2025-07-12T09:52:59.160214287Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 12 09:52:59.160319 containerd[2496]: time="2025-07-12T09:52:59.160302286Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 12 09:52:59.160407 containerd[2496]: time="2025-07-12T09:52:59.160377285Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 12 09:52:59.160451 containerd[2496]: time="2025-07-12T09:52:59.160438245Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 12 09:52:59.160478 containerd[2496]: time="2025-07-12T09:52:59.160454845Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 12 09:52:59.160478 containerd[2496]: time="2025-07-12T09:52:59.160466125Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 12 09:52:59.160517 containerd[2496]: time="2025-07-12T09:52:59.160487764Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 12 09:52:59.160517 containerd[2496]: time="2025-07-12T09:52:59.160498804Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 12 09:52:59.160517 containerd[2496]: time="2025-07-12T09:52:59.160510084Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 12 09:52:59.160574 containerd[2496]: time="2025-07-12T09:52:59.160533564Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 12 09:52:59.160574 containerd[2496]: time="2025-07-12T09:52:59.160544924Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 12 09:52:59.160574 containerd[2496]: time="2025-07-12T09:52:59.160559484Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 12 09:52:59.160630 containerd[2496]: time="2025-07-12T09:52:59.160597403Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 12 09:52:59.160630 containerd[2496]: time="2025-07-12T09:52:59.160610843Z" 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 Jul 12 09:52:59.160630 containerd[2496]: time="2025-07-12T09:52:59.160620323Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:52:59.160691 containerd[2496]: time="2025-07-12T09:52:59.160629723Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 12 09:52:59.160691 containerd[2496]: time="2025-07-12T09:52:59.160637403Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 12 09:52:59.160788 containerd[2496]: time="2025-07-12T09:52:59.160771482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 12 09:52:59.160813 containerd[2496]: time="2025-07-12T09:52:59.160793322Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 12 09:52:59.160832 containerd[2496]: time="2025-07-12T09:52:59.160812161Z" level=info msg="runtime interface created" Jul 12 09:52:59.160832 containerd[2496]: time="2025-07-12T09:52:59.160818641Z" level=info msg="created NRI interface" Jul 12 09:52:59.160832 containerd[2496]: time="2025-07-12T09:52:59.160826921Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 12 09:52:59.160889 containerd[2496]: time="2025-07-12T09:52:59.160837801Z" level=info msg="Connect containerd service" Jul 12 09:52:59.160889 containerd[2496]: time="2025-07-12T09:52:59.160863001Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 12 09:52:59.161373 containerd[2496]: time="2025-07-12T09:52:59.161348836Z" 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" Jul 12 09:52:59.169564 containerd[2496]: time="2025-07-12T09:52:59.169467480Z" level=info msg="Start subscribing containerd event" Jul 12 09:52:59.169564 containerd[2496]: time="2025-07-12T09:52:59.169521919Z" level=info msg="Start recovering state" Jul 12 09:52:59.169676 containerd[2496]: time="2025-07-12T09:52:59.169628798Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 12 09:52:59.169723 containerd[2496]: time="2025-07-12T09:52:59.169707717Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 12 09:52:59.169804 containerd[2496]: time="2025-07-12T09:52:59.169789837Z" level=info msg="Start event monitor" Jul 12 09:52:59.169862 containerd[2496]: time="2025-07-12T09:52:59.169850236Z" level=info msg="Start cni network conf syncer for default" Jul 12 09:52:59.169919 containerd[2496]: time="2025-07-12T09:52:59.169907955Z" level=info msg="Start streaming server" Jul 12 09:52:59.169994 containerd[2496]: time="2025-07-12T09:52:59.169982435Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 12 09:52:59.170039 containerd[2496]: time="2025-07-12T09:52:59.170028394Z" level=info msg="runtime interface starting up..." Jul 12 09:52:59.170078 containerd[2496]: time="2025-07-12T09:52:59.170068794Z" level=info msg="starting plugins..." Jul 12 09:52:59.170134 containerd[2496]: time="2025-07-12T09:52:59.170123473Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 12 09:52:59.170298 containerd[2496]: time="2025-07-12T09:52:59.170273512Z" level=info msg="containerd successfully booted in 0.045503s" Jul 12 09:52:59.170372 systemd[1]: Started containerd.service - containerd container runtime. Jul 12 09:52:59.172426 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 12 09:52:59.183395 (dockerd)[2544]: 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 Jul 12 09:52:59.208040 dockerd[2544]: time="2025-07-12T09:52:59.207993516Z" level=info msg="Starting up" Jul 12 09:52:59.208607 dockerd[2544]: time="2025-07-12T09:52:59.208583630Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 12 09:52:59.217408 dockerd[2544]: time="2025-07-12T09:52:59.217370667Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jul 12 09:52:59.234843 dockerd[2544]: time="2025-07-12T09:52:59.234795183Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 12 09:52:59.242369 dockerd[2544]: time="2025-07-12T09:52:59.242264832Z" level=info msg="Loading containers: start." Jul 12 09:52:59.255552 systemd[1]: var-lib-docker-overlay2-2d77b86ef3fd3c7d409db1bfe74e934709b8e6cd06ff7de8bfd82a3660c5a6c4-merged.mount: Deactivated successfully. Jul 12 09:52:59.661734 systemd-networkd[1406]: veth7e9cf23: Link DOWN Jul 12 09:52:59.661741 systemd-networkd[1406]: veth7e9cf23: Lost carrier Jul 12 09:52:59.662987 kernel: docker0: port 1(veth7e9cf23) entered disabled state Jul 12 09:52:59.664226 kernel: veth7e9cf23 (unregistering): left allmulticast mode Jul 12 09:52:59.664262 kernel: veth7e9cf23 (unregistering): left promiscuous mode Jul 12 09:52:59.664276 kernel: docker0: port 1(veth7e9cf23) entered disabled state Jul 12 09:52:59.665704 systemd-networkd[1406]: docker0: Lost carrier Jul 12 09:52:59.666300 dockerd[2544]: time="2025-07-12T09:52:59.666248629Z" level=info msg="Removing stale sandbox 0b8f2748472383d368b9aae6a90771d40834265db41caa7d5a8136008c96305d (ac2ede50ed8de9cbbc162f5b70e3d4b8d539335f586027db93af798e33248cc2)" Jul 12 09:52:59.668944 dockerd[2544]: time="2025-07-12T09:52:59.668905564Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 12 09:52:59.669016 dockerd[2544]: time="2025-07-12T09:52:59.668954044Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 87734eb19f5dbf9ed80e26645c9fe125c97faf48de0e87ebf792149de10c9d19 f16e9b67c79c0e54a6a97b69035f9f620f7f6f6ae12bf473fa60d105201f8623], retrying...." Jul 12 09:52:59.818540 dockerd[2544]: time="2025-07-12T09:52:59.818489952Z" level=warning msg="error locating sandbox id 4a3344b00f78245e2d193db332ae985a98b64991ac1496a9fdddf9a12420200c: sandbox 4a3344b00f78245e2d193db332ae985a98b64991ac1496a9fdddf9a12420200c not found" Jul 12 09:52:59.818540 dockerd[2544]: time="2025-07-12T09:52:59.818533032Z" level=warning msg="error locating sandbox id 0b8f2748472383d368b9aae6a90771d40834265db41caa7d5a8136008c96305d: sandbox 0b8f2748472383d368b9aae6a90771d40834265db41caa7d5a8136008c96305d not found" Jul 12 09:52:59.818661 dockerd[2544]: time="2025-07-12T09:52:59.818582911Z" level=info msg="Loading containers: done." Jul 12 09:52:59.828515 dockerd[2544]: time="2025-07-12T09:52:59.828464138Z" 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 Jul 12 09:52:59.828650 dockerd[2544]: time="2025-07-12T09:52:59.828538657Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jul 12 09:52:59.828650 dockerd[2544]: time="2025-07-12T09:52:59.828570577Z" level=info msg="Initializing buildkit" Jul 12 09:52:59.839953 dockerd[2544]: time="2025-07-12T09:52:59.839906590Z" level=info msg="Completed buildkit initialization" Jul 12 09:52:59.845856 dockerd[2544]: time="2025-07-12T09:52:59.845817334Z" level=info msg="Daemon has completed initialization" Jul 12 09:52:59.846339 dockerd[2544]: time="2025-07-12T09:52:59.845909373Z" level=info msg="API listen on /run/docker.sock" Jul 12 09:52:59.846003 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 12 09:53:00.224099 systemd[1]: run-docker-netns-0b8f27484723.mount: Deactivated successfully. Jul 12 09:53:03.623821 systemd[1]: Started sshd@24-10.0.0.140:22-10.0.0.1:37044.service - OpenSSH per-connection server daemon (10.0.0.1:37044). Jul 12 09:53:03.676592 sshd[2781]: Accepted publickey for core from 10.0.0.1 port 37044 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:53:03.677621 sshd-session[2781]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:53:03.681000 systemd-logind[1469]: New session 25 of user core. Jul 12 09:53:03.695068 systemd[1]: Started session-25.scope - Session 25 of User core. Jul 12 09:53:03.746017 sshd[2784]: Connection closed by 10.0.0.1 port 37044 Jul 12 09:53:03.746405 sshd-session[2781]: pam_unix(sshd:session): session closed for user core Jul 12 09:53:03.759671 systemd[1]: sshd@24-10.0.0.140:22-10.0.0.1:37044.service: Deactivated successfully. Jul 12 09:53:03.762201 systemd[1]: session-25.scope: Deactivated successfully. Jul 12 09:53:03.763010 systemd-logind[1469]: Session 25 logged out. Waiting for processes to exit. Jul 12 09:53:03.764880 systemd[1]: Started sshd@25-10.0.0.140:22-10.0.0.1:37054.service - OpenSSH per-connection server daemon (10.0.0.1:37054). Jul 12 09:53:03.765605 systemd-logind[1469]: Removed session 25. Jul 12 09:53:03.821239 sshd[2790]: Accepted publickey for core from 10.0.0.1 port 37054 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:53:03.822295 sshd-session[2790]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:53:03.826058 systemd-logind[1469]: New session 26 of user core. Jul 12 09:53:03.833063 systemd[1]: Started session-26.scope - Session 26 of User core. Jul 12 09:53:03.885717 sshd[2793]: Connection closed by 10.0.0.1 port 37054 Jul 12 09:53:03.886160 sshd-session[2790]: pam_unix(sshd:session): session closed for user core Jul 12 09:53:03.901869 systemd[1]: sshd@25-10.0.0.140:22-10.0.0.1:37054.service: Deactivated successfully. Jul 12 09:53:03.904293 systemd[1]: session-26.scope: Deactivated successfully. Jul 12 09:53:03.904990 systemd-logind[1469]: Session 26 logged out. Waiting for processes to exit. Jul 12 09:53:03.907017 systemd[1]: Started sshd@26-10.0.0.140:22-10.0.0.1:37064.service - OpenSSH per-connection server daemon (10.0.0.1:37064). Jul 12 09:53:03.907802 systemd-logind[1469]: Removed session 26. Jul 12 09:53:03.963278 sshd[2799]: Accepted publickey for core from 10.0.0.1 port 37064 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:53:03.964297 sshd-session[2799]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:53:03.967994 systemd-logind[1469]: New session 27 of user core. Jul 12 09:53:03.983061 systemd[1]: Started session-27.scope - Session 27 of User core. Jul 12 09:53:04.037752 sshd[2802]: Connection closed by 10.0.0.1 port 37064 Jul 12 09:53:04.038186 sshd-session[2799]: pam_unix(sshd:session): session closed for user core Jul 12 09:53:04.050701 systemd[1]: sshd@26-10.0.0.140:22-10.0.0.1:37064.service: Deactivated successfully. Jul 12 09:53:04.052270 systemd[1]: session-27.scope: Deactivated successfully. Jul 12 09:53:04.054444 systemd-logind[1469]: Session 27 logged out. Waiting for processes to exit. Jul 12 09:53:04.056414 systemd[1]: Started sshd@27-10.0.0.140:22-10.0.0.1:37066.service - OpenSSH per-connection server daemon (10.0.0.1:37066). Jul 12 09:53:04.056844 systemd-logind[1469]: Removed session 27. Jul 12 09:53:04.104230 sshd[2815]: Accepted publickey for core from 10.0.0.1 port 37066 ssh2: RSA SHA256:fhp558siaf39QLJw5fsAHbaRafIwNXdVZ+VoGPeGhpE Jul 12 09:53:04.105254 sshd-session[2815]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 12 09:53:04.108483 systemd-logind[1469]: New session 28 of user core. Jul 12 09:53:04.116110 systemd[1]: Started session-28.scope - Session 28 of User core. Jul 12 09:53:04.180352 systemd[1]: var-lib-docker-overlay2-40e6afa99c6f5dd4a7262f41477080a70815c270dcfcaae1fa1b4b60be0aa6fa\x2dinit-merged.mount: Deactivated successfully. Jul 12 09:53:04.211540 containerd[2496]: time="2025-07-12T09:53:04.211496266Z" level=info msg="connecting to shim c50d7c5c3675cfddf5e412cf42428fd89f987c7f06ec5593fedf68a386e4c06f" address="unix:///run/containerd/s/2be56f29522b76a3694183092ae4f9d19796e407e673afd0d6ae04cfe2419800" namespace=moby protocol=ttrpc version=3 Jul 12 09:53:04.239089 systemd[1]: Started docker-c50d7c5c3675cfddf5e412cf42428fd89f987c7f06ec5593fedf68a386e4c06f.scope - libcontainer container c50d7c5c3675cfddf5e412cf42428fd89f987c7f06ec5593fedf68a386e4c06f. Jul 12 09:53:04.248087 systemd-resolved[1302]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 12 09:53:04.262230 kernel: docker0: port 1(veth1eb1bb8) entered blocking state Jul 12 09:53:04.262303 kernel: docker0: port 1(veth1eb1bb8) entered disabled state Jul 12 09:53:04.262319 kernel: veth1eb1bb8: entered allmulticast mode Jul 12 09:53:04.263139 kernel: veth1eb1bb8: entered promiscuous mode Jul 12 09:53:04.264002 systemd-networkd[1406]: veth1eb1bb8: Link UP Jul 12 09:53:04.267958 kernel: eth0: renamed from vethe8b3a32 Jul 12 09:53:04.269803 kernel: docker0: port 1(veth1eb1bb8) entered blocking state Jul 12 09:53:04.269851 kernel: docker0: port 1(veth1eb1bb8) entered forwarding state Jul 12 09:53:04.270086 systemd-networkd[1406]: veth1eb1bb8: Gained carrier Jul 12 09:53:04.270354 systemd-networkd[1406]: docker0: Gained carrier Jul 12 09:53:04.285626 sshd[2818]: Connection closed by 10.0.0.1 port 37066 Jul 12 09:53:04.285984 sshd-session[2815]: pam_unix(sshd:session): session closed for user core Jul 12 09:53:04.289598 systemd[1]: sshd@27-10.0.0.140:22-10.0.0.1:37066.service: Deactivated successfully. Jul 12 09:53:04.291119 systemd[1]: session-28.scope: Deactivated successfully. Jul 12 09:53:04.292620 systemd-logind[1469]: Session 28 logged out. Waiting for processes to exit. Jul 12 09:53:04.293577 systemd-logind[1469]: Removed session 28.