Jul 6 23:41:36.817682 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Jul 6 23:41:36.817704 kernel: Linux version 6.12.35-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241221 p7) 14.2.1 20241221, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Sun Jul 6 21:52:18 -00 2025 Jul 6 23:41:36.817714 kernel: KASLR enabled Jul 6 23:41:36.817720 kernel: efi: EFI v2.7 by EDK II Jul 6 23:41:36.817725 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb228018 ACPI 2.0=0xdb9b8018 RNG=0xdb9b8a18 MEMRESERVE=0xdb21fd18 Jul 6 23:41:36.817730 kernel: random: crng init done Jul 6 23:41:36.817737 kernel: Kernel is locked down from EFI Secure Boot; see man kernel_lockdown.7 Jul 6 23:41:36.817743 kernel: secureboot: Secure boot enabled Jul 6 23:41:36.817749 kernel: ACPI: Early table checksum verification disabled Jul 6 23:41:36.817756 kernel: ACPI: RSDP 0x00000000DB9B8018 000024 (v02 BOCHS ) Jul 6 23:41:36.817762 kernel: ACPI: XSDT 0x00000000DB9B8F18 000064 (v01 BOCHS BXPC 00000001 01000013) Jul 6 23:41:36.817789 kernel: ACPI: FACP 0x00000000DB9B8B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817795 kernel: ACPI: DSDT 0x00000000DB904018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817801 kernel: ACPI: APIC 0x00000000DB9B8C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817808 kernel: ACPI: PPTT 0x00000000DB9B8098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817815 kernel: ACPI: GTDT 0x00000000DB9B8818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817821 kernel: ACPI: MCFG 0x00000000DB9B8A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817827 kernel: ACPI: SPCR 0x00000000DB9B8918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817833 kernel: ACPI: DBG2 0x00000000DB9B8998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817839 kernel: ACPI: IORT 0x00000000DB9B8198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jul 6 23:41:36.817845 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Jul 6 23:41:36.817851 kernel: ACPI: Use ACPI SPCR as default console: Yes Jul 6 23:41:36.817857 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Jul 6 23:41:36.817863 kernel: NODE_DATA(0) allocated [mem 0xdc737dc0-0xdc73efff] Jul 6 23:41:36.817869 kernel: Zone ranges: Jul 6 23:41:36.817876 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Jul 6 23:41:36.817882 kernel: DMA32 empty Jul 6 23:41:36.817888 kernel: Normal empty Jul 6 23:41:36.817894 kernel: Device empty Jul 6 23:41:36.817900 kernel: Movable zone start for each node Jul 6 23:41:36.817906 kernel: Early memory node ranges Jul 6 23:41:36.817912 kernel: node 0: [mem 0x0000000040000000-0x00000000dbb4ffff] Jul 6 23:41:36.817918 kernel: node 0: [mem 0x00000000dbb50000-0x00000000dbe7ffff] Jul 6 23:41:36.817924 kernel: node 0: [mem 0x00000000dbe80000-0x00000000dbe9ffff] Jul 6 23:41:36.817930 kernel: node 0: [mem 0x00000000dbea0000-0x00000000dbedffff] Jul 6 23:41:36.817944 kernel: node 0: [mem 0x00000000dbee0000-0x00000000dbf1ffff] Jul 6 23:41:36.817955 kernel: node 0: [mem 0x00000000dbf20000-0x00000000dbf6ffff] Jul 6 23:41:36.817962 kernel: node 0: [mem 0x00000000dbf70000-0x00000000dcbfffff] Jul 6 23:41:36.817968 kernel: node 0: [mem 0x00000000dcc00000-0x00000000dcfdffff] Jul 6 23:41:36.817974 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Jul 6 23:41:36.817982 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Jul 6 23:41:36.817989 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Jul 6 23:41:36.817995 kernel: psci: probing for conduit method from ACPI. Jul 6 23:41:36.818002 kernel: psci: PSCIv1.1 detected in firmware. Jul 6 23:41:36.818009 kernel: psci: Using standard PSCI v0.2 function IDs Jul 6 23:41:36.818016 kernel: psci: Trusted OS migration not required Jul 6 23:41:36.818022 kernel: psci: SMC Calling Convention v1.1 Jul 6 23:41:36.818029 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Jul 6 23:41:36.818035 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jul 6 23:41:36.818041 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jul 6 23:41:36.818048 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Jul 6 23:41:36.818055 kernel: Detected PIPT I-cache on CPU0 Jul 6 23:41:36.818061 kernel: CPU features: detected: GIC system register CPU interface Jul 6 23:41:36.818069 kernel: CPU features: detected: Spectre-v4 Jul 6 23:41:36.818075 kernel: CPU features: detected: Spectre-BHB Jul 6 23:41:36.818082 kernel: CPU features: kernel page table isolation forced ON by KASLR Jul 6 23:41:36.818089 kernel: CPU features: detected: Kernel page table isolation (KPTI) Jul 6 23:41:36.818095 kernel: CPU features: detected: ARM erratum 1418040 Jul 6 23:41:36.818102 kernel: CPU features: detected: SSBS not fully self-synchronizing Jul 6 23:41:36.818108 kernel: alternatives: applying boot alternatives Jul 6 23:41:36.818116 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=dd2d39de40482a23e9bb75390ff5ca85cd9bd34d902b8049121a8373f8cb2ef2 Jul 6 23:41:36.818123 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 6 23:41:36.818129 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 6 23:41:36.818135 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 6 23:41:36.818143 kernel: Fallback order for Node 0: 0 Jul 6 23:41:36.818149 kernel: Built 1 zonelists, mobility grouping on. Total pages: 643072 Jul 6 23:41:36.818156 kernel: Policy zone: DMA Jul 6 23:41:36.818162 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 6 23:41:36.818169 kernel: software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB Jul 6 23:41:36.818175 kernel: software IO TLB: area num 4. Jul 6 23:41:36.818181 kernel: software IO TLB: SWIOTLB bounce buffer size roundup to 4MB Jul 6 23:41:36.818188 kernel: software IO TLB: mapped [mem 0x00000000db504000-0x00000000db904000] (4MB) Jul 6 23:41:36.818195 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Jul 6 23:41:36.818201 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 6 23:41:36.818209 kernel: rcu: RCU event tracing is enabled. Jul 6 23:41:36.818215 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Jul 6 23:41:36.818224 kernel: Trampoline variant of Tasks RCU enabled. Jul 6 23:41:36.818231 kernel: Tracing variant of Tasks RCU enabled. Jul 6 23:41:36.818238 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 6 23:41:36.818244 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Jul 6 23:41:36.818251 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 6 23:41:36.818257 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Jul 6 23:41:36.818264 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 6 23:41:36.818270 kernel: GICv3: 256 SPIs implemented Jul 6 23:41:36.818276 kernel: GICv3: 0 Extended SPIs implemented Jul 6 23:41:36.818282 kernel: Root IRQ handler: gic_handle_irq Jul 6 23:41:36.818289 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Jul 6 23:41:36.818296 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Jul 6 23:41:36.818303 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Jul 6 23:41:36.818309 kernel: ITS [mem 0x08080000-0x0809ffff] Jul 6 23:41:36.818316 kernel: ITS@0x0000000008080000: allocated 8192 Devices @40110000 (indirect, esz 8, psz 64K, shr 1) Jul 6 23:41:36.818323 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40120000 (flat, esz 8, psz 64K, shr 1) Jul 6 23:41:36.818329 kernel: GICv3: using LPI property table @0x0000000040130000 Jul 6 23:41:36.818336 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040140000 Jul 6 23:41:36.818342 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 6 23:41:36.818366 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 6 23:41:36.818373 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Jul 6 23:41:36.818379 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Jul 6 23:41:36.818386 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Jul 6 23:41:36.818394 kernel: arm-pv: using stolen time PV Jul 6 23:41:36.818401 kernel: Console: colour dummy device 80x25 Jul 6 23:41:36.818408 kernel: ACPI: Core revision 20240827 Jul 6 23:41:36.818415 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Jul 6 23:41:36.818421 kernel: pid_max: default: 32768 minimum: 301 Jul 6 23:41:36.818428 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 6 23:41:36.818435 kernel: landlock: Up and running. Jul 6 23:41:36.818441 kernel: SELinux: Initializing. Jul 6 23:41:36.818455 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 6 23:41:36.818465 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 6 23:41:36.818472 kernel: rcu: Hierarchical SRCU implementation. Jul 6 23:41:36.818478 kernel: rcu: Max phase no-delay instances is 400. Jul 6 23:41:36.818485 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 6 23:41:36.818492 kernel: Remapping and enabling EFI services. Jul 6 23:41:36.818498 kernel: smp: Bringing up secondary CPUs ... Jul 6 23:41:36.818505 kernel: Detected PIPT I-cache on CPU1 Jul 6 23:41:36.818511 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Jul 6 23:41:36.818518 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040150000 Jul 6 23:41:36.818526 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 6 23:41:36.818537 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Jul 6 23:41:36.818544 kernel: Detected PIPT I-cache on CPU2 Jul 6 23:41:36.818553 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Jul 6 23:41:36.818560 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040160000 Jul 6 23:41:36.818567 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 6 23:41:36.818574 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Jul 6 23:41:36.818581 kernel: Detected PIPT I-cache on CPU3 Jul 6 23:41:36.818588 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Jul 6 23:41:36.818596 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040170000 Jul 6 23:41:36.818603 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Jul 6 23:41:36.818610 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Jul 6 23:41:36.818617 kernel: smp: Brought up 1 node, 4 CPUs Jul 6 23:41:36.818624 kernel: SMP: Total of 4 processors activated. Jul 6 23:41:36.818631 kernel: CPU: All CPU(s) started at EL1 Jul 6 23:41:36.818638 kernel: CPU features: detected: 32-bit EL0 Support Jul 6 23:41:36.818645 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Jul 6 23:41:36.818652 kernel: CPU features: detected: Common not Private translations Jul 6 23:41:36.818661 kernel: CPU features: detected: CRC32 instructions Jul 6 23:41:36.818668 kernel: CPU features: detected: Enhanced Virtualization Traps Jul 6 23:41:36.818675 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Jul 6 23:41:36.818682 kernel: CPU features: detected: LSE atomic instructions Jul 6 23:41:36.818689 kernel: CPU features: detected: Privileged Access Never Jul 6 23:41:36.818696 kernel: CPU features: detected: RAS Extension Support Jul 6 23:41:36.818703 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Jul 6 23:41:36.818710 kernel: alternatives: applying system-wide alternatives Jul 6 23:41:36.818717 kernel: CPU features: detected: Hardware dirty bit management on CPU0-3 Jul 6 23:41:36.818726 kernel: Memory: 2438448K/2572288K available (11072K kernel code, 2428K rwdata, 9032K rodata, 39424K init, 1035K bss, 127892K reserved, 0K cma-reserved) Jul 6 23:41:36.818733 kernel: devtmpfs: initialized Jul 6 23:41:36.818740 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 6 23:41:36.818747 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Jul 6 23:41:36.818754 kernel: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Jul 6 23:41:36.818761 kernel: 0 pages in range for non-PLT usage Jul 6 23:41:36.818768 kernel: 508480 pages in range for PLT usage Jul 6 23:41:36.818775 kernel: pinctrl core: initialized pinctrl subsystem Jul 6 23:41:36.818781 kernel: SMBIOS 3.0.0 present. Jul 6 23:41:36.818789 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Jul 6 23:41:36.818796 kernel: DMI: Memory slots populated: 1/1 Jul 6 23:41:36.818803 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 6 23:41:36.818810 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 6 23:41:36.818817 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 6 23:41:36.818825 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 6 23:41:36.818831 kernel: audit: initializing netlink subsys (disabled) Jul 6 23:41:36.818839 kernel: audit: type=2000 audit(0.023:1): state=initialized audit_enabled=0 res=1 Jul 6 23:41:36.818846 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 6 23:41:36.818854 kernel: cpuidle: using governor menu Jul 6 23:41:36.818861 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 6 23:41:36.818868 kernel: ASID allocator initialised with 32768 entries Jul 6 23:41:36.818875 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 6 23:41:36.818882 kernel: Serial: AMBA PL011 UART driver Jul 6 23:41:36.818889 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 6 23:41:36.818896 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 6 23:41:36.818902 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 6 23:41:36.818911 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 6 23:41:36.818918 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 6 23:41:36.818925 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 6 23:41:36.818932 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 6 23:41:36.818939 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 6 23:41:36.818945 kernel: ACPI: Added _OSI(Module Device) Jul 6 23:41:36.818952 kernel: ACPI: Added _OSI(Processor Device) Jul 6 23:41:36.818959 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 6 23:41:36.818966 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 6 23:41:36.818973 kernel: ACPI: Interpreter enabled Jul 6 23:41:36.818981 kernel: ACPI: Using GIC for interrupt routing Jul 6 23:41:36.818988 kernel: ACPI: MCFG table detected, 1 entries Jul 6 23:41:36.818995 kernel: ACPI: CPU0 has been hot-added Jul 6 23:41:36.819002 kernel: ACPI: CPU1 has been hot-added Jul 6 23:41:36.819009 kernel: ACPI: CPU2 has been hot-added Jul 6 23:41:36.819016 kernel: ACPI: CPU3 has been hot-added Jul 6 23:41:36.819023 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Jul 6 23:41:36.819030 kernel: printk: legacy console [ttyAMA0] enabled Jul 6 23:41:36.819037 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jul 6 23:41:36.819172 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 6 23:41:36.819237 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 6 23:41:36.819296 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 6 23:41:36.819367 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Jul 6 23:41:36.819970 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Jul 6 23:41:36.819982 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Jul 6 23:41:36.819989 kernel: PCI host bridge to bus 0000:00 Jul 6 23:41:36.820070 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Jul 6 23:41:36.820129 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 6 23:41:36.820181 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Jul 6 23:41:36.820233 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jul 6 23:41:36.820307 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint Jul 6 23:41:36.820409 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint Jul 6 23:41:36.820491 kernel: pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] Jul 6 23:41:36.820554 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff] Jul 6 23:41:36.820614 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref] Jul 6 23:41:36.820673 kernel: pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned Jul 6 23:41:36.820732 kernel: pci 0000:00:01.0: BAR 1 [mem 0x10000000-0x10000fff]: assigned Jul 6 23:41:36.820791 kernel: pci 0000:00:01.0: BAR 0 [io 0x1000-0x101f]: assigned Jul 6 23:41:36.820845 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Jul 6 23:41:36.820900 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 6 23:41:36.820952 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Jul 6 23:41:36.820961 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 6 23:41:36.820969 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 6 23:41:36.820976 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 6 23:41:36.820983 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 6 23:41:36.820990 kernel: iommu: Default domain type: Translated Jul 6 23:41:36.820997 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 6 23:41:36.821006 kernel: efivars: Registered efivars operations Jul 6 23:41:36.821013 kernel: vgaarb: loaded Jul 6 23:41:36.821020 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 6 23:41:36.821027 kernel: VFS: Disk quotas dquot_6.6.0 Jul 6 23:41:36.821034 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 6 23:41:36.821041 kernel: pnp: PnP ACPI init Jul 6 23:41:36.821108 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Jul 6 23:41:36.821118 kernel: pnp: PnP ACPI: found 1 devices Jul 6 23:41:36.821125 kernel: NET: Registered PF_INET protocol family Jul 6 23:41:36.821134 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 6 23:41:36.821141 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 6 23:41:36.821148 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 6 23:41:36.821155 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 6 23:41:36.821163 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 6 23:41:36.821170 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 6 23:41:36.821177 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 6 23:41:36.821184 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 6 23:41:36.821191 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 6 23:41:36.821200 kernel: PCI: CLS 0 bytes, default 64 Jul 6 23:41:36.821207 kernel: kvm [1]: HYP mode not available Jul 6 23:41:36.821214 kernel: Initialise system trusted keyrings Jul 6 23:41:36.821221 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 6 23:41:36.821228 kernel: Key type asymmetric registered Jul 6 23:41:36.821235 kernel: Asymmetric key parser 'x509' registered Jul 6 23:41:36.821242 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 6 23:41:36.821249 kernel: io scheduler mq-deadline registered Jul 6 23:41:36.821257 kernel: io scheduler kyber registered Jul 6 23:41:36.821265 kernel: io scheduler bfq registered Jul 6 23:41:36.821272 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 6 23:41:36.821279 kernel: ACPI: button: Power Button [PWRB] Jul 6 23:41:36.821287 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 6 23:41:36.821373 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Jul 6 23:41:36.821384 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 6 23:41:36.821392 kernel: thunder_xcv, ver 1.0 Jul 6 23:41:36.821398 kernel: thunder_bgx, ver 1.0 Jul 6 23:41:36.821405 kernel: nicpf, ver 1.0 Jul 6 23:41:36.821415 kernel: nicvf, ver 1.0 Jul 6 23:41:36.821493 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 6 23:41:36.821553 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-06T23:41:36 UTC (1751845296) Jul 6 23:41:36.821562 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 6 23:41:36.821570 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 (0,8000003f) counters available Jul 6 23:41:36.821577 kernel: watchdog: NMI not fully supported Jul 6 23:41:36.821584 kernel: watchdog: Hard watchdog permanently disabled Jul 6 23:41:36.821591 kernel: NET: Registered PF_INET6 protocol family Jul 6 23:41:36.821600 kernel: Segment Routing with IPv6 Jul 6 23:41:36.821607 kernel: In-situ OAM (IOAM) with IPv6 Jul 6 23:41:36.821615 kernel: NET: Registered PF_PACKET protocol family Jul 6 23:41:36.821622 kernel: Key type dns_resolver registered Jul 6 23:41:36.821628 kernel: registered taskstats version 1 Jul 6 23:41:36.821636 kernel: Loading compiled-in X.509 certificates Jul 6 23:41:36.821643 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.35-flatcar: 90fb300ebe1fa0773739bb35dad461c5679d8dfb' Jul 6 23:41:36.821650 kernel: Demotion targets for Node 0: null Jul 6 23:41:36.821657 kernel: Key type .fscrypt registered Jul 6 23:41:36.821665 kernel: Key type fscrypt-provisioning registered Jul 6 23:41:36.821672 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 6 23:41:36.821679 kernel: ima: Allocated hash algorithm: sha1 Jul 6 23:41:36.821686 kernel: ima: No architecture policies found Jul 6 23:41:36.821693 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 6 23:41:36.821700 kernel: clk: Disabling unused clocks Jul 6 23:41:36.821707 kernel: PM: genpd: Disabling unused power domains Jul 6 23:41:36.821714 kernel: Warning: unable to open an initial console. Jul 6 23:41:36.821721 kernel: Freeing unused kernel memory: 39424K Jul 6 23:41:36.821730 kernel: Run /init as init process Jul 6 23:41:36.821737 kernel: with arguments: Jul 6 23:41:36.821744 kernel: /init Jul 6 23:41:36.821751 kernel: with environment: Jul 6 23:41:36.821758 kernel: HOME=/ Jul 6 23:41:36.821765 kernel: TERM=linux Jul 6 23:41:36.821771 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 6 23:41:36.821779 systemd[1]: Successfully made /usr/ read-only. Jul 6 23:41:36.821791 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 6 23:41:36.821799 systemd[1]: Detected virtualization kvm. Jul 6 23:41:36.821806 systemd[1]: Detected architecture arm64. Jul 6 23:41:36.821814 systemd[1]: Running in initrd. Jul 6 23:41:36.821821 systemd[1]: No hostname configured, using default hostname. Jul 6 23:41:36.821829 systemd[1]: Hostname set to . Jul 6 23:41:36.821836 systemd[1]: Initializing machine ID from VM UUID. Jul 6 23:41:36.821843 systemd[1]: Queued start job for default target initrd.target. Jul 6 23:41:36.821852 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 6 23:41:36.821860 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 6 23:41:36.821868 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 6 23:41:36.821875 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 6 23:41:36.821883 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 6 23:41:36.821891 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 6 23:41:36.821901 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 6 23:41:36.821909 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 6 23:41:36.821917 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 6 23:41:36.821924 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 6 23:41:36.821932 systemd[1]: Reached target paths.target - Path Units. Jul 6 23:41:36.821939 systemd[1]: Reached target slices.target - Slice Units. Jul 6 23:41:36.821946 systemd[1]: Reached target swap.target - Swaps. Jul 6 23:41:36.821954 systemd[1]: Reached target timers.target - Timer Units. Jul 6 23:41:36.821961 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 6 23:41:36.821971 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 6 23:41:36.821978 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 6 23:41:36.821986 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 6 23:41:36.821994 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 6 23:41:36.822001 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 6 23:41:36.822009 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 6 23:41:36.822016 systemd[1]: Reached target sockets.target - Socket Units. Jul 6 23:41:36.822024 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 6 23:41:36.822033 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 6 23:41:36.822041 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 6 23:41:36.822049 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 6 23:41:36.822056 systemd[1]: Starting systemd-fsck-usr.service... Jul 6 23:41:36.822064 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 6 23:41:36.822072 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 6 23:41:36.822079 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 6 23:41:36.822087 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 6 23:41:36.822096 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 6 23:41:36.822104 systemd[1]: Finished systemd-fsck-usr.service. Jul 6 23:41:36.822127 systemd-journald[245]: Collecting audit messages is disabled. Jul 6 23:41:36.822148 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 6 23:41:36.822156 systemd-journald[245]: Journal started Jul 6 23:41:36.822174 systemd-journald[245]: Runtime Journal (/run/log/journal/673168c19af84c9caa00c7a931186257) is 6M, max 48.5M, 42.4M free. Jul 6 23:41:36.812328 systemd-modules-load[246]: Inserted module 'overlay' Jul 6 23:41:36.826364 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 6 23:41:36.826404 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 6 23:41:36.828372 systemd[1]: Started systemd-journald.service - Journal Service. Jul 6 23:41:36.830944 systemd-modules-load[246]: Inserted module 'br_netfilter' Jul 6 23:41:36.831974 kernel: Bridge firewalling registered Jul 6 23:41:36.832337 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 6 23:41:36.834178 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 6 23:41:36.837126 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 6 23:41:36.844549 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 6 23:41:36.847437 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 6 23:41:36.849004 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 6 23:41:36.850339 systemd-tmpfiles[266]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 6 23:41:36.854281 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 6 23:41:36.862107 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 6 23:41:36.863574 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 6 23:41:36.865722 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 6 23:41:36.868646 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 6 23:41:36.870923 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 6 23:41:36.892734 dracut-cmdline[287]: 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=dd2d39de40482a23e9bb75390ff5ca85cd9bd34d902b8049121a8373f8cb2ef2 Jul 6 23:41:36.909165 systemd-resolved[288]: Positive Trust Anchors: Jul 6 23:41:36.909181 systemd-resolved[288]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 6 23:41:36.909213 systemd-resolved[288]: 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 6 23:41:36.914072 systemd-resolved[288]: Defaulting to hostname 'linux'. Jul 6 23:41:36.915048 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 6 23:41:36.919100 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 6 23:41:36.973384 kernel: SCSI subsystem initialized Jul 6 23:41:36.978372 kernel: Loading iSCSI transport class v2.0-870. Jul 6 23:41:36.986391 kernel: iscsi: registered transport (tcp) Jul 6 23:41:36.998735 kernel: iscsi: registered transport (qla4xxx) Jul 6 23:41:36.998764 kernel: QLogic iSCSI HBA Driver Jul 6 23:41:37.014907 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 6 23:41:37.031541 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 6 23:41:37.033667 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 6 23:41:37.078983 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 6 23:41:37.081323 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 6 23:41:37.145387 kernel: raid6: neonx8 gen() 15769 MB/s Jul 6 23:41:37.162374 kernel: raid6: neonx4 gen() 15757 MB/s Jul 6 23:41:37.179369 kernel: raid6: neonx2 gen() 13223 MB/s Jul 6 23:41:37.196369 kernel: raid6: neonx1 gen() 10420 MB/s Jul 6 23:41:37.213367 kernel: raid6: int64x8 gen() 6889 MB/s Jul 6 23:41:37.230369 kernel: raid6: int64x4 gen() 7337 MB/s Jul 6 23:41:37.247368 kernel: raid6: int64x2 gen() 6096 MB/s Jul 6 23:41:37.264644 kernel: raid6: int64x1 gen() 5043 MB/s Jul 6 23:41:37.264666 kernel: raid6: using algorithm neonx8 gen() 15769 MB/s Jul 6 23:41:37.282512 kernel: raid6: .... xor() 12054 MB/s, rmw enabled Jul 6 23:41:37.282526 kernel: raid6: using neon recovery algorithm Jul 6 23:41:37.287366 kernel: xor: measuring software checksum speed Jul 6 23:41:37.288638 kernel: 8regs : 18158 MB/sec Jul 6 23:41:37.288653 kernel: 32regs : 21664 MB/sec Jul 6 23:41:37.289903 kernel: arm64_neon : 28041 MB/sec Jul 6 23:41:37.289916 kernel: xor: using function: arm64_neon (28041 MB/sec) Jul 6 23:41:37.343372 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 6 23:41:37.349722 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 6 23:41:37.352184 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 6 23:41:37.378972 systemd-udevd[497]: Using default interface naming scheme 'v255'. Jul 6 23:41:37.383098 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 6 23:41:37.385511 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 6 23:41:37.411735 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Jul 6 23:41:37.434165 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 6 23:41:37.436457 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 6 23:41:37.503932 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 6 23:41:37.506222 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 6 23:41:37.560399 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Jul 6 23:41:37.560624 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Jul 6 23:41:37.563365 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 6 23:41:37.564771 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 6 23:41:37.564887 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 6 23:41:37.571425 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 6 23:41:37.573330 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 6 23:41:37.595405 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 6 23:41:37.603326 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jul 6 23:41:37.610882 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jul 6 23:41:37.612359 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 6 23:41:37.626688 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 6 23:41:37.632888 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jul 6 23:41:37.634101 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jul 6 23:41:37.636385 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 6 23:41:37.639418 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 6 23:41:37.641441 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 6 23:41:37.644101 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 6 23:41:37.646063 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 6 23:41:37.667312 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 6 23:41:37.671367 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 6 23:41:38.680330 disk-uuid[592]: The operation has completed successfully. Jul 6 23:41:38.681493 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jul 6 23:41:38.699391 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 6 23:41:38.699494 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 6 23:41:38.730480 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 6 23:41:38.745163 sh[608]: Success Jul 6 23:41:38.758553 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 6 23:41:38.758583 kernel: device-mapper: uevent: version 1.0.3 Jul 6 23:41:38.762378 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 6 23:41:38.772376 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jul 6 23:41:38.797144 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 6 23:41:38.799956 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 6 23:41:38.811265 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 6 23:41:38.818031 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 6 23:41:38.818062 kernel: BTRFS: device fsid aa7ffdf7-f152-4ceb-bd0e-b3b3f8f8b296 devid 1 transid 38 /dev/mapper/usr (253:0) scanned by mount (620) Jul 6 23:41:38.818609 kernel: BTRFS info (device dm-0): first mount of filesystem aa7ffdf7-f152-4ceb-bd0e-b3b3f8f8b296 Jul 6 23:41:38.820487 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 6 23:41:38.820506 kernel: BTRFS info (device dm-0): using free-space-tree Jul 6 23:41:38.826619 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 6 23:41:38.827871 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 6 23:41:38.829234 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 6 23:41:38.829986 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 6 23:41:38.831524 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 6 23:41:38.853079 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (651) Jul 6 23:41:38.853125 kernel: BTRFS info (device vda6): first mount of filesystem 492b2e2a-5dd7-445f-b930-e9dd6acadf93 Jul 6 23:41:38.854322 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 6 23:41:38.854381 kernel: BTRFS info (device vda6): using free-space-tree Jul 6 23:41:38.861392 kernel: BTRFS info (device vda6): last unmount of filesystem 492b2e2a-5dd7-445f-b930-e9dd6acadf93 Jul 6 23:41:38.862319 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 6 23:41:38.864308 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 6 23:41:38.929726 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 6 23:41:38.932900 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 6 23:41:38.979300 systemd-networkd[797]: lo: Link UP Jul 6 23:41:38.979312 systemd-networkd[797]: lo: Gained carrier Jul 6 23:41:38.980063 systemd-networkd[797]: Enumeration completed Jul 6 23:41:38.980164 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 6 23:41:38.980907 systemd-networkd[797]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 6 23:41:38.980910 systemd-networkd[797]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 6 23:41:38.981828 systemd-networkd[797]: eth0: Link UP Jul 6 23:41:38.981832 systemd-networkd[797]: eth0: Gained carrier Jul 6 23:41:38.981841 systemd-networkd[797]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 6 23:41:38.981917 systemd[1]: Reached target network.target - Network. Jul 6 23:41:39.004412 systemd-networkd[797]: eth0: DHCPv4 address 10.0.0.129/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 6 23:41:39.004809 ignition[700]: Ignition 2.21.0 Jul 6 23:41:39.004816 ignition[700]: Stage: fetch-offline Jul 6 23:41:39.004848 ignition[700]: no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:39.004855 ignition[700]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:39.005031 ignition[700]: parsed url from cmdline: "" Jul 6 23:41:39.005034 ignition[700]: no config URL provided Jul 6 23:41:39.005040 ignition[700]: reading system config file "/usr/lib/ignition/user.ign" Jul 6 23:41:39.005046 ignition[700]: no config at "/usr/lib/ignition/user.ign" Jul 6 23:41:39.005063 ignition[700]: op(1): [started] loading QEMU firmware config module Jul 6 23:41:39.005071 ignition[700]: op(1): executing: "modprobe" "qemu_fw_cfg" Jul 6 23:41:39.017400 ignition[700]: op(1): [finished] loading QEMU firmware config module Jul 6 23:41:39.020908 ignition[700]: parsing config with SHA512: ac0bbdb71d49c6c7aaf8360b3d0fd3439a5c869ab5b34c52ca6de34dfca2cb8278464c403e6e7ed02e233945f58c67ee4cf1086b3c37e84abbfaa0f5a9ef81f2 Jul 6 23:41:39.025704 unknown[700]: fetched base config from "system" Jul 6 23:41:39.025719 unknown[700]: fetched user config from "qemu" Jul 6 23:41:39.025869 ignition[700]: fetch-offline: fetch-offline passed Jul 6 23:41:39.028168 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 6 23:41:39.025938 ignition[700]: Ignition finished successfully Jul 6 23:41:39.029533 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Jul 6 23:41:39.030251 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 6 23:41:39.059420 ignition[810]: Ignition 2.21.0 Jul 6 23:41:39.059432 ignition[810]: Stage: kargs Jul 6 23:41:39.060264 ignition[810]: no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:39.060275 ignition[810]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:39.061082 ignition[810]: kargs: kargs passed Jul 6 23:41:39.061148 ignition[810]: Ignition finished successfully Jul 6 23:41:39.065149 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 6 23:41:39.068587 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 6 23:41:39.103205 ignition[819]: Ignition 2.21.0 Jul 6 23:41:39.103219 ignition[819]: Stage: disks Jul 6 23:41:39.103378 ignition[819]: no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:39.103388 ignition[819]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:39.105915 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 6 23:41:39.104382 ignition[819]: disks: disks passed Jul 6 23:41:39.107151 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 6 23:41:39.104431 ignition[819]: Ignition finished successfully Jul 6 23:41:39.108911 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 6 23:41:39.110945 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 6 23:41:39.112414 systemd[1]: Reached target sysinit.target - System Initialization. Jul 6 23:41:39.114231 systemd[1]: Reached target basic.target - Basic System. Jul 6 23:41:39.116582 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 6 23:41:39.136358 systemd-fsck[830]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 6 23:41:39.141100 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 6 23:41:39.143891 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 6 23:41:39.213367 kernel: EXT4-fs (vda9): mounted filesystem a6b10247-fbe6-4a25-95d9-ddd4b58604ec r/w with ordered data mode. Quota mode: none. Jul 6 23:41:39.213785 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 6 23:41:39.215065 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 6 23:41:39.217418 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 6 23:41:39.219044 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 6 23:41:39.220076 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 6 23:41:39.220121 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 6 23:41:39.220145 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 6 23:41:39.227498 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 6 23:41:39.230653 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 6 23:41:39.232785 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (838) Jul 6 23:41:39.236002 kernel: BTRFS info (device vda6): first mount of filesystem 492b2e2a-5dd7-445f-b930-e9dd6acadf93 Jul 6 23:41:39.236035 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 6 23:41:39.236046 kernel: BTRFS info (device vda6): using free-space-tree Jul 6 23:41:39.239181 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 6 23:41:39.277673 initrd-setup-root[862]: cut: /sysroot/etc/passwd: No such file or directory Jul 6 23:41:39.280732 initrd-setup-root[869]: cut: /sysroot/etc/group: No such file or directory Jul 6 23:41:39.285254 initrd-setup-root[876]: cut: /sysroot/etc/shadow: No such file or directory Jul 6 23:41:39.288979 initrd-setup-root[883]: cut: /sysroot/etc/gshadow: No such file or directory Jul 6 23:41:39.366893 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 6 23:41:39.369133 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 6 23:41:39.371172 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 6 23:41:39.396985 kernel: BTRFS info (device vda6): last unmount of filesystem 492b2e2a-5dd7-445f-b930-e9dd6acadf93 Jul 6 23:41:39.427253 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 6 23:41:39.434300 ignition[952]: INFO : Ignition 2.21.0 Jul 6 23:41:39.434300 ignition[952]: INFO : Stage: mount Jul 6 23:41:39.436134 ignition[952]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:39.436134 ignition[952]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:39.436134 ignition[952]: INFO : mount: mount passed Jul 6 23:41:39.436134 ignition[952]: INFO : Ignition finished successfully Jul 6 23:41:39.439852 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 6 23:41:39.444704 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 6 23:41:39.816888 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 6 23:41:39.819518 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 6 23:41:39.847483 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 (254:6) scanned by mount (965) Jul 6 23:41:39.849919 kernel: BTRFS info (device vda6): first mount of filesystem 492b2e2a-5dd7-445f-b930-e9dd6acadf93 Jul 6 23:41:39.849945 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Jul 6 23:41:39.849955 kernel: BTRFS info (device vda6): using free-space-tree Jul 6 23:41:39.858413 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 6 23:41:39.909685 ignition[982]: INFO : Ignition 2.21.0 Jul 6 23:41:39.909685 ignition[982]: INFO : Stage: files Jul 6 23:41:39.911419 ignition[982]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:39.911419 ignition[982]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:39.911419 ignition[982]: DEBUG : files: compiled without relabeling support, skipping Jul 6 23:41:39.915667 ignition[982]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 6 23:41:39.915667 ignition[982]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 6 23:41:39.920202 ignition[982]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 6 23:41:39.922170 ignition[982]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 6 23:41:39.922170 ignition[982]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 6 23:41:39.921239 unknown[982]: wrote ssh authorized keys file for user: core Jul 6 23:41:39.929268 ignition[982]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 6 23:41:39.931228 ignition[982]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 6 23:41:39.931228 ignition[982]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Jul 6 23:41:39.934372 ignition[982]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 6 23:41:39.938293 ignition[982]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Jul 6 23:41:39.938293 ignition[982]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Jul 6 23:41:39.938293 ignition[982]: INFO : files: op(6): [started] processing unit "docker.service" Jul 6 23:41:39.938293 ignition[982]: INFO : files: op(6): [finished] processing unit "docker.service" Jul 6 23:41:39.938293 ignition[982]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Jul 6 23:41:39.962204 ignition[982]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Jul 6 23:41:39.968636 ignition[982]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Jul 6 23:41:39.971416 ignition[982]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Jul 6 23:41:39.971416 ignition[982]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Jul 6 23:41:39.971416 ignition[982]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Jul 6 23:41:39.971416 ignition[982]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 6 23:41:39.971416 ignition[982]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 6 23:41:39.971416 ignition[982]: INFO : files: files passed Jul 6 23:41:39.971416 ignition[982]: INFO : Ignition finished successfully Jul 6 23:41:39.972199 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 6 23:41:39.974818 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 6 23:41:39.976851 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 6 23:41:40.000226 initrd-setup-root-after-ignition[1011]: grep: /sysroot/oem/oem-release: No such file or directory Jul 6 23:41:39.998963 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 6 23:41:39.999066 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 6 23:41:40.012266 initrd-setup-root-after-ignition[1013]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 6 23:41:40.012266 initrd-setup-root-after-ignition[1013]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 6 23:41:40.004905 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 6 23:41:40.021844 initrd-setup-root-after-ignition[1017]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 6 23:41:40.011459 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 6 23:41:40.014432 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 6 23:41:40.058082 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 6 23:41:40.058196 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 6 23:41:40.060525 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 6 23:41:40.062382 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 6 23:41:40.064224 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 6 23:41:40.065076 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 6 23:41:40.091388 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 6 23:41:40.096107 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 6 23:41:40.121198 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 6 23:41:40.122590 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 6 23:41:40.126391 systemd[1]: Stopped target timers.target - Timer Units. Jul 6 23:41:40.127393 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 6 23:41:40.127547 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 6 23:41:40.130126 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 6 23:41:40.131197 systemd[1]: Stopped target basic.target - Basic System. Jul 6 23:41:40.133161 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 6 23:41:40.135091 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 6 23:41:40.136969 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 6 23:41:40.138940 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 6 23:41:40.140987 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 6 23:41:40.142966 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 6 23:41:40.144979 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 6 23:41:40.146789 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 6 23:41:40.149193 systemd[1]: Stopped target swap.target - Swaps. Jul 6 23:41:40.150755 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 6 23:41:40.150894 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 6 23:41:40.153991 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 6 23:41:40.155146 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 6 23:41:40.157164 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 6 23:41:40.161456 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 6 23:41:40.162803 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 6 23:41:40.162926 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 6 23:41:40.167563 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 6 23:41:40.167890 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 6 23:41:40.170264 systemd[1]: Stopped target paths.target - Path Units. Jul 6 23:41:40.171720 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 6 23:41:40.172566 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 6 23:41:40.173844 systemd[1]: Stopped target slices.target - Slice Units. Jul 6 23:41:40.175387 systemd[1]: Stopped target sockets.target - Socket Units. Jul 6 23:41:40.177181 systemd[1]: iscsid.socket: Deactivated successfully. Jul 6 23:41:40.177266 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 6 23:41:40.179390 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 6 23:41:40.179478 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 6 23:41:40.181051 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 6 23:41:40.181175 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 6 23:41:40.182904 systemd[1]: ignition-files.service: Deactivated successfully. Jul 6 23:41:40.183014 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 6 23:41:40.185322 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 6 23:41:40.186899 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 6 23:41:40.187027 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 6 23:41:40.189688 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 6 23:41:40.190602 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 6 23:41:40.190731 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 6 23:41:40.192807 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 6 23:41:40.192910 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 6 23:41:40.197956 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 6 23:41:40.210492 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 6 23:41:40.219094 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 6 23:41:40.224218 ignition[1037]: INFO : Ignition 2.21.0 Jul 6 23:41:40.224218 ignition[1037]: INFO : Stage: umount Jul 6 23:41:40.225907 ignition[1037]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 6 23:41:40.225907 ignition[1037]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Jul 6 23:41:40.225907 ignition[1037]: INFO : umount: umount passed Jul 6 23:41:40.225907 ignition[1037]: INFO : Ignition finished successfully Jul 6 23:41:40.224654 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 6 23:41:40.226397 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 6 23:41:40.228059 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 6 23:41:40.228136 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 6 23:41:40.230267 systemd[1]: Stopped target network.target - Network. Jul 6 23:41:40.231284 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 6 23:41:40.231396 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 6 23:41:40.233144 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 6 23:41:40.233191 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 6 23:41:40.234847 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 6 23:41:40.234897 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 6 23:41:40.236529 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 6 23:41:40.236572 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 6 23:41:40.238262 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 6 23:41:40.238309 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 6 23:41:40.238621 systemd-networkd[797]: eth0: Gained IPv6LL Jul 6 23:41:40.241329 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 6 23:41:40.243275 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 6 23:41:40.249846 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 6 23:41:40.249959 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 6 23:41:40.254210 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 6 23:41:40.254425 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 6 23:41:40.254526 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 6 23:41:40.258146 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jul 6 23:41:40.258763 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 6 23:41:40.259975 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 6 23:41:40.260012 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 6 23:41:40.262768 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 6 23:41:40.263697 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 6 23:41:40.263757 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 6 23:41:40.266129 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 6 23:41:40.266177 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 6 23:41:40.268926 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 6 23:41:40.268970 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 6 23:41:40.271245 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 6 23:41:40.271293 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 6 23:41:40.274279 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 6 23:41:40.293179 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 6 23:41:40.293298 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 6 23:41:40.295508 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 6 23:41:40.295642 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 6 23:41:40.297871 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 6 23:41:40.297932 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 6 23:41:40.299317 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 6 23:41:40.299376 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 6 23:41:40.301659 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 6 23:41:40.301711 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 6 23:41:40.304369 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 6 23:41:40.304415 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 6 23:41:40.307222 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 6 23:41:40.307277 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 6 23:41:40.311492 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 6 23:41:40.312700 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 6 23:41:40.312766 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 6 23:41:40.316869 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 6 23:41:40.316913 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 6 23:41:40.320565 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 6 23:41:40.320616 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 6 23:41:40.326486 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 6 23:41:40.326622 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 6 23:41:40.329902 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 6 23:41:40.332258 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 6 23:41:40.363232 systemd[1]: Switching root. Jul 6 23:41:40.389668 systemd-journald[245]: Journal stopped Jul 6 23:41:41.159274 systemd-journald[245]: Received SIGTERM from PID 1 (systemd). Jul 6 23:41:41.159322 kernel: SELinux: policy capability network_peer_controls=1 Jul 6 23:41:41.159334 kernel: SELinux: policy capability open_perms=1 Jul 6 23:41:41.159364 kernel: SELinux: policy capability extended_socket_class=1 Jul 6 23:41:41.159376 kernel: SELinux: policy capability always_check_network=0 Jul 6 23:41:41.159385 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 6 23:41:41.159397 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 6 23:41:41.159409 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 6 23:41:41.159422 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 6 23:41:41.159440 kernel: SELinux: policy capability userspace_initial_context=0 Jul 6 23:41:41.159452 kernel: audit: type=1403 audit(1751845300.474:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 6 23:41:41.159467 systemd[1]: Successfully loaded SELinux policy in 46.862ms. Jul 6 23:41:41.159482 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 16.381ms. Jul 6 23:41:41.159493 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 6 23:41:41.159505 systemd[1]: Detected virtualization kvm. Jul 6 23:41:41.159515 systemd[1]: Detected architecture arm64. Jul 6 23:41:41.159525 systemd[1]: Detected first boot. Jul 6 23:41:41.159535 systemd[1]: Initializing machine ID from VM UUID. Jul 6 23:41:41.159545 zram_generator::config[1083]: No configuration found. Jul 6 23:41:41.159556 kernel: NET: Registered PF_VSOCK protocol family Jul 6 23:41:41.159565 systemd[1]: Populated /etc with preset unit settings. Jul 6 23:41:41.159576 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 6 23:41:41.159586 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 6 23:41:41.159597 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 6 23:41:41.159607 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 6 23:41:41.159619 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 6 23:41:41.159630 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 6 23:41:41.159640 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 6 23:41:41.159651 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 6 23:41:41.159661 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 6 23:41:41.159671 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 6 23:41:41.159681 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 6 23:41:41.159691 systemd[1]: Created slice user.slice - User and Session Slice. Jul 6 23:41:41.159701 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 6 23:41:41.159711 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 6 23:41:41.159721 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 6 23:41:41.159732 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 6 23:41:41.159743 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 6 23:41:41.159753 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 6 23:41:41.159763 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Jul 6 23:41:41.159773 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 6 23:41:41.159783 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 6 23:41:41.159793 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 6 23:41:41.159802 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 6 23:41:41.159814 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 6 23:41:41.159825 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 6 23:41:41.159835 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 6 23:41:41.159844 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 6 23:41:41.159855 systemd[1]: Reached target slices.target - Slice Units. Jul 6 23:41:41.159864 systemd[1]: Reached target swap.target - Swaps. Jul 6 23:41:41.159874 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 6 23:41:41.159884 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 6 23:41:41.159894 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 6 23:41:41.159905 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 6 23:41:41.159916 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 6 23:41:41.159926 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 6 23:41:41.159936 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 6 23:41:41.159946 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 6 23:41:41.159956 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 6 23:41:41.159965 systemd[1]: Mounting media.mount - External Media Directory... Jul 6 23:41:41.159976 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 6 23:41:41.159985 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 6 23:41:41.159997 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 6 23:41:41.160007 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 6 23:41:41.160017 systemd[1]: Reached target machines.target - Containers. Jul 6 23:41:41.160027 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 6 23:41:41.160037 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 6 23:41:41.160047 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 6 23:41:41.160057 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 6 23:41:41.160067 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 6 23:41:41.160077 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 6 23:41:41.160088 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 6 23:41:41.160098 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 6 23:41:41.160107 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 6 23:41:41.160117 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 6 23:41:41.160127 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 6 23:41:41.160137 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 6 23:41:41.160147 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 6 23:41:41.160158 systemd[1]: Stopped systemd-fsck-usr.service. Jul 6 23:41:41.160169 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 6 23:41:41.160180 kernel: loop: module loaded Jul 6 23:41:41.160189 kernel: fuse: init (API version 7.41) Jul 6 23:41:41.160200 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 6 23:41:41.160211 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 6 23:41:41.160221 kernel: ACPI: bus type drm_connector registered Jul 6 23:41:41.160239 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 6 23:41:41.160250 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 6 23:41:41.160260 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 6 23:41:41.160270 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 6 23:41:41.160281 systemd[1]: verity-setup.service: Deactivated successfully. Jul 6 23:41:41.160291 systemd[1]: Stopped verity-setup.service. Jul 6 23:41:41.160301 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 6 23:41:41.160330 systemd-journald[1148]: Collecting audit messages is disabled. Jul 6 23:41:41.160410 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 6 23:41:41.160428 systemd-journald[1148]: Journal started Jul 6 23:41:41.160455 systemd-journald[1148]: Runtime Journal (/run/log/journal/673168c19af84c9caa00c7a931186257) is 6M, max 48.5M, 42.4M free. Jul 6 23:41:40.920326 systemd[1]: Queued start job for default target multi-user.target. Jul 6 23:41:40.941224 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jul 6 23:41:40.941629 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 6 23:41:41.163371 systemd[1]: Started systemd-journald.service - Journal Service. Jul 6 23:41:41.163990 systemd[1]: Mounted media.mount - External Media Directory. Jul 6 23:41:41.165131 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 6 23:41:41.166469 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 6 23:41:41.167721 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 6 23:41:41.168989 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 6 23:41:41.170433 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 6 23:41:41.171919 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 6 23:41:41.172080 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 6 23:41:41.173557 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 6 23:41:41.173723 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 6 23:41:41.175267 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 6 23:41:41.175446 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 6 23:41:41.176752 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 6 23:41:41.176923 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 6 23:41:41.178393 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 6 23:41:41.178562 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 6 23:41:41.180012 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 6 23:41:41.180171 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 6 23:41:41.181629 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 6 23:41:41.183106 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 6 23:41:41.184671 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 6 23:41:41.186245 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 6 23:41:41.198055 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 6 23:41:41.200583 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 6 23:41:41.202715 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 6 23:41:41.203834 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 6 23:41:41.203861 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 6 23:41:41.205832 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 6 23:41:41.210099 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 6 23:41:41.211269 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 6 23:41:41.212504 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 6 23:41:41.214524 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 6 23:41:41.215772 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 6 23:41:41.217500 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 6 23:41:41.218675 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 6 23:41:41.221523 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 6 23:41:41.223545 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 6 23:41:41.229302 systemd-journald[1148]: Time spent on flushing to /var/log/journal/673168c19af84c9caa00c7a931186257 is 21.843ms for 847 entries. Jul 6 23:41:41.229302 systemd-journald[1148]: System Journal (/var/log/journal/673168c19af84c9caa00c7a931186257) is 8M, max 195.6M, 187.6M free. Jul 6 23:41:41.269264 systemd-journald[1148]: Received client request to flush runtime journal. Jul 6 23:41:41.269318 kernel: loop0: detected capacity change from 0 to 138376 Jul 6 23:41:41.269407 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 6 23:41:41.227499 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 6 23:41:41.230038 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 6 23:41:41.232200 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 6 23:41:41.234675 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 6 23:41:41.240373 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 6 23:41:41.242050 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 6 23:41:41.251101 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 6 23:41:41.253765 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 6 23:41:41.272243 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 6 23:41:41.275386 kernel: loop1: detected capacity change from 0 to 107312 Jul 6 23:41:41.285180 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 6 23:41:41.287136 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 6 23:41:41.290269 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 6 23:41:41.309376 kernel: loop2: detected capacity change from 0 to 138376 Jul 6 23:41:41.320375 kernel: loop3: detected capacity change from 0 to 107312 Jul 6 23:41:41.321802 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. Jul 6 23:41:41.321820 systemd-tmpfiles[1217]: ACLs are not supported, ignoring. Jul 6 23:41:41.325655 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 6 23:41:41.328796 (sd-merge)[1220]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Jul 6 23:41:41.329122 (sd-merge)[1220]: Merged extensions into '/usr'. Jul 6 23:41:41.333426 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 6 23:41:41.337684 systemd[1]: Starting ensure-sysext.service... Jul 6 23:41:41.341015 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 6 23:41:41.354921 systemd[1]: Reload requested from client PID 1224 ('systemctl') (unit ensure-sysext.service)... Jul 6 23:41:41.354945 systemd[1]: Reloading... Jul 6 23:41:41.359469 systemd-tmpfiles[1225]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 6 23:41:41.359909 systemd-tmpfiles[1225]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 6 23:41:41.360225 systemd-tmpfiles[1225]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 6 23:41:41.360604 systemd-tmpfiles[1225]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 6 23:41:41.361288 systemd-tmpfiles[1225]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 6 23:41:41.361604 systemd-tmpfiles[1225]: ACLs are not supported, ignoring. Jul 6 23:41:41.361726 systemd-tmpfiles[1225]: ACLs are not supported, ignoring. Jul 6 23:41:41.364551 systemd-tmpfiles[1225]: Detected autofs mount point /boot during canonicalization of boot. Jul 6 23:41:41.364652 systemd-tmpfiles[1225]: Skipping /boot Jul 6 23:41:41.374048 systemd-tmpfiles[1225]: Detected autofs mount point /boot during canonicalization of boot. Jul 6 23:41:41.374151 systemd-tmpfiles[1225]: Skipping /boot Jul 6 23:41:41.414468 zram_generator::config[1250]: No configuration found. Jul 6 23:41:41.499228 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 6 23:41:41.514011 ldconfig[1194]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 6 23:41:41.563135 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 6 23:41:41.563409 systemd[1]: Reloading finished in 208 ms. Jul 6 23:41:41.596051 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 6 23:41:41.614412 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 6 23:41:41.622272 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 6 23:41:41.624764 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 6 23:41:41.638640 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 6 23:41:41.641980 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 6 23:41:41.644954 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 6 23:41:41.649079 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 6 23:41:41.654764 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 6 23:41:41.658625 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 6 23:41:41.665079 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 6 23:41:41.666270 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 6 23:41:41.666403 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 6 23:41:41.667305 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 6 23:41:41.667486 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 6 23:41:41.672235 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 6 23:41:41.672410 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 6 23:41:41.674255 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 6 23:41:41.676385 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 6 23:41:41.678228 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 6 23:41:41.684987 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 6 23:41:41.687276 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 6 23:41:41.689831 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 6 23:41:41.692636 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 6 23:41:41.693735 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 6 23:41:41.693848 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 6 23:41:41.711687 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 6 23:41:41.715391 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 6 23:41:41.717199 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 6 23:41:41.717379 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 6 23:41:41.718989 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 6 23:41:41.719148 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 6 23:41:41.722806 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 6 23:41:41.722967 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 6 23:41:41.729922 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 6 23:41:41.731574 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 6 23:41:41.733792 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 6 23:41:41.748903 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 6 23:41:41.753808 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 6 23:41:41.755110 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 6 23:41:41.755276 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 6 23:41:41.756403 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 6 23:41:41.758174 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 6 23:41:41.759887 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 6 23:41:41.762779 augenrules[1336]: No rules Jul 6 23:41:41.766391 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 6 23:41:41.768101 systemd[1]: audit-rules.service: Deactivated successfully. Jul 6 23:41:41.768278 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 6 23:41:41.769660 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 6 23:41:41.769811 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 6 23:41:41.771330 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 6 23:41:41.771514 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 6 23:41:41.773011 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 6 23:41:41.773166 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 6 23:41:41.777468 systemd[1]: Finished ensure-sysext.service. Jul 6 23:41:41.781852 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 6 23:41:41.781911 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 6 23:41:41.783822 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jul 6 23:41:41.785022 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 6 23:41:41.797527 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 6 23:41:41.800482 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 6 23:41:41.802784 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 6 23:41:41.821558 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 6 23:41:41.822046 systemd-resolved[1293]: Positive Trust Anchors: Jul 6 23:41:41.822064 systemd-resolved[1293]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 6 23:41:41.822095 systemd-resolved[1293]: 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 6 23:41:41.838160 systemd-udevd[1351]: Using default interface naming scheme 'v255'. Jul 6 23:41:41.839282 systemd-resolved[1293]: Defaulting to hostname 'linux'. Jul 6 23:41:41.840978 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 6 23:41:41.842364 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 6 23:41:41.845048 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jul 6 23:41:41.846532 systemd[1]: Reached target time-set.target - System Time Set. Jul 6 23:41:41.866747 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 6 23:41:41.868867 systemd[1]: Reached target sysinit.target - System Initialization. Jul 6 23:41:41.870052 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 6 23:41:41.871324 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 6 23:41:41.872742 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 6 23:41:41.874247 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 6 23:41:41.875648 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 6 23:41:41.876992 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 6 23:41:41.877029 systemd[1]: Reached target paths.target - Path Units. Jul 6 23:41:41.879490 systemd[1]: Reached target timers.target - Timer Units. Jul 6 23:41:41.881918 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 6 23:41:41.884724 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 6 23:41:41.889286 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 6 23:41:41.890897 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 6 23:41:41.892331 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 6 23:41:41.900472 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 6 23:41:41.902162 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 6 23:41:41.908543 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 6 23:41:41.911158 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 6 23:41:41.917833 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Jul 6 23:41:41.917920 systemd[1]: Reached target sockets.target - Socket Units. Jul 6 23:41:41.919811 systemd[1]: Reached target basic.target - Basic System. Jul 6 23:41:41.921282 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 6 23:41:41.921313 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 6 23:41:41.924892 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 6 23:41:41.929874 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 6 23:41:41.935467 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 6 23:41:41.941332 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 6 23:41:41.943195 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 6 23:41:41.946631 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 6 23:41:41.951926 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 6 23:41:41.963592 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 6 23:41:41.969550 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 6 23:41:41.971651 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 6 23:41:41.972158 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 6 23:41:41.975099 systemd[1]: Starting update-engine.service - Update Engine... Jul 6 23:41:41.979922 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 6 23:41:41.981715 jq[1390]: false Jul 6 23:41:41.992636 jq[1410]: true Jul 6 23:41:42.005294 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 6 23:41:42.006524 extend-filesystems[1392]: Found /dev/vda6 Jul 6 23:41:42.006953 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 6 23:41:42.007131 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 6 23:41:42.007382 systemd[1]: motdgen.service: Deactivated successfully. Jul 6 23:41:42.007568 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 6 23:41:42.009412 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 6 23:41:42.009589 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 6 23:41:42.024133 extend-filesystems[1392]: Found /dev/vda9 Jul 6 23:41:42.036439 jq[1414]: true Jul 6 23:41:42.039364 extend-filesystems[1392]: Checking size of /dev/vda9 Jul 6 23:41:42.043570 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jul 6 23:41:42.052661 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 6 23:41:42.067947 dbus-daemon[1387]: [system] SELinux support is enabled Jul 6 23:41:42.068128 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 6 23:41:42.068538 extend-filesystems[1392]: Old size kept for /dev/vda9 Jul 6 23:41:42.072049 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 6 23:41:42.072374 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 6 23:41:42.077212 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 6 23:41:42.077252 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 6 23:41:42.079384 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 6 23:41:42.079405 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 6 23:41:42.081517 update_engine[1404]: I20250706 23:41:42.079134 1404 main.cc:92] Flatcar Update Engine starting Jul 6 23:41:42.085700 systemd-logind[1400]: New seat seat0. Jul 6 23:41:42.087777 update_engine[1404]: I20250706 23:41:42.087692 1404 update_check_scheduler.cc:74] Next update check in 2m24s Jul 6 23:41:42.087994 systemd[1]: Started systemd-logind.service - User Login Management. Jul 6 23:41:42.089980 systemd[1]: Started update-engine.service - Update Engine. Jul 6 23:41:42.094904 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 6 23:41:42.110863 systemd-networkd[1384]: lo: Link UP Jul 6 23:41:42.110876 systemd-networkd[1384]: lo: Gained carrier Jul 6 23:41:42.111405 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 6 23:41:42.111860 systemd-networkd[1384]: Enumeration completed Jul 6 23:41:42.112428 systemd-networkd[1384]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 6 23:41:42.112447 systemd-networkd[1384]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 6 23:41:42.113177 systemd-networkd[1384]: eth0: Link UP Jul 6 23:41:42.113308 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 6 23:41:42.113372 systemd-networkd[1384]: eth0: Gained carrier Jul 6 23:41:42.113387 systemd-networkd[1384]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 6 23:41:42.115543 systemd[1]: Reached target network.target - Network. Jul 6 23:41:42.118281 bash[1447]: Updated "/home/core/.ssh/authorized_keys" Jul 6 23:41:42.118146 systemd[1]: Starting containerd.service - containerd container runtime... Jul 6 23:41:42.121577 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 6 23:41:42.124789 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 6 23:41:42.128367 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 6 23:41:42.128439 systemd-networkd[1384]: eth0: DHCPv4 address 10.0.0.129/16, gateway 10.0.0.1 acquired from 10.0.0.1 Jul 6 23:41:42.130485 systemd-timesyncd[1349]: Network configuration changed, trying to establish connection. Jul 6 23:41:42.131197 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Jul 6 23:41:42.133515 systemd-timesyncd[1349]: Contacted time server 10.0.0.1:123 (10.0.0.1). Jul 6 23:41:42.133688 systemd-timesyncd[1349]: Initial clock synchronization to Sun 2025-07-06 23:41:42.195526 UTC. Jul 6 23:41:42.173723 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 6 23:41:42.175609 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 6 23:41:42.180412 locksmithd[1442]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 6 23:41:42.186855 (ntainerd)[1475]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 6 23:41:42.194164 systemd-logind[1400]: Watching system buttons on /dev/input/event0 (Power Button) Jul 6 23:41:42.295226 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 6 23:41:42.358892 sshd_keygen[1411]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 6 23:41:42.382398 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 6 23:41:42.385710 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 6 23:41:42.398894 containerd[1475]: time="2025-07-06T23:41:42Z" 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 6 23:41:42.399542 containerd[1475]: time="2025-07-06T23:41:42.399512880Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 6 23:41:42.404801 systemd[1]: issuegen.service: Deactivated successfully. Jul 6 23:41:42.404997 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 6 23:41:42.407604 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 6 23:41:42.408017 containerd[1475]: time="2025-07-06T23:41:42.407818280Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.36µs" Jul 6 23:41:42.408017 containerd[1475]: time="2025-07-06T23:41:42.407844400Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 6 23:41:42.408017 containerd[1475]: time="2025-07-06T23:41:42.407861440Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 6 23:41:42.408017 containerd[1475]: time="2025-07-06T23:41:42.407998000Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 6 23:41:42.408017 containerd[1475]: time="2025-07-06T23:41:42.408012120Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 6 23:41:42.408118 containerd[1475]: time="2025-07-06T23:41:42.408034120Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408118 containerd[1475]: time="2025-07-06T23:41:42.408079320Z" 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 6 23:41:42.408118 containerd[1475]: time="2025-07-06T23:41:42.408090480Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408316 containerd[1475]: time="2025-07-06T23:41:42.408275600Z" 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 6 23:41:42.408316 containerd[1475]: time="2025-07-06T23:41:42.408301200Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408316 containerd[1475]: time="2025-07-06T23:41:42.408312960Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408399 containerd[1475]: time="2025-07-06T23:41:42.408321160Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408419 containerd[1475]: time="2025-07-06T23:41:42.408406240Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408628 containerd[1475]: time="2025-07-06T23:41:42.408598840Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 6 23:41:42.408668 containerd[1475]: time="2025-07-06T23:41:42.408650880Z" 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 6 23:41:42.408668 containerd[1475]: time="2025-07-06T23:41:42.408662280Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 6 23:41:42.409177 containerd[1475]: time="2025-07-06T23:41:42.409153240Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 6 23:41:42.409400 containerd[1475]: time="2025-07-06T23:41:42.409383280Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 6 23:41:42.409481 containerd[1475]: time="2025-07-06T23:41:42.409464280Z" level=info msg="metadata content store policy set" policy=shared Jul 6 23:41:42.413129 containerd[1475]: time="2025-07-06T23:41:42.413102760Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 6 23:41:42.413205 containerd[1475]: time="2025-07-06T23:41:42.413145480Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 6 23:41:42.413205 containerd[1475]: time="2025-07-06T23:41:42.413160000Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 6 23:41:42.413205 containerd[1475]: time="2025-07-06T23:41:42.413171280Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 6 23:41:42.413205 containerd[1475]: time="2025-07-06T23:41:42.413182880Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 6 23:41:42.413297 containerd[1475]: time="2025-07-06T23:41:42.413279240Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 6 23:41:42.413319 containerd[1475]: time="2025-07-06T23:41:42.413302800Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 6 23:41:42.413363 containerd[1475]: time="2025-07-06T23:41:42.413323280Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 6 23:41:42.413384 containerd[1475]: time="2025-07-06T23:41:42.413375760Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 6 23:41:42.413498 containerd[1475]: time="2025-07-06T23:41:42.413481680Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 6 23:41:42.414482 containerd[1475]: time="2025-07-06T23:41:42.414417040Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 6 23:41:42.414699 containerd[1475]: time="2025-07-06T23:41:42.414574920Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416598280Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416626160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416641120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416652360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416662760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416672200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416683000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416692600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416704880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416715240Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416724680Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416901720Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416947080Z" level=info msg="Start snapshots syncer" Jul 6 23:41:42.417418 containerd[1475]: time="2025-07-06T23:41:42.416973640Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 6 23:41:42.417774 containerd[1475]: time="2025-07-06T23:41:42.417176880Z" 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 6 23:41:42.417774 containerd[1475]: time="2025-07-06T23:41:42.417221240Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 6 23:41:42.417882 containerd[1475]: time="2025-07-06T23:41:42.417288880Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 6 23:41:42.418048 containerd[1475]: time="2025-07-06T23:41:42.417968360Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 6 23:41:42.418138 containerd[1475]: time="2025-07-06T23:41:42.418123880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 6 23:41:42.418191 containerd[1475]: time="2025-07-06T23:41:42.418178320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 6 23:41:42.418247 containerd[1475]: time="2025-07-06T23:41:42.418235160Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 6 23:41:42.418302 containerd[1475]: time="2025-07-06T23:41:42.418285320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 6 23:41:42.418365 containerd[1475]: time="2025-07-06T23:41:42.418338680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 6 23:41:42.418422 containerd[1475]: time="2025-07-06T23:41:42.418409960Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 6 23:41:42.418500 containerd[1475]: time="2025-07-06T23:41:42.418486880Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 6 23:41:42.418551 containerd[1475]: time="2025-07-06T23:41:42.418539160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 6 23:41:42.418600 containerd[1475]: time="2025-07-06T23:41:42.418588400Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 6 23:41:42.418700 containerd[1475]: time="2025-07-06T23:41:42.418684520Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 6 23:41:42.418759 containerd[1475]: time="2025-07-06T23:41:42.418744960Z" 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 6 23:41:42.418803 containerd[1475]: time="2025-07-06T23:41:42.418790800Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 6 23:41:42.418851 containerd[1475]: time="2025-07-06T23:41:42.418838840Z" 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 6 23:41:42.418893 containerd[1475]: time="2025-07-06T23:41:42.418881480Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 6 23:41:42.418948 containerd[1475]: time="2025-07-06T23:41:42.418935400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 6 23:41:42.419007 containerd[1475]: time="2025-07-06T23:41:42.418994560Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 6 23:41:42.419119 containerd[1475]: time="2025-07-06T23:41:42.419108200Z" level=info msg="runtime interface created" Jul 6 23:41:42.419158 containerd[1475]: time="2025-07-06T23:41:42.419147440Z" level=info msg="created NRI interface" Jul 6 23:41:42.419205 containerd[1475]: time="2025-07-06T23:41:42.419193320Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 6 23:41:42.419259 containerd[1475]: time="2025-07-06T23:41:42.419247480Z" level=info msg="Connect containerd service" Jul 6 23:41:42.419334 containerd[1475]: time="2025-07-06T23:41:42.419322080Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 6 23:41:42.420095 containerd[1475]: time="2025-07-06T23:41:42.420064280Z" 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 6 23:41:42.423447 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 6 23:41:42.426167 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 6 23:41:42.428452 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Jul 6 23:41:42.429738 systemd[1]: Reached target getty.target - Login Prompts. Jul 6 23:41:42.526947 containerd[1475]: time="2025-07-06T23:41:42.526880320Z" level=info msg="Start subscribing containerd event" Jul 6 23:41:42.526947 containerd[1475]: time="2025-07-06T23:41:42.526951760Z" level=info msg="Start recovering state" Jul 6 23:41:42.527060 containerd[1475]: time="2025-07-06T23:41:42.527037200Z" level=info msg="Start event monitor" Jul 6 23:41:42.527060 containerd[1475]: time="2025-07-06T23:41:42.527052520Z" level=info msg="Start cni network conf syncer for default" Jul 6 23:41:42.527060 containerd[1475]: time="2025-07-06T23:41:42.527059560Z" level=info msg="Start streaming server" Jul 6 23:41:42.527131 containerd[1475]: time="2025-07-06T23:41:42.527067920Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 6 23:41:42.527131 containerd[1475]: time="2025-07-06T23:41:42.527075640Z" level=info msg="runtime interface starting up..." Jul 6 23:41:42.527131 containerd[1475]: time="2025-07-06T23:41:42.527081640Z" level=info msg="starting plugins..." Jul 6 23:41:42.527131 containerd[1475]: time="2025-07-06T23:41:42.527098600Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 6 23:41:42.527400 containerd[1475]: time="2025-07-06T23:41:42.527212560Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 6 23:41:42.527400 containerd[1475]: time="2025-07-06T23:41:42.527276280Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 6 23:41:42.527400 containerd[1475]: time="2025-07-06T23:41:42.527374840Z" level=info msg="containerd successfully booted in 0.128799s" Jul 6 23:41:42.527469 systemd[1]: Started containerd.service - containerd container runtime. Jul 6 23:41:43.629653 systemd-networkd[1384]: eth0: Gained IPv6LL Jul 6 23:41:43.631842 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 6 23:41:43.633539 systemd[1]: Reached target network-online.target - Network is Online. Jul 6 23:41:43.637754 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Jul 6 23:41:43.639805 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 6 23:41:43.664930 systemd[1]: coreos-metadata.service: Deactivated successfully. Jul 6 23:41:43.665177 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Jul 6 23:41:43.668110 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 6 23:41:43.670193 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 6 23:41:43.670471 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 6 23:41:43.673445 systemd[1]: Startup finished in 2.130s (kernel) + 3.850s (initrd) + 3.246s (userspace) = 9.227s. Jul 6 23:41:49.886758 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 6 23:41:49.887912 systemd[1]: Started sshd@0-10.0.0.129:22-10.0.0.1:33946.service - OpenSSH per-connection server daemon (10.0.0.1:33946). Jul 6 23:41:49.949485 sshd[1540]: Accepted publickey for core from 10.0.0.1 port 33946 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:49.951441 sshd-session[1540]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:49.957344 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 6 23:41:49.958230 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 6 23:41:49.963394 systemd-logind[1400]: New session 1 of user core. Jul 6 23:41:49.983684 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 6 23:41:49.986158 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 6 23:41:49.999384 (systemd)[1544]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 6 23:41:50.001474 systemd-logind[1400]: New session c1 of user core. Jul 6 23:41:50.129640 systemd[1544]: Queued start job for default target default.target. Jul 6 23:41:50.147378 systemd[1544]: Created slice app.slice - User Application Slice. Jul 6 23:41:50.147408 systemd[1544]: Reached target paths.target - Paths. Jul 6 23:41:50.147448 systemd[1544]: Reached target timers.target - Timers. Jul 6 23:41:50.148724 systemd[1544]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 6 23:41:50.159154 systemd[1544]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 6 23:41:50.159366 systemd[1544]: Reached target sockets.target - Sockets. Jul 6 23:41:50.159500 systemd[1544]: Reached target basic.target - Basic System. Jul 6 23:41:50.159532 systemd[1544]: Reached target default.target - Main User Target. Jul 6 23:41:50.159558 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 6 23:41:50.159561 systemd[1544]: Startup finished in 152ms. Jul 6 23:41:50.160921 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 6 23:41:50.228863 systemd[1]: Started sshd@1-10.0.0.129:22-10.0.0.1:33954.service - OpenSSH per-connection server daemon (10.0.0.1:33954). Jul 6 23:41:50.280732 sshd[1555]: Accepted publickey for core from 10.0.0.1 port 33954 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:50.282171 sshd-session[1555]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:50.287612 systemd-logind[1400]: New session 2 of user core. Jul 6 23:41:50.295563 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 6 23:41:50.346788 sshd[1557]: Connection closed by 10.0.0.1 port 33954 Jul 6 23:41:50.347152 sshd-session[1555]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:50.358680 systemd[1]: sshd@1-10.0.0.129:22-10.0.0.1:33954.service: Deactivated successfully. Jul 6 23:41:50.360327 systemd[1]: session-2.scope: Deactivated successfully. Jul 6 23:41:50.361209 systemd-logind[1400]: Session 2 logged out. Waiting for processes to exit. Jul 6 23:41:50.363904 systemd[1]: Started sshd@2-10.0.0.129:22-10.0.0.1:33966.service - OpenSSH per-connection server daemon (10.0.0.1:33966). Jul 6 23:41:50.364578 systemd-logind[1400]: Removed session 2. Jul 6 23:41:50.422726 sshd[1563]: Accepted publickey for core from 10.0.0.1 port 33966 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:50.423994 sshd-session[1563]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:50.428837 systemd-logind[1400]: New session 3 of user core. Jul 6 23:41:50.440562 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 6 23:41:50.489867 sshd[1565]: Connection closed by 10.0.0.1 port 33966 Jul 6 23:41:50.490438 sshd-session[1563]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:50.499645 systemd[1]: sshd@2-10.0.0.129:22-10.0.0.1:33966.service: Deactivated successfully. Jul 6 23:41:50.501440 systemd[1]: session-3.scope: Deactivated successfully. Jul 6 23:41:50.502153 systemd-logind[1400]: Session 3 logged out. Waiting for processes to exit. Jul 6 23:41:50.505416 systemd-logind[1400]: Removed session 3. Jul 6 23:41:50.505968 systemd[1]: Started sshd@3-10.0.0.129:22-10.0.0.1:33974.service - OpenSSH per-connection server daemon (10.0.0.1:33974). Jul 6 23:41:50.557262 sshd[1571]: Accepted publickey for core from 10.0.0.1 port 33974 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:50.558647 sshd-session[1571]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:50.562613 systemd-logind[1400]: New session 4 of user core. Jul 6 23:41:50.570559 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 6 23:41:50.622438 sshd[1573]: Connection closed by 10.0.0.1 port 33974 Jul 6 23:41:50.622739 sshd-session[1571]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:50.645765 systemd[1]: sshd@3-10.0.0.129:22-10.0.0.1:33974.service: Deactivated successfully. Jul 6 23:41:50.647461 systemd[1]: session-4.scope: Deactivated successfully. Jul 6 23:41:50.649145 systemd-logind[1400]: Session 4 logged out. Waiting for processes to exit. Jul 6 23:41:50.651765 systemd[1]: Started sshd@4-10.0.0.129:22-10.0.0.1:33990.service - OpenSSH per-connection server daemon (10.0.0.1:33990). Jul 6 23:41:50.652832 systemd-logind[1400]: Removed session 4. Jul 6 23:41:50.705233 sshd[1579]: Accepted publickey for core from 10.0.0.1 port 33990 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:50.706580 sshd-session[1579]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:50.711284 systemd-logind[1400]: New session 5 of user core. Jul 6 23:41:50.724583 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 6 23:41:50.791343 sudo[1582]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 6 23:41:50.791688 sudo[1582]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 6 23:41:50.814217 sudo[1582]: pam_unix(sudo:session): session closed for user root Jul 6 23:41:50.815930 sshd[1581]: Connection closed by 10.0.0.1 port 33990 Jul 6 23:41:50.816399 sshd-session[1579]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:50.830062 systemd[1]: sshd@4-10.0.0.129:22-10.0.0.1:33990.service: Deactivated successfully. Jul 6 23:41:50.832881 systemd[1]: session-5.scope: Deactivated successfully. Jul 6 23:41:50.833717 systemd-logind[1400]: Session 5 logged out. Waiting for processes to exit. Jul 6 23:41:50.837888 systemd[1]: Started sshd@5-10.0.0.129:22-10.0.0.1:33996.service - OpenSSH per-connection server daemon (10.0.0.1:33996). Jul 6 23:41:50.841897 systemd-logind[1400]: Removed session 5. Jul 6 23:41:50.898705 sshd[1588]: Accepted publickey for core from 10.0.0.1 port 33996 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:50.900705 sshd-session[1588]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:50.906437 systemd-logind[1400]: New session 6 of user core. Jul 6 23:41:50.916563 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 6 23:41:50.970384 sudo[1592]: 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 6 23:41:50.970687 sudo[1592]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 6 23:41:50.982227 sudo[1592]: pam_unix(sudo:session): session closed for user root Jul 6 23:41:50.987731 sudo[1591]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 6 23:41:50.988484 sudo[1591]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 6 23:41:51.001254 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 6 23:41:51.047890 augenrules[1614]: No rules Jul 6 23:41:51.049147 systemd[1]: audit-rules.service: Deactivated successfully. Jul 6 23:41:51.051395 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 6 23:41:51.054295 sudo[1591]: pam_unix(sudo:session): session closed for user root Jul 6 23:41:51.055727 sshd[1590]: Connection closed by 10.0.0.1 port 33996 Jul 6 23:41:51.056149 sshd-session[1588]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:51.074485 systemd[1]: sshd@5-10.0.0.129:22-10.0.0.1:33996.service: Deactivated successfully. Jul 6 23:41:51.077123 systemd[1]: session-6.scope: Deactivated successfully. Jul 6 23:41:51.078034 systemd-logind[1400]: Session 6 logged out. Waiting for processes to exit. Jul 6 23:41:51.081658 systemd[1]: Started sshd@6-10.0.0.129:22-10.0.0.1:34006.service - OpenSSH per-connection server daemon (10.0.0.1:34006). Jul 6 23:41:51.082723 systemd-logind[1400]: Removed session 6. Jul 6 23:41:51.128076 sshd[1623]: Accepted publickey for core from 10.0.0.1 port 34006 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:51.128944 sshd-session[1623]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:51.133410 systemd-logind[1400]: New session 7 of user core. Jul 6 23:41:51.152575 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 6 23:41:51.208559 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 6 23:41:51.226256 (dockerd)[1627]: 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 6 23:41:51.585064 dockerd[1627]: time="2025-07-06T23:41:51.584928148Z" level=info msg="Starting up" Jul 6 23:41:51.586209 dockerd[1627]: time="2025-07-06T23:41:51.586133253Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 6 23:41:51.651867 dockerd[1627]: time="2025-07-06T23:41:51.651820114Z" level=info msg="Loading containers: start." Jul 6 23:41:51.665508 kernel: Initializing XFRM netlink socket Jul 6 23:41:51.928148 systemd-networkd[1384]: docker0: Link UP Jul 6 23:41:51.937837 dockerd[1627]: time="2025-07-06T23:41:51.937652674Z" level=info msg="Loading containers: done." Jul 6 23:41:51.954518 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck350509550-merged.mount: Deactivated successfully. Jul 6 23:41:51.963091 dockerd[1627]: time="2025-07-06T23:41:51.963033697Z" 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 6 23:41:51.963261 dockerd[1627]: time="2025-07-06T23:41:51.963143150Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 6 23:41:51.963287 dockerd[1627]: time="2025-07-06T23:41:51.963268600Z" level=info msg="Initializing buildkit" Jul 6 23:41:51.992710 dockerd[1627]: time="2025-07-06T23:41:51.992655361Z" level=info msg="Completed buildkit initialization" Jul 6 23:41:52.001311 dockerd[1627]: time="2025-07-06T23:41:52.000607744Z" level=info msg="Daemon has completed initialization" Jul 6 23:41:52.001311 dockerd[1627]: time="2025-07-06T23:41:52.000697820Z" level=info msg="API listen on /run/docker.sock" Jul 6 23:41:52.000935 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 6 23:41:52.015423 sshd[1625]: Connection closed by 10.0.0.1 port 34006 Jul 6 23:41:52.015769 sshd-session[1623]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:52.033676 systemd[1]: sshd@6-10.0.0.129:22-10.0.0.1:34006.service: Deactivated successfully. Jul 6 23:41:52.035921 systemd[1]: session-7.scope: Deactivated successfully. Jul 6 23:41:52.037589 systemd-logind[1400]: Session 7 logged out. Waiting for processes to exit. Jul 6 23:41:52.046580 systemd[1]: Started sshd@7-10.0.0.129:22-10.0.0.1:34020.service - OpenSSH per-connection server daemon (10.0.0.1:34020). Jul 6 23:41:52.047474 systemd-logind[1400]: Removed session 7. Jul 6 23:41:52.107627 sshd[1833]: Accepted publickey for core from 10.0.0.1 port 34020 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:52.108844 sshd-session[1833]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:52.114435 systemd-logind[1400]: New session 8 of user core. Jul 6 23:41:52.124569 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 6 23:41:53.303393 containerd[1475]: time="2025-07-06T23:41:53.302493690Z" level=info msg="connecting to shim e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae" address="unix:///run/containerd/s/99d36b9d179e8490ac7a3e5ea99bb76d6f6e7d552851f76cedaa806ccd5d9d9c" namespace=moby protocol=ttrpc version=3 Jul 6 23:41:53.331570 systemd[1]: Started docker-e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae.scope - libcontainer container e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae. Jul 6 23:41:53.345161 systemd-resolved[1293]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 6 23:41:53.366822 kernel: docker0: port 1(vethd9b7421) entered blocking state Jul 6 23:41:53.366930 kernel: docker0: port 1(vethd9b7421) entered disabled state Jul 6 23:41:53.366947 kernel: vethd9b7421: entered allmulticast mode Jul 6 23:41:53.367751 kernel: vethd9b7421: entered promiscuous mode Jul 6 23:41:53.368134 systemd-networkd[1384]: vethd9b7421: Link UP Jul 6 23:41:53.379386 kernel: eth0: renamed from vethde86ad7 Jul 6 23:41:53.379493 kernel: docker0: port 1(vethd9b7421) entered blocking state Jul 6 23:41:53.380886 kernel: docker0: port 1(vethd9b7421) entered forwarding state Jul 6 23:41:53.381121 systemd-networkd[1384]: vethd9b7421: Gained carrier Jul 6 23:41:53.381572 systemd-networkd[1384]: docker0: Gained carrier Jul 6 23:41:53.411861 sshd[1835]: Connection closed by 10.0.0.1 port 34020 Jul 6 23:41:53.412228 sshd-session[1833]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:53.421753 systemd[1]: sshd@7-10.0.0.129:22-10.0.0.1:34020.service: Deactivated successfully. Jul 6 23:41:53.425411 systemd[1]: session-8.scope: Deactivated successfully. Jul 6 23:41:53.426126 systemd-logind[1400]: Session 8 logged out. Waiting for processes to exit. Jul 6 23:41:53.429117 systemd[1]: Started sshd@8-10.0.0.129:22-10.0.0.1:49864.service - OpenSSH per-connection server daemon (10.0.0.1:49864). Jul 6 23:41:53.431427 systemd-logind[1400]: Removed session 8. Jul 6 23:41:53.488875 sshd[1908]: Accepted publickey for core from 10.0.0.1 port 49864 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:53.490429 sshd-session[1908]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:53.495402 systemd-logind[1400]: New session 9 of user core. Jul 6 23:41:53.502555 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 6 23:41:53.560855 sshd[1910]: Connection closed by 10.0.0.1 port 49864 Jul 6 23:41:53.561856 sshd-session[1908]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:53.574725 systemd[1]: sshd@8-10.0.0.129:22-10.0.0.1:49864.service: Deactivated successfully. Jul 6 23:41:53.577034 systemd[1]: session-9.scope: Deactivated successfully. Jul 6 23:41:53.578002 systemd-logind[1400]: Session 9 logged out. Waiting for processes to exit. Jul 6 23:41:53.582771 systemd[1]: Started sshd@9-10.0.0.129:22-10.0.0.1:49870.service - OpenSSH per-connection server daemon (10.0.0.1:49870). Jul 6 23:41:53.583524 systemd-logind[1400]: Removed session 9. Jul 6 23:41:53.650932 sshd[1916]: Accepted publickey for core from 10.0.0.1 port 49870 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:53.651593 sshd-session[1916]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:53.660940 systemd-logind[1400]: New session 10 of user core. Jul 6 23:41:53.673636 systemd[1]: Started session-10.scope - Session 10 of User core. Jul 6 23:41:53.727565 sudo[1919]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1475 Jul 6 23:41:53.727843 sudo[1919]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 6 23:41:53.736063 sudo[1919]: pam_unix(sudo:session): session closed for user root Jul 6 23:41:53.736900 containerd[1475]: time="2025-07-06T23:41:53.736197603Z" level=info msg="Stop CRI service" Jul 6 23:41:53.736995 dockerd[1627]: time="2025-07-06T23:41:53.736384783Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 6 23:41:53.736995 dockerd[1627]: time="2025-07-06T23:41:53.736422179Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 6 23:41:53.736995 dockerd[1627]: time="2025-07-06T23:41:53.736694092Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 6 23:41:53.736995 dockerd[1627]: time="2025-07-06T23:41:53.736708761Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 6 23:41:53.737897 sshd[1918]: Connection closed by 10.0.0.1 port 49870 Jul 6 23:41:53.738441 sshd-session[1916]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:53.739784 containerd[1475]: time="2025-07-06T23:41:53.739714469Z" level=info msg="Stop CRI service" Jul 6 23:41:53.747553 systemd[1]: containerd.service: Deactivated successfully. Jul 6 23:41:53.747659 systemd[1]: containerd.service: Unit process 1859 (containerd-shim) remains running after unit stopped. Jul 6 23:41:53.747902 systemd[1]: containerd.service: Consumed 387ms CPU time, 135M memory peak. Jul 6 23:41:53.748317 systemd[1]: sshd@9-10.0.0.129:22-10.0.0.1:49870.service: Deactivated successfully. Jul 6 23:41:53.750068 systemd[1]: session-10.scope: Deactivated successfully. Jul 6 23:41:53.751481 systemd-logind[1400]: Session 10 logged out. Waiting for processes to exit. Jul 6 23:41:53.754999 systemd[1]: Started sshd@10-10.0.0.129:22-10.0.0.1:49886.service - OpenSSH per-connection server daemon (10.0.0.1:49886). Jul 6 23:41:53.755767 systemd-logind[1400]: Removed session 10. Jul 6 23:41:53.819861 sshd[1926]: Accepted publickey for core from 10.0.0.1 port 49886 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:53.820794 sshd-session[1926]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:41:53.825606 systemd-logind[1400]: New session 11 of user core. Jul 6 23:41:53.854477 systemd[1]: Started session-11.scope - Session 11 of User core. Jul 6 23:41:53.913905 sshd[1928]: Connection closed by 10.0.0.1 port 49886 Jul 6 23:41:53.914446 sshd-session[1926]: pam_unix(sshd:session): session closed for user core Jul 6 23:41:53.917747 systemd[1]: sshd@10-10.0.0.129:22-10.0.0.1:49886.service: Deactivated successfully. Jul 6 23:41:53.919503 systemd[1]: session-11.scope: Deactivated successfully. Jul 6 23:41:53.923325 systemd-logind[1400]: Session 11 logged out. Waiting for processes to exit. Jul 6 23:41:53.924564 systemd-logind[1400]: Removed session 11. Jul 6 23:41:54.637566 systemd-networkd[1384]: docker0: Gained IPv6LL Jul 6 23:41:54.829560 systemd-networkd[1384]: vethd9b7421: Gained IPv6LL Jul 6 23:41:58.998287 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Jul 6 23:41:58.998695 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 6 23:41:58.998909 dockerd[1627]: time="2025-07-06T23:41:58.998858173Z" level=info msg="Processing signal 'terminated'" Jul 6 23:41:59.945153 systemd[1]: Started sshd@11-10.0.0.129:22-10.0.0.1:49890.service - OpenSSH per-connection server daemon (10.0.0.1:49890). Jul 6 23:41:59.991236 sshd[1934]: Accepted publickey for core from 10.0.0.1 port 49890 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:41:59.992985 sshd-session[1934]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:00.000210 systemd-logind[1400]: New session 12 of user core. Jul 6 23:42:00.011564 systemd[1]: Started session-12.scope - Session 12 of User core. Jul 6 23:42:00.070571 sshd[1936]: Connection closed by 10.0.0.1 port 49890 Jul 6 23:42:00.070366 sshd-session[1934]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:00.074440 systemd[1]: sshd@11-10.0.0.129:22-10.0.0.1:49890.service: Deactivated successfully. Jul 6 23:42:00.076029 systemd[1]: session-12.scope: Deactivated successfully. Jul 6 23:42:00.081219 systemd-logind[1400]: Session 12 logged out. Waiting for processes to exit. Jul 6 23:42:00.085654 systemd-logind[1400]: Removed session 12. Jul 6 23:42:01.000286 dockerd[1627]: time="2025-07-06T23:42:01.000215029Z" level=error msg="Error sending stop (signal 15) to container" container=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae error="Cannot kill container e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\"" Jul 6 23:42:01.000286 dockerd[1627]: time="2025-07-06T23:42:01.000275026Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae Jul 6 23:42:06.093160 systemd[1]: Started sshd@12-10.0.0.129:22-10.0.0.1:45774.service - OpenSSH per-connection server daemon (10.0.0.1:45774). Jul 6 23:42:06.142656 sshd[1942]: Accepted publickey for core from 10.0.0.1 port 45774 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:06.144075 sshd-session[1942]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:06.148863 systemd-logind[1400]: New session 13 of user core. Jul 6 23:42:06.164572 systemd[1]: Started session-13.scope - Session 13 of User core. Jul 6 23:42:06.217528 sshd[1944]: Connection closed by 10.0.0.1 port 45774 Jul 6 23:42:06.219035 sshd-session[1942]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:06.225584 systemd[1]: sshd@12-10.0.0.129:22-10.0.0.1:45774.service: Deactivated successfully. Jul 6 23:42:06.227883 systemd[1]: session-13.scope: Deactivated successfully. Jul 6 23:42:06.228656 systemd-logind[1400]: Session 13 logged out. Waiting for processes to exit. Jul 6 23:42:06.232706 systemd-logind[1400]: Removed session 13. Jul 6 23:42:11.006211 dockerd[1627]: time="2025-07-06T23:42:11.002734393Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae error="context deadline exceeded" Jul 6 23:42:11.015552 systemd[1]: docker-e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae.scope: Deactivated successfully. Jul 6 23:42:12.235715 systemd[1]: Started sshd@13-10.0.0.129:22-10.0.0.1:45788.service - OpenSSH per-connection server daemon (10.0.0.1:45788). Jul 6 23:42:12.287654 sshd[1950]: Accepted publickey for core from 10.0.0.1 port 45788 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:12.290879 sshd-session[1950]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:12.296761 systemd-logind[1400]: New session 14 of user core. Jul 6 23:42:12.305569 systemd[1]: Started session-14.scope - Session 14 of User core. Jul 6 23:42:12.358829 sshd[1952]: Connection closed by 10.0.0.1 port 45788 Jul 6 23:42:12.359317 sshd-session[1950]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:12.362697 systemd-logind[1400]: Session 14 logged out. Waiting for processes to exit. Jul 6 23:42:12.363166 systemd[1]: sshd@13-10.0.0.129:22-10.0.0.1:45788.service: Deactivated successfully. Jul 6 23:42:12.365149 systemd[1]: session-14.scope: Deactivated successfully. Jul 6 23:42:12.367923 systemd-logind[1400]: Removed session 14. Jul 6 23:42:13.999204 dockerd[1627]: time="2025-07-06T23:42:13.999057064Z" level=error msg="Force shutdown daemon" Jul 6 23:42:13.999800 dockerd[1627]: time="2025-07-06T23:42:13.999633067Z" level=info msg="Daemon shutdown complete" Jul 6 23:42:14.002504 systemd[1]: docker.service: Deactivated successfully. Jul 6 23:42:14.002813 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 6 23:42:14.002867 systemd[1]: docker.service: Consumed 965ms CPU time, 131.1M memory peak. Jul 6 23:42:14.003704 systemd[1]: docker.socket: Deactivated successfully. Jul 6 23:42:14.004029 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 6 23:42:14.004063 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 6 23:42:14.006509 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 6 23:42:14.006658 systemd[1]: containerd.service: Found left-over process 1859 (containerd-shim) in control group while starting unit. Ignoring. Jul 6 23:42:14.006660 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 6 23:42:14.021254 systemd[1]: Starting containerd.service - containerd container runtime... Jul 6 23:42:14.021591 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 6 23:42:14.048091 systemd[1]: containerd.service: Found left-over process 1859 (containerd-shim) in control group while starting unit. Ignoring. Jul 6 23:42:14.048102 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 6 23:42:14.052834 (ntainerd)[1962]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 6 23:42:14.070969 containerd[1962]: time="2025-07-06T23:42:14Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Jul 6 23:42:14.071708 containerd[1962]: time="2025-07-06T23:42:14.071661525Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 6 23:42:14.080186 containerd[1962]: time="2025-07-06T23:42:14.079857626Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="10.325µs" Jul 6 23:42:14.080186 containerd[1962]: time="2025-07-06T23:42:14.079896007Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 6 23:42:14.080186 containerd[1962]: time="2025-07-06T23:42:14.079913056Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 6 23:42:14.080186 containerd[1962]: time="2025-07-06T23:42:14.079953157Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 6 23:42:14.080186 containerd[1962]: time="2025-07-06T23:42:14.079965203Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 6 23:42:14.080563 containerd[1962]: time="2025-07-06T23:42:14.080524656Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 6 23:42:14.080607 containerd[1962]: time="2025-07-06T23:42:14.080588450Z" 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 6 23:42:14.080607 containerd[1962]: time="2025-07-06T23:42:14.080601377Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081257 containerd[1962]: time="2025-07-06T23:42:14.081194648Z" 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 6 23:42:14.081257 containerd[1962]: time="2025-07-06T23:42:14.081250597Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081336 containerd[1962]: time="2025-07-06T23:42:14.081273289Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081385 containerd[1962]: time="2025-07-06T23:42:14.081336843Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081467 containerd[1962]: time="2025-07-06T23:42:14.081444779Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081730 containerd[1962]: time="2025-07-06T23:42:14.081697952Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 6 23:42:14.081819 containerd[1962]: time="2025-07-06T23:42:14.081772992Z" 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 6 23:42:14.081848 containerd[1962]: time="2025-07-06T23:42:14.081814213Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 6 23:42:14.081932 containerd[1962]: time="2025-07-06T23:42:14.081887732Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 6 23:42:14.082619 containerd[1962]: time="2025-07-06T23:42:14.082417410Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 6 23:42:14.082619 containerd[1962]: time="2025-07-06T23:42:14.082464474Z" level=info msg="metadata content store policy set" policy=shared Jul 6 23:42:14.082619 containerd[1962]: time="2025-07-06T23:42:14.082601586Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 6 23:42:14.082730 containerd[1962]: time="2025-07-06T23:42:14.082652293Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 6 23:42:14.082730 containerd[1962]: time="2025-07-06T23:42:14.082671463Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 6 23:42:14.082730 containerd[1962]: time="2025-07-06T23:42:14.082683950Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 6 23:42:14.082730 containerd[1962]: time="2025-07-06T23:42:14.082707842Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 6 23:42:14.082730 containerd[1962]: time="2025-07-06T23:42:14.082722890Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082738418Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082754747Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082766593Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082780440Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082793087Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 6 23:42:14.082848 containerd[1962]: time="2025-07-06T23:42:14.082808695Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 6 23:42:14.083080 containerd[1962]: time="2025-07-06T23:42:14.083053824Z" level=info msg="connecting to shim e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae" address="unix:///run/containerd/s/99d36b9d179e8490ac7a3e5ea99bb76d6f6e7d552851f76cedaa806ccd5d9d9c" namespace=moby protocol=ttrpc version=3 Jul 6 23:42:14.090234 containerd[1962]: time="2025-07-06T23:42:14.090186167Z" level=info msg="cleaning leaked shim process" id=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae namespace=moby Jul 6 23:42:14.102532 containerd[1962]: time="2025-07-06T23:42:14.102466371Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 6 23:42:14.104325 containerd[1962]: time="2025-07-06T23:42:14.104149854Z" level=info msg="shim disconnected" id=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae namespace=moby Jul 6 23:42:14.104325 containerd[1962]: time="2025-07-06T23:42:14.104279322Z" level=warning msg="cleaning up after shim disconnected" id=e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae namespace=moby Jul 6 23:42:14.104671 containerd[1962]: time="2025-07-06T23:42:14.104489513Z" level=info msg="cleaning up dead shim" namespace=moby Jul 6 23:42:14.117250 containerd[1962]: time="2025-07-06T23:42:14.116931122Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 6 23:42:14.117250 containerd[1962]: time="2025-07-06T23:42:14.117158801Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117486253Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117519110Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117559891Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117573659Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117588707Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117606916Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117618162Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117638012Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117652020Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117664226Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117741667Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117759556Z" level=info msg="Start snapshots syncer" Jul 6 23:42:14.118462 containerd[1962]: time="2025-07-06T23:42:14.117797336Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 6 23:42:14.118759 containerd[1962]: time="2025-07-06T23:42:14.118046347Z" 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 6 23:42:14.118759 containerd[1962]: time="2025-07-06T23:42:14.118109180Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118190422Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118256657Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118277908Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118288034Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118302121Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118315008Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118336059Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118404495Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118457002Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118471130Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118483736Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118517914Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118532922Z" 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 6 23:42:14.118842 containerd[1962]: time="2025-07-06T23:42:14.118542487Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118552212Z" 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 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118561097Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118576345Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118587231Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118603319Z" level=info msg="runtime interface created" Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118608762Z" level=info msg="created NRI interface" Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118617727Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118629133Z" level=info msg="Connect containerd service" Jul 6 23:42:14.119095 containerd[1962]: time="2025-07-06T23:42:14.118661830Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 6 23:42:14.119303 containerd[1962]: time="2025-07-06T23:42:14.119209437Z" 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 6 23:42:14.129583 containerd[1962]: time="2025-07-06T23:42:14.129250546Z" level=info msg="Start subscribing containerd event" Jul 6 23:42:14.129583 containerd[1962]: time="2025-07-06T23:42:14.129554066Z" level=info msg="Start recovering state" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129844778Z" level=info msg="Start event monitor" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129870112Z" level=info msg="Start cni network conf syncer for default" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129878636Z" level=info msg="Start streaming server" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129887120Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129900768Z" level=info msg="runtime interface starting up..." Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129908051Z" level=info msg="starting plugins..." Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.129916656Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.130188599Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 6 23:42:14.131565 containerd[1962]: time="2025-07-06T23:42:14.130224858Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 6 23:42:14.135817 containerd[1962]: time="2025-07-06T23:42:14.135103778Z" level=info msg="containerd successfully booted in 0.064388s" Jul 6 23:42:14.135204 systemd[1]: Started containerd.service - containerd container runtime. Jul 6 23:42:14.137568 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 6 23:42:14.147750 (dockerd)[2008]: 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 6 23:42:14.181728 dockerd[2008]: time="2025-07-06T23:42:14.181110361Z" level=info msg="Starting up" Jul 6 23:42:14.182505 dockerd[2008]: time="2025-07-06T23:42:14.182470475Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 6 23:42:14.219493 dockerd[2008]: time="2025-07-06T23:42:14.219452362Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 6 23:42:14.226892 dockerd[2008]: time="2025-07-06T23:42:14.226841960Z" level=info msg="Loading containers: start." Jul 6 23:42:14.239482 systemd[1]: var-lib-docker-overlay2-1b294f306b509efe2d7c5c5af78d0995bbd3b37b07785017a782012cbdf7dda4-merged.mount: Deactivated successfully. Jul 6 23:42:14.599767 kernel: docker0: port 1(vethd9b7421) entered disabled state Jul 6 23:42:14.599458 systemd-networkd[1384]: vethd9b7421: Link DOWN Jul 6 23:42:14.599461 systemd-networkd[1384]: vethd9b7421: Lost carrier Jul 6 23:42:14.604217 kernel: vethd9b7421 (unregistering): left allmulticast mode Jul 6 23:42:14.604311 kernel: vethd9b7421 (unregistering): left promiscuous mode Jul 6 23:42:14.604357 kernel: docker0: port 1(vethd9b7421) entered disabled state Jul 6 23:42:14.612695 systemd-networkd[1384]: docker0: Lost carrier Jul 6 23:42:14.613173 dockerd[2008]: time="2025-07-06T23:42:14.613111662Z" level=info msg="Removing stale sandbox 8561e0afc0d4431b8ecc32978428684a7716635f6b68bc396a7017dc5bc0678c (e86b0524f09e6705aaeb5f6eed395d346399425722c60d3cd5236d6f10c54bae)" Jul 6 23:42:14.616026 dockerd[2008]: time="2025-07-06T23:42:14.615950672Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 6 23:42:14.616100 dockerd[2008]: time="2025-07-06T23:42:14.616032795Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint b2a3f4022c992e1e00f86ed9709fe27da1d99f1709bea27aa5202e3d41fc5d25 dcbf09e6362a23bb34bfbe80ef12110a2d64a81eb1cc2a56fbd416d524dca496], retrying...." Jul 6 23:42:14.836290 dockerd[2008]: time="2025-07-06T23:42:14.836228868Z" level=warning msg="error locating sandbox id 8561e0afc0d4431b8ecc32978428684a7716635f6b68bc396a7017dc5bc0678c: sandbox 8561e0afc0d4431b8ecc32978428684a7716635f6b68bc396a7017dc5bc0678c not found" Jul 6 23:42:14.836438 dockerd[2008]: time="2025-07-06T23:42:14.836404320Z" level=info msg="Loading containers: done." Jul 6 23:42:14.847660 dockerd[2008]: time="2025-07-06T23:42:14.847604277Z" 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 6 23:42:14.847809 dockerd[2008]: time="2025-07-06T23:42:14.847686080Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 6 23:42:14.847809 dockerd[2008]: time="2025-07-06T23:42:14.847724340Z" level=info msg="Initializing buildkit" Jul 6 23:42:14.859709 dockerd[2008]: time="2025-07-06T23:42:14.859553268Z" level=info msg="Completed buildkit initialization" Jul 6 23:42:14.867289 dockerd[2008]: time="2025-07-06T23:42:14.867235939Z" level=info msg="Daemon has completed initialization" Jul 6 23:42:14.867819 dockerd[2008]: time="2025-07-06T23:42:14.867401226Z" level=info msg="API listen on /run/docker.sock" Jul 6 23:42:14.867476 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 6 23:42:15.199478 systemd[1]: run-docker-netns-8561e0afc0d4.mount: Deactivated successfully. Jul 6 23:42:18.385932 systemd[1]: Started sshd@14-10.0.0.129:22-10.0.0.1:43734.service - OpenSSH per-connection server daemon (10.0.0.1:43734). Jul 6 23:42:18.446357 sshd[2229]: Accepted publickey for core from 10.0.0.1 port 43734 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:18.448002 sshd-session[2229]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:18.452996 systemd-logind[1400]: New session 15 of user core. Jul 6 23:42:18.456555 systemd[1]: Started session-15.scope - Session 15 of User core. Jul 6 23:42:18.510768 sshd[2231]: Connection closed by 10.0.0.1 port 43734 Jul 6 23:42:18.511199 sshd-session[2229]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:18.532309 systemd[1]: sshd@14-10.0.0.129:22-10.0.0.1:43734.service: Deactivated successfully. Jul 6 23:42:18.539378 systemd[1]: session-15.scope: Deactivated successfully. Jul 6 23:42:18.541544 systemd-logind[1400]: Session 15 logged out. Waiting for processes to exit. Jul 6 23:42:18.544648 systemd[1]: Started sshd@15-10.0.0.129:22-10.0.0.1:43748.service - OpenSSH per-connection server daemon (10.0.0.1:43748). Jul 6 23:42:18.546091 systemd-logind[1400]: Removed session 15. Jul 6 23:42:18.594108 sshd[2237]: Accepted publickey for core from 10.0.0.1 port 43748 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:18.595328 sshd-session[2237]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:18.601803 systemd-logind[1400]: New session 16 of user core. Jul 6 23:42:18.606554 systemd[1]: Started session-16.scope - Session 16 of User core. Jul 6 23:42:18.663390 sshd[2239]: Connection closed by 10.0.0.1 port 43748 Jul 6 23:42:18.663512 sshd-session[2237]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:18.676270 systemd[1]: sshd@15-10.0.0.129:22-10.0.0.1:43748.service: Deactivated successfully. Jul 6 23:42:18.680332 systemd[1]: session-16.scope: Deactivated successfully. Jul 6 23:42:18.682553 systemd-logind[1400]: Session 16 logged out. Waiting for processes to exit. Jul 6 23:42:18.687609 systemd[1]: Started sshd@16-10.0.0.129:22-10.0.0.1:43754.service - OpenSSH per-connection server daemon (10.0.0.1:43754). Jul 6 23:42:18.688743 systemd-logind[1400]: Removed session 16. Jul 6 23:42:18.749226 sshd[2245]: Accepted publickey for core from 10.0.0.1 port 43754 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:18.750165 sshd-session[2245]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:18.754455 systemd-logind[1400]: New session 17 of user core. Jul 6 23:42:18.765502 systemd[1]: Started session-17.scope - Session 17 of User core. Jul 6 23:42:18.822655 sshd[2247]: Connection closed by 10.0.0.1 port 43754 Jul 6 23:42:18.823484 sshd-session[2245]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:18.833192 systemd[1]: sshd@16-10.0.0.129:22-10.0.0.1:43754.service: Deactivated successfully. Jul 6 23:42:18.835293 systemd[1]: session-17.scope: Deactivated successfully. Jul 6 23:42:18.836544 systemd-logind[1400]: Session 17 logged out. Waiting for processes to exit. Jul 6 23:42:18.838358 systemd[1]: Started sshd@17-10.0.0.129:22-10.0.0.1:43766.service - OpenSSH per-connection server daemon (10.0.0.1:43766). Jul 6 23:42:18.839175 systemd-logind[1400]: Removed session 17. Jul 6 23:42:18.900308 sshd[2260]: Accepted publickey for core from 10.0.0.1 port 43766 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:18.901523 sshd-session[2260]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:18.905120 systemd-logind[1400]: New session 18 of user core. Jul 6 23:42:18.916509 systemd[1]: Started session-18.scope - Session 18 of User core. Jul 6 23:42:19.026776 containerd[1962]: time="2025-07-06T23:42:19.025603797Z" level=info msg="connecting to shim 52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5" address="unix:///run/containerd/s/04ba544a80f0e9d0e6ae8a6cf443f6f334d21f3019b9b227e648878c6558b3ee" namespace=moby protocol=ttrpc version=3 Jul 6 23:42:19.053520 systemd[1]: Started docker-52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5.scope - libcontainer container 52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5. Jul 6 23:42:19.066592 systemd-resolved[1293]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 6 23:42:19.083990 kernel: docker0: port 1(veth5de5933) entered blocking state Jul 6 23:42:19.084065 kernel: docker0: port 1(veth5de5933) entered disabled state Jul 6 23:42:19.084657 kernel: veth5de5933: entered allmulticast mode Jul 6 23:42:19.085431 kernel: veth5de5933: entered promiscuous mode Jul 6 23:42:19.085663 systemd-networkd[1384]: veth5de5933: Link UP Jul 6 23:42:19.092515 kernel: eth0: renamed from veth1115da0 Jul 6 23:42:19.092562 kernel: docker0: port 1(veth5de5933) entered blocking state Jul 6 23:42:19.092584 kernel: docker0: port 1(veth5de5933) entered forwarding state Jul 6 23:42:19.093485 systemd-networkd[1384]: veth5de5933: Gained carrier Jul 6 23:42:19.093656 systemd-networkd[1384]: docker0: Gained carrier Jul 6 23:42:19.118085 sshd[2262]: Connection closed by 10.0.0.1 port 43766 Jul 6 23:42:19.118606 sshd-session[2260]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:19.131473 systemd[1]: sshd@17-10.0.0.129:22-10.0.0.1:43766.service: Deactivated successfully. Jul 6 23:42:19.132919 systemd[1]: session-18.scope: Deactivated successfully. Jul 6 23:42:19.133613 systemd-logind[1400]: Session 18 logged out. Waiting for processes to exit. Jul 6 23:42:19.136088 systemd[1]: Started sshd@18-10.0.0.129:22-10.0.0.1:43776.service - OpenSSH per-connection server daemon (10.0.0.1:43776). Jul 6 23:42:19.137420 systemd-logind[1400]: Removed session 18. Jul 6 23:42:19.186789 sshd[2331]: Accepted publickey for core from 10.0.0.1 port 43776 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:19.188414 sshd-session[2331]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:19.193129 systemd-logind[1400]: New session 19 of user core. Jul 6 23:42:19.203539 systemd[1]: Started session-19.scope - Session 19 of User core. Jul 6 23:42:19.255961 sshd[2333]: Connection closed by 10.0.0.1 port 43776 Jul 6 23:42:19.256416 sshd-session[2331]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:19.274411 systemd[1]: sshd@18-10.0.0.129:22-10.0.0.1:43776.service: Deactivated successfully. Jul 6 23:42:19.276775 systemd[1]: session-19.scope: Deactivated successfully. Jul 6 23:42:19.279408 systemd-logind[1400]: Session 19 logged out. Waiting for processes to exit. Jul 6 23:42:19.280882 systemd[1]: Started sshd@19-10.0.0.129:22-10.0.0.1:43790.service - OpenSSH per-connection server daemon (10.0.0.1:43790). Jul 6 23:42:19.281644 systemd-logind[1400]: Removed session 19. Jul 6 23:42:19.330648 sshd[2339]: Accepted publickey for core from 10.0.0.1 port 43790 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:19.331847 sshd-session[2339]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:19.336481 systemd-logind[1400]: New session 20 of user core. Jul 6 23:42:19.347584 systemd[1]: Started session-20.scope - Session 20 of User core. Jul 6 23:42:19.399221 sudo[2342]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1962 Jul 6 23:42:19.399879 sudo[2342]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 6 23:42:19.402960 sudo[2342]: pam_unix(sudo:session): session closed for user root Jul 6 23:42:19.404561 sshd[2341]: Connection closed by 10.0.0.1 port 43790 Jul 6 23:42:19.404962 sshd-session[2339]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:19.405852 dockerd[2008]: time="2025-07-06T23:42:19.405809910Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Jul 6 23:42:19.405852 dockerd[2008]: time="2025-07-06T23:42:19.405845364Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Jul 6 23:42:19.406477 dockerd[2008]: time="2025-07-06T23:42:19.406036036Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Jul 6 23:42:19.406477 dockerd[2008]: time="2025-07-06T23:42:19.406061046Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Jul 6 23:42:19.417257 systemd[1]: containerd.service: Deactivated successfully. Jul 6 23:42:19.417390 systemd[1]: containerd.service: Unit process 2281 (containerd-shim) remains running after unit stopped. Jul 6 23:42:19.417615 systemd[1]: containerd.service: Consumed 154ms CPU time, 136M memory peak. Jul 6 23:42:19.417975 systemd[1]: sshd@19-10.0.0.129:22-10.0.0.1:43790.service: Deactivated successfully. Jul 6 23:42:19.419387 systemd[1]: session-20.scope: Deactivated successfully. Jul 6 23:42:19.419987 systemd-logind[1400]: Session 20 logged out. Waiting for processes to exit. Jul 6 23:42:19.422834 systemd[1]: Started sshd@20-10.0.0.129:22-10.0.0.1:43802.service - OpenSSH per-connection server daemon (10.0.0.1:43802). Jul 6 23:42:19.423259 systemd-logind[1400]: Removed session 20. Jul 6 23:42:19.483061 sshd[2349]: Accepted publickey for core from 10.0.0.1 port 43802 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:19.484515 sshd-session[2349]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:19.489318 systemd-logind[1400]: New session 21 of user core. Jul 6 23:42:19.494550 systemd[1]: Started session-21.scope - Session 21 of User core. Jul 6 23:42:19.548090 sshd[2351]: Connection closed by 10.0.0.1 port 43802 Jul 6 23:42:19.548545 sshd-session[2349]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:19.551505 systemd[1]: sshd@20-10.0.0.129:22-10.0.0.1:43802.service: Deactivated successfully. Jul 6 23:42:19.552963 systemd[1]: session-21.scope: Deactivated successfully. Jul 6 23:42:19.554949 systemd-logind[1400]: Session 21 logged out. Waiting for processes to exit. Jul 6 23:42:19.556073 systemd-logind[1400]: Removed session 21. Jul 6 23:42:20.237753 systemd-networkd[1384]: veth5de5933: Gained IPv6LL Jul 6 23:42:24.592602 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Jul 6 23:42:24.592948 systemd[1]: Stopping docker.service - Docker Application Container Engine... Jul 6 23:42:24.593077 dockerd[2008]: time="2025-07-06T23:42:24.593039035Z" level=info msg="Processing signal 'terminated'" Jul 6 23:42:25.565560 systemd[1]: Started sshd@21-10.0.0.129:22-10.0.0.1:41750.service - OpenSSH per-connection server daemon (10.0.0.1:41750). Jul 6 23:42:25.622663 sshd[2357]: Accepted publickey for core from 10.0.0.1 port 41750 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:25.626855 sshd-session[2357]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:25.631401 systemd-logind[1400]: New session 22 of user core. Jul 6 23:42:25.641516 systemd[1]: Started session-22.scope - Session 22 of User core. Jul 6 23:42:25.695777 sshd[2359]: Connection closed by 10.0.0.1 port 41750 Jul 6 23:42:25.696253 sshd-session[2357]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:25.699664 systemd[1]: sshd@21-10.0.0.129:22-10.0.0.1:41750.service: Deactivated successfully. Jul 6 23:42:25.701188 systemd[1]: session-22.scope: Deactivated successfully. Jul 6 23:42:25.708657 systemd-logind[1400]: Session 22 logged out. Waiting for processes to exit. Jul 6 23:42:25.710079 systemd-logind[1400]: Removed session 22. Jul 6 23:42:26.595027 dockerd[2008]: time="2025-07-06T23:42:26.594936870Z" level=error msg="Error sending stop (signal 15) to container" container=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 error="Cannot kill container 52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\"" Jul 6 23:42:26.595027 dockerd[2008]: time="2025-07-06T23:42:26.595002686Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 Jul 6 23:42:27.448414 update_engine[1404]: I20250706 23:42:27.448240 1404 update_attempter.cc:509] Updating boot flags... Jul 6 23:42:31.721684 systemd[1]: Started sshd@22-10.0.0.129:22-10.0.0.1:41760.service - OpenSSH per-connection server daemon (10.0.0.1:41760). Jul 6 23:42:31.783219 sshd[2383]: Accepted publickey for core from 10.0.0.1 port 41760 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:31.784850 sshd-session[2383]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:31.789873 systemd-logind[1400]: New session 23 of user core. Jul 6 23:42:31.803580 systemd[1]: Started session-23.scope - Session 23 of User core. Jul 6 23:42:31.857606 sshd[2385]: Connection closed by 10.0.0.1 port 41760 Jul 6 23:42:31.857957 sshd-session[2383]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:31.861297 systemd[1]: sshd@22-10.0.0.129:22-10.0.0.1:41760.service: Deactivated successfully. Jul 6 23:42:31.862993 systemd[1]: session-23.scope: Deactivated successfully. Jul 6 23:42:31.863773 systemd-logind[1400]: Session 23 logged out. Waiting for processes to exit. Jul 6 23:42:31.865018 systemd-logind[1400]: Removed session 23. Jul 6 23:42:36.596317 dockerd[2008]: time="2025-07-06T23:42:36.596209973Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 error="context deadline exceeded" Jul 6 23:42:36.597168 systemd[1]: docker-52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5.scope: Deactivated successfully. Jul 6 23:42:37.873248 systemd[1]: Started sshd@23-10.0.0.129:22-10.0.0.1:45886.service - OpenSSH per-connection server daemon (10.0.0.1:45886). Jul 6 23:42:37.915733 sshd[2391]: Accepted publickey for core from 10.0.0.1 port 45886 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:37.916907 sshd-session[2391]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:37.920332 systemd-logind[1400]: New session 24 of user core. Jul 6 23:42:37.928500 systemd[1]: Started session-24.scope - Session 24 of User core. Jul 6 23:42:37.979865 sshd[2393]: Connection closed by 10.0.0.1 port 45886 Jul 6 23:42:37.980157 sshd-session[2391]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:37.983439 systemd[1]: sshd@23-10.0.0.129:22-10.0.0.1:45886.service: Deactivated successfully. Jul 6 23:42:37.984797 systemd[1]: session-24.scope: Deactivated successfully. Jul 6 23:42:37.987232 systemd-logind[1400]: Session 24 logged out. Waiting for processes to exit. Jul 6 23:42:37.988161 systemd-logind[1400]: Removed session 24. Jul 6 23:42:39.593392 dockerd[2008]: time="2025-07-06T23:42:39.593294552Z" level=error msg="Force shutdown daemon" Jul 6 23:42:39.593830 dockerd[2008]: time="2025-07-06T23:42:39.593420245Z" level=info msg="Daemon shutdown complete" Jul 6 23:42:39.593830 dockerd[2008]: time="2025-07-06T23:42:39.593539378Z" 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 6 23:42:39.593830 dockerd[2008]: time="2025-07-06T23:42:39.593568101Z" level=info msg="stopping event stream following graceful shutdown" error="context canceled" module=libcontainerd namespace=plugins.moby Jul 6 23:42:39.597677 systemd[1]: docker.service: Deactivated successfully. Jul 6 23:42:39.599422 systemd[1]: Stopped docker.service - Docker Application Container Engine. Jul 6 23:42:39.599889 systemd[1]: docker.socket: Deactivated successfully. Jul 6 23:42:39.600139 systemd[1]: Closed docker.socket - Docker Socket for the API. Jul 6 23:42:39.600176 systemd[1]: Stopping docker.socket - Docker Socket for the API... Jul 6 23:42:39.601620 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 6 23:42:39.601788 systemd[1]: containerd.service: Found left-over process 2281 (containerd-shim) in control group while starting unit. Ignoring. Jul 6 23:42:39.601795 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 6 23:42:39.607933 systemd[1]: Starting containerd.service - containerd container runtime... Jul 6 23:42:39.608312 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 6 23:42:39.618757 systemd[1]: containerd.service: Found left-over process 2281 (containerd-shim) in control group while starting unit. Ignoring. Jul 6 23:42:39.618766 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Jul 6 23:42:39.622790 (ntainerd)[2404]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 6 23:42:39.635090 containerd[2404]: time="2025-07-06T23:42:39Z" 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 6 23:42:39.635597 containerd[2404]: time="2025-07-06T23:42:39.635565733Z" level=info msg="starting containerd" revision=06b99ca80cdbfbc6cc8bd567021738c9af2b36ce version=v2.0.4 Jul 6 23:42:39.643707 containerd[2404]: time="2025-07-06T23:42:39.643666980Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="9.601µs" Jul 6 23:42:39.643840 containerd[2404]: time="2025-07-06T23:42:39.643824356Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 6 23:42:39.643900 containerd[2404]: time="2025-07-06T23:42:39.643888483Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 6 23:42:39.643986 containerd[2404]: time="2025-07-06T23:42:39.643973012Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 6 23:42:39.644038 containerd[2404]: time="2025-07-06T23:42:39.644025737Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 6 23:42:39.644271 containerd[2404]: time="2025-07-06T23:42:39.644252281Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 6 23:42:39.644374 containerd[2404]: time="2025-07-06T23:42:39.644340250Z" 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 6 23:42:39.644446 containerd[2404]: time="2025-07-06T23:42:39.644432340Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 6 23:42:39.644724 containerd[2404]: time="2025-07-06T23:42:39.644704769Z" 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 6 23:42:39.644801 containerd[2404]: time="2025-07-06T23:42:39.644775216Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:42:39.644863 containerd[2404]: time="2025-07-06T23:42:39.644848944Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 6 23:42:39.644912 containerd[2404]: time="2025-07-06T23:42:39.644899989Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 6 23:42:39.644985 containerd[2404]: time="2025-07-06T23:42:39.644972597Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 6 23:42:39.645121 containerd[2404]: time="2025-07-06T23:42:39.645106931Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 6 23:42:39.645193 containerd[2404]: time="2025-07-06T23:42:39.645177858Z" 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 6 23:42:39.645245 containerd[2404]: time="2025-07-06T23:42:39.645232024Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 6 23:42:39.645333 containerd[2404]: time="2025-07-06T23:42:39.645317593Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 6 23:42:39.645643 containerd[2404]: time="2025-07-06T23:42:39.645625505Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 6 23:42:39.645730 containerd[2404]: time="2025-07-06T23:42:39.645717314Z" level=info msg="metadata content store policy set" policy=shared Jul 6 23:42:39.645913 containerd[2404]: time="2025-07-06T23:42:39.645896813Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 6 23:42:39.646004 containerd[2404]: time="2025-07-06T23:42:39.645990863Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 6 23:42:39.646063 containerd[2404]: time="2025-07-06T23:42:39.646049789Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 6 23:42:39.646120 containerd[2404]: time="2025-07-06T23:42:39.646107915Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 6 23:42:39.646169 containerd[2404]: time="2025-07-06T23:42:39.646157800Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 6 23:42:39.646224 containerd[2404]: time="2025-07-06T23:42:39.646212726Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 6 23:42:39.646274 containerd[2404]: time="2025-07-06T23:42:39.646262891Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 6 23:42:39.646326 containerd[2404]: time="2025-07-06T23:42:39.646314097Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 6 23:42:39.646405 containerd[2404]: time="2025-07-06T23:42:39.646387785Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 6 23:42:39.646454 containerd[2404]: time="2025-07-06T23:42:39.646442870Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 6 23:42:39.646513 containerd[2404]: time="2025-07-06T23:42:39.646501276Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 6 23:42:39.646565 containerd[2404]: time="2025-07-06T23:42:39.646554002Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 6 23:42:39.646833 containerd[2404]: time="2025-07-06T23:42:39.646813629Z" level=info msg="connecting to shim 52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5" address="unix:///run/containerd/s/04ba544a80f0e9d0e6ae8a6cf443f6f334d21f3019b9b227e648878c6558b3ee" namespace=moby protocol=ttrpc version=3 Jul 6 23:42:39.653075 containerd[2404]: time="2025-07-06T23:42:39.653051401Z" level=info msg="cleaning leaked shim process" id=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 namespace=moby Jul 6 23:42:39.661119 containerd[2404]: time="2025-07-06T23:42:39.661087922Z" level=info msg="shim disconnected" id=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 namespace=moby Jul 6 23:42:39.661226 containerd[2404]: time="2025-07-06T23:42:39.661112884Z" level=warning msg="cleaning up after shim disconnected" id=52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5 namespace=moby Jul 6 23:42:39.661226 containerd[2404]: time="2025-07-06T23:42:39.661191493Z" level=info msg="cleaning up dead shim" namespace=moby Jul 6 23:42:39.661310 containerd[2404]: time="2025-07-06T23:42:39.660919784Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Jul 6 23:42:39.670915 containerd[2404]: time="2025-07-06T23:42:39.670849983Z" level=error msg="copy shim log after reload" error="read /proc/self/fd/7: file already closed" namespace=moby Jul 6 23:42:39.671053 containerd[2404]: time="2025-07-06T23:42:39.671021441Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 6 23:42:39.671079 containerd[2404]: time="2025-07-06T23:42:39.671067765Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 6 23:42:39.671103 containerd[2404]: time="2025-07-06T23:42:39.671087127Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 6 23:42:39.671103 containerd[2404]: time="2025-07-06T23:42:39.671099289Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 6 23:42:39.671143 containerd[2404]: time="2025-07-06T23:42:39.671111850Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 6 23:42:39.671143 containerd[2404]: time="2025-07-06T23:42:39.671124251Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 6 23:42:39.671143 containerd[2404]: time="2025-07-06T23:42:39.671139653Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 6 23:42:39.671199 containerd[2404]: time="2025-07-06T23:42:39.671152694Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 6 23:42:39.671199 containerd[2404]: time="2025-07-06T23:42:39.671166016Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 6 23:42:39.671199 containerd[2404]: time="2025-07-06T23:42:39.671179577Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 6 23:42:39.671199 containerd[2404]: time="2025-07-06T23:42:39.671191418Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 6 23:42:39.671268 containerd[2404]: time="2025-07-06T23:42:39.671258105Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 6 23:42:39.671289 containerd[2404]: time="2025-07-06T23:42:39.671273427Z" level=info msg="Start snapshots syncer" Jul 6 23:42:39.671310 containerd[2404]: time="2025-07-06T23:42:39.671297429Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 6 23:42:39.671659 containerd[2404]: time="2025-07-06T23:42:39.671621903Z" 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 6 23:42:39.671747 containerd[2404]: time="2025-07-06T23:42:39.671690831Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 6 23:42:39.671776 containerd[2404]: time="2025-07-06T23:42:39.671761878Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 6 23:42:39.671823 containerd[2404]: time="2025-07-06T23:42:39.671811323Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 6 23:42:39.671854 containerd[2404]: time="2025-07-06T23:42:39.671840166Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 6 23:42:39.671854 containerd[2404]: time="2025-07-06T23:42:39.671851327Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 6 23:42:39.671892 containerd[2404]: time="2025-07-06T23:42:39.671861008Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 6 23:42:39.671892 containerd[2404]: time="2025-07-06T23:42:39.671872570Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 6 23:42:39.671892 containerd[2404]: time="2025-07-06T23:42:39.671883011Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 6 23:42:39.671940 containerd[2404]: time="2025-07-06T23:42:39.671893132Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 6 23:42:39.671940 containerd[2404]: time="2025-07-06T23:42:39.671920455Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 6 23:42:39.671940 containerd[2404]: time="2025-07-06T23:42:39.671930696Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 6 23:42:39.671994 containerd[2404]: time="2025-07-06T23:42:39.671941137Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 6 23:42:39.671994 containerd[2404]: time="2025-07-06T23:42:39.671971020Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 6 23:42:39.671994 containerd[2404]: time="2025-07-06T23:42:39.671985301Z" 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 6 23:42:39.672059 containerd[2404]: time="2025-07-06T23:42:39.671994542Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 6 23:42:39.672059 containerd[2404]: time="2025-07-06T23:42:39.672004903Z" 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 6 23:42:39.672059 containerd[2404]: time="2025-07-06T23:42:39.672013504Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 6 23:42:39.672059 containerd[2404]: time="2025-07-06T23:42:39.672039427Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 6 23:42:39.672059 containerd[2404]: time="2025-07-06T23:42:39.672051148Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 6 23:42:39.672156 containerd[2404]: time="2025-07-06T23:42:39.672067070Z" level=info msg="runtime interface created" Jul 6 23:42:39.672156 containerd[2404]: time="2025-07-06T23:42:39.672071750Z" level=info msg="created NRI interface" Jul 6 23:42:39.672156 containerd[2404]: time="2025-07-06T23:42:39.672079911Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 6 23:42:39.672156 containerd[2404]: time="2025-07-06T23:42:39.672090072Z" level=info msg="Connect containerd service" Jul 6 23:42:39.672156 containerd[2404]: time="2025-07-06T23:42:39.672113835Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 6 23:42:39.672730 containerd[2404]: time="2025-07-06T23:42:39.672702376Z" 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 6 23:42:39.681541 containerd[2404]: time="2025-07-06T23:42:39.681499976Z" level=info msg="Start subscribing containerd event" Jul 6 23:42:39.681677 containerd[2404]: time="2025-07-06T23:42:39.681561863Z" level=info msg="Start recovering state" Jul 6 23:42:39.681677 containerd[2404]: time="2025-07-06T23:42:39.681634951Z" level=info msg="Start event monitor" Jul 6 23:42:39.681677 containerd[2404]: time="2025-07-06T23:42:39.681647952Z" level=info msg="Start cni network conf syncer for default" Jul 6 23:42:39.681677 containerd[2404]: time="2025-07-06T23:42:39.681655193Z" level=info msg="Start streaming server" Jul 6 23:42:39.681677 containerd[2404]: time="2025-07-06T23:42:39.681676515Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 6 23:42:39.681912 containerd[2404]: time="2025-07-06T23:42:39.681688116Z" level=info msg="runtime interface starting up..." Jul 6 23:42:39.681912 containerd[2404]: time="2025-07-06T23:42:39.681695997Z" level=info msg="starting plugins..." Jul 6 23:42:39.681912 containerd[2404]: time="2025-07-06T23:42:39.681706238Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 6 23:42:39.681975 containerd[2404]: time="2025-07-06T23:42:39.681945263Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 6 23:42:39.681999 containerd[2404]: time="2025-07-06T23:42:39.681984187Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 6 23:42:39.682049 containerd[2404]: time="2025-07-06T23:42:39.682029552Z" level=info msg="containerd successfully booted in 0.047104s" Jul 6 23:42:39.682146 systemd[1]: Started containerd.service - containerd container runtime. Jul 6 23:42:39.683732 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 6 23:42:39.707749 (dockerd)[2453]: 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 6 23:42:39.732259 dockerd[2453]: time="2025-07-06T23:42:39.732203199Z" level=info msg="Starting up" Jul 6 23:42:39.732816 dockerd[2453]: time="2025-07-06T23:42:39.732797461Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 6 23:42:39.759871 dockerd[2453]: time="2025-07-06T23:42:39.759773842Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Jul 6 23:42:39.768038 dockerd[2453]: time="2025-07-06T23:42:39.767977100Z" level=info msg="Loading containers: start." Jul 6 23:42:39.783685 systemd[1]: var-lib-docker-overlay2-6340d107d58b355981b31030cdcdad3eff6431b8c321cf8d2fd07ddab0bb80a3-merged.mount: Deactivated successfully. Jul 6 23:42:40.205088 systemd-networkd[1384]: veth5de5933: Link DOWN Jul 6 23:42:40.205097 systemd-networkd[1384]: veth5de5933: Lost carrier Jul 6 23:42:40.206386 kernel: docker0: port 1(veth5de5933) entered disabled state Jul 6 23:42:40.208695 kernel: veth5de5933 (unregistering): left allmulticast mode Jul 6 23:42:40.208755 kernel: veth5de5933 (unregistering): left promiscuous mode Jul 6 23:42:40.208773 kernel: docker0: port 1(veth5de5933) entered disabled state Jul 6 23:42:40.209463 dockerd[2453]: time="2025-07-06T23:42:40.209419025Z" level=info msg="Removing stale sandbox e24a8461d9fe5e42d66f897b26569058031cdec36bf3d6267568583d6588fe10 (52da86f7e00475d7851dd805a56cb9afb5113362f151db6d472a98f55235e2c5)" Jul 6 23:42:40.210197 systemd-networkd[1384]: docker0: Lost carrier Jul 6 23:42:40.212736 dockerd[2453]: time="2025-07-06T23:42:40.212692545Z" level=warning msg="Failed deleting service host entries to the running container: open : no such file or directory" Jul 6 23:42:40.212803 dockerd[2453]: time="2025-07-06T23:42:40.212750671Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 8b5f4860d1f4c1cc5303ffe87b510e156e7b146cb2ea7e0292b2d2ba10752bc6 44133123bbc8962382bf425f146ae8ed6f0fd72274748ffe5cf2704ed8b7b955], retrying...." Jul 6 23:42:40.459550 dockerd[2453]: time="2025-07-06T23:42:40.459442657Z" level=warning msg="error locating sandbox id 8561e0afc0d4431b8ecc32978428684a7716635f6b68bc396a7017dc5bc0678c: sandbox 8561e0afc0d4431b8ecc32978428684a7716635f6b68bc396a7017dc5bc0678c not found" Jul 6 23:42:40.459550 dockerd[2453]: time="2025-07-06T23:42:40.459487942Z" level=warning msg="error locating sandbox id e24a8461d9fe5e42d66f897b26569058031cdec36bf3d6267568583d6588fe10: sandbox e24a8461d9fe5e42d66f897b26569058031cdec36bf3d6267568583d6588fe10 not found" Jul 6 23:42:40.459550 dockerd[2453]: time="2025-07-06T23:42:40.459549468Z" level=info msg="Loading containers: done." Jul 6 23:42:40.469229 dockerd[2453]: time="2025-07-06T23:42:40.469176051Z" 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 6 23:42:40.469402 dockerd[2453]: time="2025-07-06T23:42:40.469262900Z" level=info msg="Docker daemon" commit=bbd0a17ccc67e48d4a69393287b7fcc4f0578683 containerd-snapshotter=false storage-driver=overlay2 version=28.0.1 Jul 6 23:42:40.469402 dockerd[2453]: time="2025-07-06T23:42:40.469305704Z" level=info msg="Initializing buildkit" Jul 6 23:42:40.481683 dockerd[2453]: time="2025-07-06T23:42:40.481633393Z" level=info msg="Completed buildkit initialization" Jul 6 23:42:40.489499 dockerd[2453]: time="2025-07-06T23:42:40.489446039Z" level=info msg="Daemon has completed initialization" Jul 6 23:42:40.489605 dockerd[2453]: time="2025-07-06T23:42:40.489534727Z" level=info msg="API listen on /run/docker.sock" Jul 6 23:42:40.489680 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 6 23:42:40.751151 systemd[1]: var-lib-docker-overlay2-6340d107d58b355981b31030cdcdad3eff6431b8c321cf8d2fd07ddab0bb80a3-merged.mount: Deactivated successfully. Jul 6 23:42:40.751232 systemd[1]: run-docker-netns-e24a8461d9fe.mount: Deactivated successfully. Jul 6 23:42:44.003511 systemd[1]: Started sshd@24-10.0.0.129:22-10.0.0.1:47356.service - OpenSSH per-connection server daemon (10.0.0.1:47356). Jul 6 23:42:44.049646 sshd[2675]: Accepted publickey for core from 10.0.0.1 port 47356 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:44.050656 sshd-session[2675]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:44.054421 systemd-logind[1400]: New session 25 of user core. Jul 6 23:42:44.063627 systemd[1]: Started session-25.scope - Session 25 of User core. Jul 6 23:42:44.118644 sshd[2677]: Connection closed by 10.0.0.1 port 47356 Jul 6 23:42:44.119953 sshd-session[2675]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:44.130334 systemd[1]: sshd@24-10.0.0.129:22-10.0.0.1:47356.service: Deactivated successfully. Jul 6 23:42:44.132918 systemd[1]: session-25.scope: Deactivated successfully. Jul 6 23:42:44.135211 systemd-logind[1400]: Session 25 logged out. Waiting for processes to exit. Jul 6 23:42:44.140612 systemd[1]: Started sshd@25-10.0.0.129:22-10.0.0.1:47368.service - OpenSSH per-connection server daemon (10.0.0.1:47368). Jul 6 23:42:44.144895 systemd-logind[1400]: Removed session 25. Jul 6 23:42:44.193855 sshd[2683]: Accepted publickey for core from 10.0.0.1 port 47368 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:44.195105 sshd-session[2683]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:44.199223 systemd-logind[1400]: New session 26 of user core. Jul 6 23:42:44.224513 systemd[1]: Started session-26.scope - Session 26 of User core. Jul 6 23:42:44.284227 sshd[2685]: Connection closed by 10.0.0.1 port 47368 Jul 6 23:42:44.284161 sshd-session[2683]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:44.296370 systemd[1]: sshd@25-10.0.0.129:22-10.0.0.1:47368.service: Deactivated successfully. Jul 6 23:42:44.297786 systemd[1]: session-26.scope: Deactivated successfully. Jul 6 23:42:44.298442 systemd-logind[1400]: Session 26 logged out. Waiting for processes to exit. Jul 6 23:42:44.300543 systemd[1]: Started sshd@26-10.0.0.129:22-10.0.0.1:47370.service - OpenSSH per-connection server daemon (10.0.0.1:47370). Jul 6 23:42:44.304959 systemd-logind[1400]: Removed session 26. Jul 6 23:42:44.359716 sshd[2691]: Accepted publickey for core from 10.0.0.1 port 47370 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:44.361269 sshd-session[2691]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:44.365490 systemd-logind[1400]: New session 27 of user core. Jul 6 23:42:44.385532 systemd[1]: Started session-27.scope - Session 27 of User core. Jul 6 23:42:44.445222 sshd[2693]: Connection closed by 10.0.0.1 port 47370 Jul 6 23:42:44.445617 sshd-session[2691]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:44.460430 systemd[1]: sshd@26-10.0.0.129:22-10.0.0.1:47370.service: Deactivated successfully. Jul 6 23:42:44.461766 systemd[1]: session-27.scope: Deactivated successfully. Jul 6 23:42:44.463047 systemd-logind[1400]: Session 27 logged out. Waiting for processes to exit. Jul 6 23:42:44.465363 systemd[1]: Started sshd@27-10.0.0.129:22-10.0.0.1:47378.service - OpenSSH per-connection server daemon (10.0.0.1:47378). Jul 6 23:42:44.468620 systemd-logind[1400]: Removed session 27. Jul 6 23:42:44.524628 sshd[2706]: Accepted publickey for core from 10.0.0.1 port 47378 ssh2: RSA SHA256:jyTvj9WiqpnTWeC15mq15pBzt3VkG8C4RFcxi7WEalo Jul 6 23:42:44.525847 sshd-session[2706]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 6 23:42:44.529780 systemd-logind[1400]: New session 28 of user core. Jul 6 23:42:44.537570 systemd[1]: Started session-28.scope - Session 28 of User core. Jul 6 23:42:44.604516 systemd[1]: var-lib-docker-overlay2-9f829e35c1f3fb60cc475af281b48b05561625fb6cee048637c1fcc75fa4f097\x2dinit-merged.mount: Deactivated successfully. Jul 6 23:42:44.647587 containerd[2404]: time="2025-07-06T23:42:44.647539512Z" level=info msg="connecting to shim 2e1a6a6aa0bf541e984231628e8ad73c37a1269cf45ea05f129d898e0532658a" address="unix:///run/containerd/s/3af3c7e2177aef9064d6b9c3cd4fb9b998b06017b1b51a89c3973c788bebdebb" namespace=moby protocol=ttrpc version=3 Jul 6 23:42:44.676547 systemd[1]: Started docker-2e1a6a6aa0bf541e984231628e8ad73c37a1269cf45ea05f129d898e0532658a.scope - libcontainer container 2e1a6a6aa0bf541e984231628e8ad73c37a1269cf45ea05f129d898e0532658a. Jul 6 23:42:44.691261 systemd-resolved[1293]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Jul 6 23:42:44.713629 kernel: docker0: port 1(vethe1c40d2) entered blocking state Jul 6 23:42:44.713709 kernel: docker0: port 1(vethe1c40d2) entered disabled state Jul 6 23:42:44.713734 kernel: vethe1c40d2: entered allmulticast mode Jul 6 23:42:44.713759 kernel: vethe1c40d2: entered promiscuous mode Jul 6 23:42:44.714570 systemd-networkd[1384]: vethe1c40d2: Link UP Jul 6 23:42:44.724385 kernel: eth0: renamed from veth0ee2df8 Jul 6 23:42:44.726366 kernel: docker0: port 1(vethe1c40d2) entered blocking state Jul 6 23:42:44.726423 kernel: docker0: port 1(vethe1c40d2) entered forwarding state Jul 6 23:42:44.726925 systemd-networkd[1384]: vethe1c40d2: Gained carrier Jul 6 23:42:44.727132 systemd-networkd[1384]: docker0: Gained carrier Jul 6 23:42:44.747273 sshd[2708]: Connection closed by 10.0.0.1 port 47378 Jul 6 23:42:44.747640 sshd-session[2706]: pam_unix(sshd:session): session closed for user core Jul 6 23:42:44.751687 systemd[1]: sshd@27-10.0.0.129:22-10.0.0.1:47378.service: Deactivated successfully. Jul 6 23:42:44.753210 systemd[1]: session-28.scope: Deactivated successfully. Jul 6 23:42:44.755928 systemd-logind[1400]: Session 28 logged out. Waiting for processes to exit. Jul 6 23:42:44.757157 systemd-logind[1400]: Removed session 28.