Sep 9 23:38:38.865872 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 9 23:38:38.865895 kernel: Linux version 6.6.104-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.43 p3) 2.43.1) #1 SMP PREEMPT Tue Sep 9 22:11:11 -00 2025 Sep 9 23:38:38.865906 kernel: KASLR enabled Sep 9 23:38:38.865911 kernel: efi: EFI v2.7 by EDK II Sep 9 23:38:38.865917 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbae018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40218 Sep 9 23:38:38.865923 kernel: random: crng init done Sep 9 23:38:38.865930 kernel: secureboot: Secure boot disabled Sep 9 23:38:38.865935 kernel: ACPI: Early table checksum verification disabled Sep 9 23:38:38.865941 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Sep 9 23:38:38.865949 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 9 23:38:38.865955 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865961 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865967 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865973 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865980 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865988 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.865995 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.866001 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.866008 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 23:38:38.866014 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 9 23:38:38.866020 kernel: NUMA: Failed to initialise from firmware Sep 9 23:38:38.866027 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:38:38.866033 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Sep 9 23:38:38.866039 kernel: Zone ranges: Sep 9 23:38:38.866045 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:38:38.866053 kernel: DMA32 empty Sep 9 23:38:38.866059 kernel: Normal empty Sep 9 23:38:38.866065 kernel: Movable zone start for each node Sep 9 23:38:38.866072 kernel: Early memory node ranges Sep 9 23:38:38.866078 kernel: node 0: [mem 0x0000000040000000-0x00000000d967ffff] Sep 9 23:38:38.866084 kernel: node 0: [mem 0x00000000d9680000-0x00000000d968ffff] Sep 9 23:38:38.866090 kernel: node 0: [mem 0x00000000d9690000-0x00000000d976ffff] Sep 9 23:38:38.866096 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Sep 9 23:38:38.866102 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Sep 9 23:38:38.866109 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 9 23:38:38.866115 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 9 23:38:38.866121 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 9 23:38:38.866129 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 9 23:38:38.866136 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 23:38:38.866142 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 9 23:38:38.866151 kernel: psci: probing for conduit method from ACPI. Sep 9 23:38:38.866172 kernel: psci: PSCIv1.1 detected in firmware. Sep 9 23:38:38.866179 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 23:38:38.866187 kernel: psci: Trusted OS migration not required Sep 9 23:38:38.866194 kernel: psci: SMC Calling Convention v1.1 Sep 9 23:38:38.866201 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 9 23:38:38.866208 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Sep 9 23:38:38.866214 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Sep 9 23:38:38.866221 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 9 23:38:38.866227 kernel: Detected PIPT I-cache on CPU0 Sep 9 23:38:38.866234 kernel: CPU features: detected: GIC system register CPU interface Sep 9 23:38:38.866240 kernel: CPU features: detected: Hardware dirty bit management Sep 9 23:38:38.866247 kernel: CPU features: detected: Spectre-v4 Sep 9 23:38:38.866254 kernel: CPU features: detected: Spectre-BHB Sep 9 23:38:38.866261 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 9 23:38:38.866268 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 9 23:38:38.866274 kernel: CPU features: detected: ARM erratum 1418040 Sep 9 23:38:38.866280 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 9 23:38:38.866287 kernel: alternatives: applying boot alternatives Sep 9 23:38:38.866295 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=21f768e38d6f559c285ae64c28cbdad2cb8e0d9191080506cf69923230b56ba0 Sep 9 23:38:38.866302 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 23:38:38.866308 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 23:38:38.866316 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 23:38:38.866511 kernel: Fallback order for Node 0: 0 Sep 9 23:38:38.866527 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Sep 9 23:38:38.866534 kernel: Policy zone: DMA Sep 9 23:38:38.866540 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 23:38:38.866547 kernel: software IO TLB: area num 4. Sep 9 23:38:38.866553 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Sep 9 23:38:38.866561 kernel: Memory: 2387412K/2572288K available (10368K kernel code, 2186K rwdata, 8104K rodata, 38400K init, 897K bss, 184876K reserved, 0K cma-reserved) Sep 9 23:38:38.866567 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 9 23:38:38.866574 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 23:38:38.866581 kernel: rcu: RCU event tracing is enabled. Sep 9 23:38:38.866588 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 9 23:38:38.866595 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 23:38:38.866601 kernel: Tracing variant of Tasks RCU enabled. Sep 9 23:38:38.866610 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 23:38:38.866616 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 9 23:38:38.866623 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 23:38:38.866629 kernel: GICv3: 256 SPIs implemented Sep 9 23:38:38.866663 kernel: GICv3: 0 Extended SPIs implemented Sep 9 23:38:38.866672 kernel: Root IRQ handler: gic_handle_irq Sep 9 23:38:38.866678 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 9 23:38:38.866685 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 9 23:38:38.866691 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 9 23:38:38.866698 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Sep 9 23:38:38.866705 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Sep 9 23:38:38.866714 kernel: GICv3: using LPI property table @0x00000000400f0000 Sep 9 23:38:38.866721 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Sep 9 23:38:38.866727 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 23:38:38.866734 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:38:38.866741 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 9 23:38:38.866748 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 9 23:38:38.866754 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 9 23:38:38.866761 kernel: arm-pv: using stolen time PV Sep 9 23:38:38.866768 kernel: Console: colour dummy device 80x25 Sep 9 23:38:38.866774 kernel: ACPI: Core revision 20230628 Sep 9 23:38:38.866782 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 9 23:38:38.866792 kernel: pid_max: default: 32768 minimum: 301 Sep 9 23:38:38.866799 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 9 23:38:38.866806 kernel: landlock: Up and running. Sep 9 23:38:38.866815 kernel: SELinux: Initializing. Sep 9 23:38:38.866825 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:38:38.866834 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 23:38:38.866841 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 23:38:38.866848 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 23:38:38.866855 kernel: rcu: Hierarchical SRCU implementation. Sep 9 23:38:38.866864 kernel: rcu: Max phase no-delay instances is 400. Sep 9 23:38:38.866871 kernel: Platform MSI: ITS@0x8080000 domain created Sep 9 23:38:38.866878 kernel: PCI/MSI: ITS@0x8080000 domain created Sep 9 23:38:38.866885 kernel: Remapping and enabling EFI services. Sep 9 23:38:38.866891 kernel: smp: Bringing up secondary CPUs ... Sep 9 23:38:38.866898 kernel: Detected PIPT I-cache on CPU1 Sep 9 23:38:38.866905 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 9 23:38:38.866912 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Sep 9 23:38:38.866919 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:38:38.866927 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 9 23:38:38.866934 kernel: Detected PIPT I-cache on CPU2 Sep 9 23:38:38.866946 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 9 23:38:38.866955 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Sep 9 23:38:38.866962 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:38:38.866969 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 9 23:38:38.866976 kernel: Detected PIPT I-cache on CPU3 Sep 9 23:38:38.866983 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 9 23:38:38.866990 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Sep 9 23:38:38.866999 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 23:38:38.867006 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 9 23:38:38.867013 kernel: smp: Brought up 1 node, 4 CPUs Sep 9 23:38:38.867020 kernel: SMP: Total of 4 processors activated. Sep 9 23:38:38.867027 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 23:38:38.867034 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 9 23:38:38.867041 kernel: CPU features: detected: Common not Private translations Sep 9 23:38:38.867048 kernel: CPU features: detected: CRC32 instructions Sep 9 23:38:38.867057 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 9 23:38:38.867064 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 9 23:38:38.867071 kernel: CPU features: detected: LSE atomic instructions Sep 9 23:38:38.867079 kernel: CPU features: detected: Privileged Access Never Sep 9 23:38:38.867086 kernel: CPU features: detected: RAS Extension Support Sep 9 23:38:38.867093 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 9 23:38:38.867100 kernel: CPU: All CPU(s) started at EL1 Sep 9 23:38:38.867108 kernel: alternatives: applying system-wide alternatives Sep 9 23:38:38.867114 kernel: devtmpfs: initialized Sep 9 23:38:38.867124 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 23:38:38.867132 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 9 23:38:38.867143 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 23:38:38.867151 kernel: SMBIOS 3.0.0 present. Sep 9 23:38:38.867158 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Sep 9 23:38:38.867165 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 23:38:38.867173 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 23:38:38.867180 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 23:38:38.867187 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 23:38:38.867196 kernel: audit: initializing netlink subsys (disabled) Sep 9 23:38:38.867203 kernel: audit: type=2000 audit(0.025:1): state=initialized audit_enabled=0 res=1 Sep 9 23:38:38.867210 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 23:38:38.867218 kernel: cpuidle: using governor menu Sep 9 23:38:38.867225 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 23:38:38.867232 kernel: ASID allocator initialised with 32768 entries Sep 9 23:38:38.867239 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 23:38:38.867246 kernel: Serial: AMBA PL011 UART driver Sep 9 23:38:38.867253 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 9 23:38:38.867262 kernel: Modules: 0 pages in range for non-PLT usage Sep 9 23:38:38.867269 kernel: Modules: 509248 pages in range for PLT usage Sep 9 23:38:38.867276 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 23:38:38.867283 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 23:38:38.867291 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 23:38:38.867298 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 9 23:38:38.867306 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 23:38:38.867313 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 23:38:38.867326 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 23:38:38.867357 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 9 23:38:38.867369 kernel: ACPI: Added _OSI(Module Device) Sep 9 23:38:38.867378 kernel: ACPI: Added _OSI(Processor Device) Sep 9 23:38:38.867385 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 23:38:38.867392 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 23:38:38.867399 kernel: ACPI: Interpreter enabled Sep 9 23:38:38.867407 kernel: ACPI: Using GIC for interrupt routing Sep 9 23:38:38.867414 kernel: ACPI: MCFG table detected, 1 entries Sep 9 23:38:38.867421 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 9 23:38:38.867428 kernel: printk: console [ttyAMA0] enabled Sep 9 23:38:38.867438 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 9 23:38:38.867600 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 23:38:38.867737 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 23:38:38.867810 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 23:38:38.867875 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 9 23:38:38.867940 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 9 23:38:38.867949 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 9 23:38:38.867961 kernel: PCI host bridge to bus 0000:00 Sep 9 23:38:38.868037 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 9 23:38:38.868100 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 23:38:38.868161 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 9 23:38:38.868220 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 9 23:38:38.868303 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Sep 9 23:38:38.868422 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Sep 9 23:38:38.868494 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Sep 9 23:38:38.868590 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Sep 9 23:38:38.868720 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 23:38:38.868795 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 23:38:38.868864 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Sep 9 23:38:38.868933 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Sep 9 23:38:38.869004 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 9 23:38:38.869064 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 23:38:38.869122 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 9 23:38:38.869132 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 23:38:38.869139 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 23:38:38.869146 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 23:38:38.869153 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 23:38:38.869161 kernel: iommu: Default domain type: Translated Sep 9 23:38:38.869170 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 23:38:38.869177 kernel: efivars: Registered efivars operations Sep 9 23:38:38.869184 kernel: vgaarb: loaded Sep 9 23:38:38.869191 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 23:38:38.869198 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 23:38:38.869205 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 23:38:38.869213 kernel: pnp: PnP ACPI init Sep 9 23:38:38.869286 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 9 23:38:38.869298 kernel: pnp: PnP ACPI: found 1 devices Sep 9 23:38:38.869305 kernel: NET: Registered PF_INET protocol family Sep 9 23:38:38.869313 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 23:38:38.869320 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 23:38:38.869345 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 23:38:38.869352 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 23:38:38.869360 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 9 23:38:38.869381 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 23:38:38.869389 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:38:38.869399 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 23:38:38.869406 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 23:38:38.869414 kernel: PCI: CLS 0 bytes, default 64 Sep 9 23:38:38.869421 kernel: kvm [1]: HYP mode not available Sep 9 23:38:38.869428 kernel: Initialise system trusted keyrings Sep 9 23:38:38.869436 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 23:38:38.869443 kernel: Key type asymmetric registered Sep 9 23:38:38.869450 kernel: Asymmetric key parser 'x509' registered Sep 9 23:38:38.869457 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 9 23:38:38.869465 kernel: io scheduler mq-deadline registered Sep 9 23:38:38.869473 kernel: io scheduler kyber registered Sep 9 23:38:38.869480 kernel: io scheduler bfq registered Sep 9 23:38:38.869487 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 23:38:38.869494 kernel: ACPI: button: Power Button [PWRB] Sep 9 23:38:38.869502 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 23:38:38.869583 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 9 23:38:38.869594 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 23:38:38.869601 kernel: thunder_xcv, ver 1.0 Sep 9 23:38:38.869608 kernel: thunder_bgx, ver 1.0 Sep 9 23:38:38.869617 kernel: nicpf, ver 1.0 Sep 9 23:38:38.869624 kernel: nicvf, ver 1.0 Sep 9 23:38:38.869754 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 23:38:38.869828 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T23:38:38 UTC (1757461118) Sep 9 23:38:38.869838 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 23:38:38.869846 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Sep 9 23:38:38.869854 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 9 23:38:38.869865 kernel: watchdog: Hard watchdog permanently disabled Sep 9 23:38:38.869872 kernel: NET: Registered PF_INET6 protocol family Sep 9 23:38:38.869879 kernel: Segment Routing with IPv6 Sep 9 23:38:38.869886 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 23:38:38.869893 kernel: NET: Registered PF_PACKET protocol family Sep 9 23:38:38.869901 kernel: Key type dns_resolver registered Sep 9 23:38:38.869908 kernel: registered taskstats version 1 Sep 9 23:38:38.869916 kernel: Loading compiled-in X.509 certificates Sep 9 23:38:38.869923 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.104-flatcar: 3c4ba31f0a17c8a368cad32e74fc485e669c1e50' Sep 9 23:38:38.869930 kernel: Key type .fscrypt registered Sep 9 23:38:38.869939 kernel: Key type fscrypt-provisioning registered Sep 9 23:38:38.869946 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 23:38:38.869953 kernel: ima: Allocated hash algorithm: sha1 Sep 9 23:38:38.869961 kernel: ima: No architecture policies found Sep 9 23:38:38.869968 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 23:38:38.869975 kernel: clk: Disabling unused clocks Sep 9 23:38:38.869982 kernel: Freeing unused kernel memory: 38400K Sep 9 23:38:38.869989 kernel: Run /init as init process Sep 9 23:38:38.869998 kernel: with arguments: Sep 9 23:38:38.870005 kernel: /init Sep 9 23:38:38.870012 kernel: with environment: Sep 9 23:38:38.870019 kernel: HOME=/ Sep 9 23:38:38.870026 kernel: TERM=linux Sep 9 23:38:38.870033 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 23:38:38.870041 systemd[1]: Successfully made /usr/ read-only. Sep 9 23:38:38.870052 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 23:38:38.870061 systemd[1]: Detected virtualization kvm. Sep 9 23:38:38.870069 systemd[1]: Detected architecture arm64. Sep 9 23:38:38.870077 systemd[1]: Running in initrd. Sep 9 23:38:38.870085 systemd[1]: No hostname configured, using default hostname. Sep 9 23:38:38.870093 systemd[1]: Hostname set to . Sep 9 23:38:38.870100 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:38:38.870108 systemd[1]: Queued start job for default target initrd.target. Sep 9 23:38:38.870116 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:38:38.870125 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:38:38.870133 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 23:38:38.870141 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:38:38.870149 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 23:38:38.870158 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 23:38:38.870167 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 9 23:38:38.870175 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 23:38:38.870184 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:38:38.870192 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:38:38.870200 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:38:38.870207 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:38:38.870215 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:38:38.870222 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:38:38.870230 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:38:38.870238 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:38:38.870245 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 23:38:38.870255 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 9 23:38:38.870262 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:38:38.870270 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:38:38.870278 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:38:38.870286 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:38:38.870294 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 23:38:38.870301 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:38:38.870309 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 23:38:38.870319 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 23:38:38.870362 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:38:38.870372 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:38:38.870380 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:38:38.870387 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 23:38:38.870395 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:38:38.870407 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 23:38:38.870441 systemd-journald[238]: Collecting audit messages is disabled. Sep 9 23:38:38.870461 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 9 23:38:38.870471 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 23:38:38.870479 kernel: Bridge firewalling registered Sep 9 23:38:38.870487 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:38:38.870495 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:38:38.870504 systemd-journald[238]: Journal started Sep 9 23:38:38.870574 systemd-journald[238]: Runtime Journal (/run/log/journal/5c812a4e39744d57bd7a670d5903bd7e) is 5.9M, max 47.3M, 41.4M free. Sep 9 23:38:38.852219 systemd-modules-load[239]: Inserted module 'overlay' Sep 9 23:38:38.872767 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:38:38.866779 systemd-modules-load[239]: Inserted module 'br_netfilter' Sep 9 23:38:38.873720 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 23:38:38.885520 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 23:38:38.887243 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:38:38.891585 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:38:38.893884 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:38:38.899008 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:38:38.908722 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:38:38.910256 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:38:38.921509 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 23:38:38.922467 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:38:38.926396 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:38:38.936456 dracut-cmdline[277]: dracut-dracut-053 Sep 9 23:38:38.939039 dracut-cmdline[277]: Using kernel command line parameters: rd.driver.pre=btrfs 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=21f768e38d6f559c285ae64c28cbdad2cb8e0d9191080506cf69923230b56ba0 Sep 9 23:38:38.955920 systemd-resolved[281]: Positive Trust Anchors: Sep 9 23:38:38.955940 systemd-resolved[281]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:38:38.955973 systemd-resolved[281]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 23:38:38.961298 systemd-resolved[281]: Defaulting to hostname 'linux'. Sep 9 23:38:38.962538 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:38:38.965460 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:38:39.016378 kernel: SCSI subsystem initialized Sep 9 23:38:39.021364 kernel: Loading iSCSI transport class v2.0-870. Sep 9 23:38:39.029384 kernel: iscsi: registered transport (tcp) Sep 9 23:38:39.042411 kernel: iscsi: registered transport (qla4xxx) Sep 9 23:38:39.042477 kernel: QLogic iSCSI HBA Driver Sep 9 23:38:39.087029 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 23:38:39.097592 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 23:38:39.114361 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 23:38:39.114439 kernel: device-mapper: uevent: version 1.0.3 Sep 9 23:38:39.116361 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 9 23:38:39.162374 kernel: raid6: neonx8 gen() 15788 MB/s Sep 9 23:38:39.179355 kernel: raid6: neonx4 gen() 15635 MB/s Sep 9 23:38:39.196347 kernel: raid6: neonx2 gen() 13215 MB/s Sep 9 23:38:39.213363 kernel: raid6: neonx1 gen() 10542 MB/s Sep 9 23:38:39.230365 kernel: raid6: int64x8 gen() 6788 MB/s Sep 9 23:38:39.247351 kernel: raid6: int64x4 gen() 7297 MB/s Sep 9 23:38:39.264357 kernel: raid6: int64x2 gen() 6104 MB/s Sep 9 23:38:39.281353 kernel: raid6: int64x1 gen() 5049 MB/s Sep 9 23:38:39.281379 kernel: raid6: using algorithm neonx8 gen() 15788 MB/s Sep 9 23:38:39.298376 kernel: raid6: .... xor() 11745 MB/s, rmw enabled Sep 9 23:38:39.298419 kernel: raid6: using neon recovery algorithm Sep 9 23:38:39.303815 kernel: xor: measuring software checksum speed Sep 9 23:38:39.303845 kernel: 8regs : 21658 MB/sec Sep 9 23:38:39.304420 kernel: 32regs : 21681 MB/sec Sep 9 23:38:39.305449 kernel: arm64_neon : 27879 MB/sec Sep 9 23:38:39.305474 kernel: xor: using function: arm64_neon (27879 MB/sec) Sep 9 23:38:39.354373 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 23:38:39.365803 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:38:39.388531 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:38:39.402444 systemd-udevd[465]: Using default interface naming scheme 'v255'. Sep 9 23:38:39.406376 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:38:39.412524 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 23:38:39.426659 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Sep 9 23:38:39.455513 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:38:39.465600 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:38:39.513499 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:38:39.519580 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 23:38:39.537417 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 23:38:39.538785 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:38:39.540811 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:38:39.542322 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:38:39.554517 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 23:38:39.566078 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:38:39.586462 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 9 23:38:39.592539 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 9 23:38:39.594596 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 23:38:39.597932 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:38:39.596524 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:38:39.597742 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 23:38:39.598867 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:38:39.599018 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:38:39.602947 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:38:39.614642 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:38:39.618464 kernel: BTRFS: device fsid 3ddee560-dcea-4f51-a281-f1376972e538 devid 1 transid 36 /dev/vda3 scanned by (udev-worker) (517) Sep 9 23:38:39.618489 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by (udev-worker) (525) Sep 9 23:38:39.629379 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:38:39.637136 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 9 23:38:39.653607 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 9 23:38:39.659685 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 9 23:38:39.660621 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 9 23:38:39.669325 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 23:38:39.682504 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 23:38:39.684117 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 23:38:39.691393 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:38:39.713906 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:38:40.699283 disk-uuid[556]: The operation has completed successfully. Sep 9 23:38:40.700590 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 23:38:40.728205 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 23:38:40.728364 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 23:38:40.772578 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 9 23:38:40.775593 sh[576]: Success Sep 9 23:38:40.786361 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 9 23:38:40.825258 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 9 23:38:40.826465 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 9 23:38:40.829104 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 9 23:38:40.843084 kernel: BTRFS info (device dm-0): first mount of filesystem 3ddee560-dcea-4f51-a281-f1376972e538 Sep 9 23:38:40.843125 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:38:40.843135 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 9 23:38:40.843145 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 9 23:38:40.843806 kernel: BTRFS info (device dm-0): using free space tree Sep 9 23:38:40.848085 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 9 23:38:40.849390 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 9 23:38:40.865559 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 9 23:38:40.867138 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 23:38:40.881049 kernel: BTRFS info (device vda6): first mount of filesystem 191f1648-95e8-4e77-9224-63d1cc235347 Sep 9 23:38:40.881103 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:38:40.881694 kernel: BTRFS info (device vda6): using free space tree Sep 9 23:38:40.883385 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 23:38:40.887456 kernel: BTRFS info (device vda6): last unmount of filesystem 191f1648-95e8-4e77-9224-63d1cc235347 Sep 9 23:38:40.891043 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 9 23:38:40.898553 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 23:38:40.960371 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:38:40.967090 ignition[660]: Ignition 2.20.0 Sep 9 23:38:40.967100 ignition[660]: Stage: fetch-offline Sep 9 23:38:40.974530 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:38:40.967135 ignition[660]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:40.967144 ignition[660]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:40.967305 ignition[660]: parsed url from cmdline: "" Sep 9 23:38:40.981219 unknown[660]: fetched base config from "system" Sep 9 23:38:40.967308 ignition[660]: no config URL provided Sep 9 23:38:40.981227 unknown[660]: fetched user config from "qemu" Sep 9 23:38:40.967320 ignition[660]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 23:38:40.983232 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:38:40.967329 ignition[660]: no config at "/usr/lib/ignition/user.ign" Sep 9 23:38:40.967367 ignition[660]: op(1): [started] loading QEMU firmware config module Sep 9 23:38:40.967371 ignition[660]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 9 23:38:40.972478 ignition[660]: op(1): [finished] loading QEMU firmware config module Sep 9 23:38:40.972503 ignition[660]: QEMU firmware config was not found. Ignoring... Sep 9 23:38:40.976151 ignition[660]: parsing config with SHA512: 99d0278b921769c99aab7db703adb678984616d825d9a90c1f768f6da12efc2263dbb68f8f90c3b02a49d3b02aeaa4dcb34d3402afc5f79f3fc553f7dbc0c987 Sep 9 23:38:40.981433 ignition[660]: fetch-offline: fetch-offline passed Sep 9 23:38:40.981521 ignition[660]: Ignition finished successfully Sep 9 23:38:41.001800 systemd-networkd[766]: lo: Link UP Sep 9 23:38:41.001814 systemd-networkd[766]: lo: Gained carrier Sep 9 23:38:41.002657 systemd-networkd[766]: Enumeration completed Sep 9 23:38:41.002934 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:38:41.003059 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:38:41.003063 systemd-networkd[766]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:38:41.003672 systemd-networkd[766]: eth0: Link UP Sep 9 23:38:41.003675 systemd-networkd[766]: eth0: Gained carrier Sep 9 23:38:41.003681 systemd-networkd[766]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:38:41.004427 systemd[1]: Reached target network.target - Network. Sep 9 23:38:41.005624 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 9 23:38:41.013544 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 23:38:41.021411 systemd-networkd[766]: eth0: DHCPv4 address 10.0.0.91/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 23:38:41.027105 ignition[771]: Ignition 2.20.0 Sep 9 23:38:41.027113 ignition[771]: Stage: kargs Sep 9 23:38:41.027282 ignition[771]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:41.027292 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:41.027960 ignition[771]: kargs: kargs passed Sep 9 23:38:41.027999 ignition[771]: Ignition finished successfully Sep 9 23:38:41.032409 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 23:38:41.040513 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 23:38:41.049679 ignition[781]: Ignition 2.20.0 Sep 9 23:38:41.049687 ignition[781]: Stage: disks Sep 9 23:38:41.049855 ignition[781]: no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:41.049865 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:41.052062 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 23:38:41.050475 ignition[781]: disks: disks passed Sep 9 23:38:41.053384 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 23:38:41.050520 ignition[781]: Ignition finished successfully Sep 9 23:38:41.055105 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 23:38:41.056840 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:38:41.058060 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:38:41.059836 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:38:41.067504 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 23:38:41.077372 systemd-fsck[792]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 9 23:38:41.095460 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 23:38:41.108499 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 23:38:41.148358 kernel: EXT4-fs (vda9): mounted filesystem e3172dee-2277-4905-9eaa-a536ab409f20 r/w with ordered data mode. Quota mode: none. Sep 9 23:38:41.148990 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 23:38:41.150094 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 23:38:41.162451 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:38:41.165484 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 23:38:41.166355 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 9 23:38:41.166399 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 23:38:41.171695 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by mount (800) Sep 9 23:38:41.166424 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:38:41.170306 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 23:38:41.177023 kernel: BTRFS info (device vda6): first mount of filesystem 191f1648-95e8-4e77-9224-63d1cc235347 Sep 9 23:38:41.177043 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:38:41.177053 kernel: BTRFS info (device vda6): using free space tree Sep 9 23:38:41.173227 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 23:38:41.179349 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 23:38:41.180188 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:38:41.212288 initrd-setup-root[825]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 23:38:41.216717 initrd-setup-root[832]: cut: /sysroot/etc/group: No such file or directory Sep 9 23:38:41.220385 initrd-setup-root[839]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 23:38:41.224160 initrd-setup-root[846]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 23:38:41.293223 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 23:38:41.306479 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 23:38:41.308040 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 9 23:38:41.313388 kernel: BTRFS info (device vda6): last unmount of filesystem 191f1648-95e8-4e77-9224-63d1cc235347 Sep 9 23:38:41.328534 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 9 23:38:41.332395 ignition[915]: INFO : Ignition 2.20.0 Sep 9 23:38:41.332395 ignition[915]: INFO : Stage: mount Sep 9 23:38:41.334455 ignition[915]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:41.334455 ignition[915]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:41.334455 ignition[915]: INFO : mount: mount passed Sep 9 23:38:41.334455 ignition[915]: INFO : Ignition finished successfully Sep 9 23:38:41.334964 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 23:38:41.341505 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 23:38:41.848835 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 9 23:38:41.857557 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 23:38:41.863351 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (929) Sep 9 23:38:41.865168 kernel: BTRFS info (device vda6): first mount of filesystem 191f1648-95e8-4e77-9224-63d1cc235347 Sep 9 23:38:41.865192 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 23:38:41.865203 kernel: BTRFS info (device vda6): using free space tree Sep 9 23:38:41.868361 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 23:38:41.868884 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 23:38:41.888206 ignition[946]: INFO : Ignition 2.20.0 Sep 9 23:38:41.888206 ignition[946]: INFO : Stage: files Sep 9 23:38:41.889700 ignition[946]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:41.889700 ignition[946]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:41.889700 ignition[946]: DEBUG : files: compiled without relabeling support, skipping Sep 9 23:38:41.892437 ignition[946]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 23:38:41.892437 ignition[946]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 23:38:41.892437 ignition[946]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 23:38:41.895827 ignition[946]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 23:38:41.895827 ignition[946]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 23:38:41.895827 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 23:38:41.895827 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(6): [started] processing unit "docker.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(6): [finished] processing unit "docker.service" Sep 9 23:38:41.895827 ignition[946]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 9 23:38:41.892856 unknown[946]: wrote ssh authorized keys file for user: core Sep 9 23:38:41.917713 ignition[946]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 23:38:41.917713 ignition[946]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 23:38:41.917713 ignition[946]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 9 23:38:41.917713 ignition[946]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 9 23:38:41.917713 ignition[946]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 9 23:38:41.917713 ignition[946]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:38:41.917713 ignition[946]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 23:38:41.917713 ignition[946]: INFO : files: files passed Sep 9 23:38:41.917713 ignition[946]: INFO : Ignition finished successfully Sep 9 23:38:41.921388 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 23:38:41.928651 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 23:38:41.931084 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 23:38:41.934370 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 23:38:41.934466 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 23:38:41.938803 initrd-setup-root-after-ignition[975]: grep: /sysroot/oem/oem-release: No such file or directory Sep 9 23:38:41.941543 initrd-setup-root-after-ignition[977]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:38:41.941543 initrd-setup-root-after-ignition[977]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:38:41.944199 initrd-setup-root-after-ignition[981]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 23:38:41.944993 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:38:41.946729 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 9 23:38:41.956500 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 23:38:41.976728 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 23:38:41.976862 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 23:38:41.978836 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 23:38:41.980236 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 9 23:38:41.981654 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 9 23:38:41.982462 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 23:38:41.997585 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:38:41.999817 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 23:38:42.011074 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:38:42.012477 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:38:42.014096 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 23:38:42.015592 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 23:38:42.015724 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 23:38:42.017779 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 9 23:38:42.019337 systemd[1]: Stopped target basic.target - Basic System. Sep 9 23:38:42.020726 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 9 23:38:42.022345 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 23:38:42.024113 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 23:38:42.025756 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 23:38:42.027188 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 23:38:42.028883 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 23:38:42.030370 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 23:38:42.031854 systemd[1]: Stopped target swap.target - Swaps. Sep 9 23:38:42.033144 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 23:38:42.033281 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 23:38:42.035942 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:38:42.037571 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:38:42.039075 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 23:38:42.043408 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:38:42.044500 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 23:38:42.044633 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 23:38:42.047089 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 23:38:42.047206 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 23:38:42.048990 systemd[1]: Stopped target paths.target - Path Units. Sep 9 23:38:42.050238 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 23:38:42.054399 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:38:42.055404 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 23:38:42.057117 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 23:38:42.058407 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 23:38:42.058495 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 23:38:42.059830 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 23:38:42.059906 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 23:38:42.061193 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 23:38:42.061318 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 23:38:42.062809 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 23:38:42.062905 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 23:38:42.077552 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 23:38:42.078266 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 23:38:42.078421 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:38:42.083569 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 9 23:38:42.084256 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 23:38:42.084414 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:38:42.085386 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 23:38:42.085487 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 23:38:42.092085 ignition[1001]: INFO : Ignition 2.20.0 Sep 9 23:38:42.092085 ignition[1001]: INFO : Stage: umount Sep 9 23:38:42.092085 ignition[1001]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 23:38:42.092085 ignition[1001]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 23:38:42.091670 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 23:38:42.099082 ignition[1001]: INFO : umount: umount passed Sep 9 23:38:42.099082 ignition[1001]: INFO : Ignition finished successfully Sep 9 23:38:42.091768 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 23:38:42.096840 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 23:38:42.097300 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 23:38:42.097587 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 23:38:42.098583 systemd[1]: Stopped target network.target - Network. Sep 9 23:38:42.099796 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 23:38:42.100454 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 23:38:42.101844 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 23:38:42.101889 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 23:38:42.103305 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 23:38:42.103377 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 9 23:38:42.104712 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 23:38:42.104748 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 23:38:42.106421 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 9 23:38:42.107771 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 23:38:42.109404 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 23:38:42.109495 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 9 23:38:42.111014 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 23:38:42.111103 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 23:38:42.113461 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 23:38:42.115506 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 23:38:42.118436 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Sep 9 23:38:42.118691 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 23:38:42.118730 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:38:42.121503 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Sep 9 23:38:42.121730 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 23:38:42.121822 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 9 23:38:42.124092 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 23:38:42.124151 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:38:42.131449 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 23:38:42.132432 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 23:38:42.132497 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 23:38:42.134124 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 23:38:42.134168 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:38:42.136377 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 23:38:42.136546 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 23:38:42.138264 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:38:42.147157 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 23:38:42.147271 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 23:38:42.152026 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 23:38:42.152175 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:38:42.154185 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 23:38:42.154231 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 23:38:42.155593 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 23:38:42.155629 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:38:42.157022 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 23:38:42.157069 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 23:38:42.159151 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 23:38:42.159197 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 23:38:42.161348 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 23:38:42.161396 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 23:38:42.173550 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 23:38:42.174392 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 23:38:42.174455 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:38:42.176949 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 23:38:42.176990 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:38:42.181351 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 23:38:42.181488 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 23:38:42.184022 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 23:38:42.186181 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 23:38:42.196031 systemd[1]: Switching root. Sep 9 23:38:42.218549 systemd-journald[238]: Journal stopped Sep 9 23:38:42.880800 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Sep 9 23:38:42.880858 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 23:38:42.880870 kernel: SELinux: policy capability open_perms=1 Sep 9 23:38:42.880880 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 23:38:42.880890 kernel: SELinux: policy capability always_check_network=0 Sep 9 23:38:42.880900 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 23:38:42.880910 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 23:38:42.880923 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 23:38:42.880933 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 23:38:42.880942 kernel: audit: type=1403 audit(1757461122.279:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 23:38:42.880953 systemd[1]: Successfully loaded SELinux policy in 30.986ms. Sep 9 23:38:42.880969 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 9.887ms. Sep 9 23:38:42.880981 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Sep 9 23:38:42.880992 systemd[1]: Detected virtualization kvm. Sep 9 23:38:42.881002 systemd[1]: Detected architecture arm64. Sep 9 23:38:42.881013 systemd[1]: Detected first boot. Sep 9 23:38:42.881025 systemd[1]: Initializing machine ID from VM UUID. Sep 9 23:38:42.881037 zram_generator::config[1049]: No configuration found. Sep 9 23:38:42.881049 kernel: NET: Registered PF_VSOCK protocol family Sep 9 23:38:42.881065 systemd[1]: Populated /etc with preset unit settings. Sep 9 23:38:42.881077 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Sep 9 23:38:42.881089 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 23:38:42.881100 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 23:38:42.881112 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 23:38:42.881124 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 23:38:42.881135 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 23:38:42.881145 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 23:38:42.881155 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 23:38:42.881166 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 23:38:42.881179 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 23:38:42.881190 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 23:38:42.881200 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 23:38:42.881211 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 23:38:42.881222 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 23:38:42.881232 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 23:38:42.881243 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 23:38:42.881254 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 23:38:42.881264 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 23:38:42.881277 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 9 23:38:42.881287 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 23:38:42.881299 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 23:38:42.881318 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 23:38:42.881456 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 23:38:42.881471 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 23:38:42.881482 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 23:38:42.881494 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 23:38:42.881509 systemd[1]: Reached target slices.target - Slice Units. Sep 9 23:38:42.881520 systemd[1]: Reached target swap.target - Swaps. Sep 9 23:38:42.881531 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 23:38:42.881541 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 23:38:42.881551 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 9 23:38:42.881562 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 23:38:42.881573 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 23:38:42.881584 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 23:38:42.881595 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 23:38:42.881607 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 23:38:42.881617 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 23:38:42.881628 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 23:38:42.881639 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 23:38:42.881649 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 23:38:42.881660 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 23:38:42.881671 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 9 23:38:42.881682 systemd[1]: Reached target machines.target - Containers. Sep 9 23:38:42.881692 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 23:38:42.881705 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:38:42.881715 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 23:38:42.881725 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 23:38:42.881736 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:38:42.881749 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:38:42.881759 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:38:42.881770 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 23:38:42.881780 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:38:42.881792 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 23:38:42.881803 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 23:38:42.881815 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 23:38:42.881826 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 23:38:42.881836 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 23:38:42.881847 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:38:42.881858 kernel: fuse: init (API version 7.39) Sep 9 23:38:42.881868 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 23:38:42.881878 kernel: loop: module loaded Sep 9 23:38:42.881889 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 23:38:42.881899 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 23:38:42.881910 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 23:38:42.881920 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 9 23:38:42.881932 kernel: ACPI: bus type drm_connector registered Sep 9 23:38:42.881941 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 23:38:42.881952 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 23:38:42.881962 systemd[1]: Stopped verity-setup.service. Sep 9 23:38:42.881974 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 23:38:42.881984 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 23:38:42.881995 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 23:38:42.882005 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 23:38:42.882016 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 23:38:42.882028 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 23:38:42.882060 systemd-journald[1114]: Collecting audit messages is disabled. Sep 9 23:38:42.882082 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 23:38:42.882093 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 23:38:42.882103 systemd-journald[1114]: Journal started Sep 9 23:38:42.882124 systemd-journald[1114]: Runtime Journal (/run/log/journal/5c812a4e39744d57bd7a670d5903bd7e) is 5.9M, max 47.3M, 41.4M free. Sep 9 23:38:42.674663 systemd[1]: Queued start job for default target multi-user.target. Sep 9 23:38:42.689392 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 9 23:38:42.689799 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 23:38:42.883392 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 23:38:42.885647 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 23:38:42.888367 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 23:38:42.889579 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:38:42.889757 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:38:42.890915 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:38:42.891084 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:38:42.892169 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:38:42.892525 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:38:42.893671 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 23:38:42.893846 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 23:38:42.894935 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:38:42.895088 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:38:42.896245 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 23:38:42.897838 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 23:38:42.899091 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 23:38:42.900405 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 9 23:38:42.912991 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 23:38:42.925459 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 23:38:42.927373 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 23:38:42.928185 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 23:38:42.928221 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 23:38:42.930013 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 9 23:38:42.932270 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 23:38:42.934263 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 23:38:42.935261 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:38:42.936391 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 23:38:42.938063 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 23:38:42.939115 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:38:42.942537 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 23:38:42.945272 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:38:42.949162 systemd-journald[1114]: Time spent on flushing to /var/log/journal/5c812a4e39744d57bd7a670d5903bd7e is 22.192ms for 832 entries. Sep 9 23:38:42.949162 systemd-journald[1114]: System Journal (/var/log/journal/5c812a4e39744d57bd7a670d5903bd7e) is 8M, max 195.6M, 187.6M free. Sep 9 23:38:42.982515 systemd-journald[1114]: Received client request to flush runtime journal. Sep 9 23:38:42.982560 kernel: loop0: detected capacity change from 0 to 123192 Sep 9 23:38:42.949568 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 23:38:42.953520 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 23:38:42.960817 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 23:38:42.963543 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 23:38:42.966643 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 23:38:42.968660 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 23:38:42.970094 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 23:38:42.972537 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 23:38:42.973890 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 23:38:42.977968 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 23:38:42.986562 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 9 23:38:42.988968 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 9 23:38:42.990828 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 23:38:42.996347 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 23:38:43.013765 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 9 23:38:43.018416 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 23:38:43.021441 kernel: loop1: detected capacity change from 0 to 113512 Sep 9 23:38:43.028679 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 23:38:43.033117 udevadm[1178]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 9 23:38:43.045679 systemd-tmpfiles[1185]: ACLs are not supported, ignoring. Sep 9 23:38:43.045699 systemd-tmpfiles[1185]: ACLs are not supported, ignoring. Sep 9 23:38:43.050097 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 23:38:43.054378 kernel: loop2: detected capacity change from 0 to 123192 Sep 9 23:38:43.059660 kernel: loop3: detected capacity change from 0 to 113512 Sep 9 23:38:43.063187 (sd-merge)[1190]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 9 23:38:43.063612 (sd-merge)[1190]: Merged extensions into '/usr'. Sep 9 23:38:43.066292 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 23:38:43.073519 systemd[1]: Starting ensure-sysext.service... Sep 9 23:38:43.078540 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 23:38:43.082346 systemd[1]: Reload requested from client PID 1192 ('systemctl') (unit ensure-sysext.service)... Sep 9 23:38:43.082363 systemd[1]: Reloading... Sep 9 23:38:43.113581 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 23:38:43.113781 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 9 23:38:43.116583 systemd-tmpfiles[1193]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 23:38:43.116837 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Sep 9 23:38:43.116902 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Sep 9 23:38:43.123820 systemd-tmpfiles[1193]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:38:43.123833 systemd-tmpfiles[1193]: Skipping /boot Sep 9 23:38:43.134087 systemd-tmpfiles[1193]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 23:38:43.134108 systemd-tmpfiles[1193]: Skipping /boot Sep 9 23:38:43.158245 zram_generator::config[1220]: No configuration found. Sep 9 23:38:43.230547 ldconfig[1161]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 23:38:43.268742 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. Sep 9 23:38:43.318231 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 23:38:43.318471 systemd[1]: Reloading finished in 235 ms. Sep 9 23:38:43.338214 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 23:38:43.358524 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 23:38:43.375633 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:38:43.377983 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 23:38:43.380251 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 23:38:43.383211 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 23:38:43.385610 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 23:38:43.390385 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:38:43.391918 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:38:43.394009 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:38:43.396319 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:38:43.397190 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:38:43.397312 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:38:43.398292 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:38:43.398502 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:38:43.399780 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:38:43.399936 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:38:43.401441 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:38:43.401588 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:38:43.407128 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:38:43.416673 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:38:43.422321 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:38:43.425238 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:38:43.427321 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:38:43.427482 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:38:43.429914 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 23:38:43.432647 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 23:38:43.434956 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:38:43.435141 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:38:43.437004 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:38:43.437211 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:38:43.439154 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:38:43.439578 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:38:43.451459 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 23:38:43.466633 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 23:38:43.468606 augenrules[1298]: No rules Sep 9 23:38:43.471659 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 23:38:43.473564 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 23:38:43.475553 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 23:38:43.476593 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 23:38:43.476740 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Sep 9 23:38:43.477796 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 23:38:43.479479 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 23:38:43.481152 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:38:43.481398 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:38:43.482800 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 23:38:43.484364 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 23:38:43.485937 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 23:38:43.486090 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 23:38:43.487546 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 23:38:43.487712 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 23:38:43.489159 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 23:38:43.489317 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 23:38:43.490814 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 23:38:43.490972 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 23:38:43.497125 systemd[1]: Finished ensure-sysext.service. Sep 9 23:38:43.502662 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 23:38:43.502726 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 23:38:43.517552 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 9 23:38:43.519440 systemd-resolved[1263]: Positive Trust Anchors: Sep 9 23:38:43.519479 systemd-resolved[1263]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 23:38:43.519512 systemd-resolved[1263]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 9 23:38:43.519922 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 23:38:43.522268 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 23:38:43.523178 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 9 23:38:43.526395 systemd-resolved[1263]: Defaulting to hostname 'linux'. Sep 9 23:38:43.527899 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 23:38:43.528932 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 23:38:43.534629 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 23:38:43.548625 systemd-udevd[1321]: Using default interface naming scheme 'v255'. Sep 9 23:38:43.563870 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 23:38:43.565145 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 9 23:38:43.566675 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 23:38:43.580513 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 23:38:43.611480 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 9 23:38:43.618365 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1336) Sep 9 23:38:43.646931 systemd-networkd[1334]: lo: Link UP Sep 9 23:38:43.646945 systemd-networkd[1334]: lo: Gained carrier Sep 9 23:38:43.647938 systemd-networkd[1334]: Enumeration completed Sep 9 23:38:43.648397 systemd-networkd[1334]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:38:43.648401 systemd-networkd[1334]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 23:38:43.648591 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 23:38:43.648930 systemd-networkd[1334]: eth0: Link UP Sep 9 23:38:43.648934 systemd-networkd[1334]: eth0: Gained carrier Sep 9 23:38:43.648947 systemd-networkd[1334]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 23:38:43.649779 systemd[1]: Reached target network.target - Network. Sep 9 23:38:43.658603 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 9 23:38:43.660422 systemd-networkd[1334]: eth0: DHCPv4 address 10.0.0.91/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 23:38:43.660971 systemd-timesyncd[1320]: Network configuration changed, trying to establish connection. Sep 9 23:38:43.186497 systemd-journald[1114]: Time jumped backwards, rotating. Sep 9 23:38:43.661426 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 9 23:38:43.176583 systemd-timesyncd[1320]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 9 23:38:43.176625 systemd-timesyncd[1320]: Initial clock synchronization to Tue 2025-09-09 23:38:43.176509 UTC. Sep 9 23:38:43.176658 systemd-resolved[1263]: Clock change detected. Flushing caches. Sep 9 23:38:43.181663 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 23:38:43.184248 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 23:38:43.191365 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 9 23:38:43.201207 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 23:38:43.245749 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 23:38:43.247815 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 9 23:38:43.250860 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 9 23:38:43.264418 lvm[1365]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 23:38:43.282478 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 23:38:43.296867 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 9 23:38:43.298127 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 23:38:43.299071 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 23:38:43.300005 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 23:38:43.301000 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 9 23:38:43.302128 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 23:38:43.303121 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 23:38:43.304169 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 23:38:43.305238 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 23:38:43.305277 systemd[1]: Reached target paths.target - Path Units. Sep 9 23:38:43.306216 systemd[1]: Reached target timers.target - Timer Units. Sep 9 23:38:43.307897 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 23:38:43.310091 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:38:43.313222 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 9 23:38:43.314554 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Sep 9 23:38:43.315560 systemd[1]: Reached target ssh-access.target - SSH Access Available. Sep 9 23:38:43.322390 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 23:38:43.323888 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 9 23:38:43.326069 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 9 23:38:43.327574 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:38:43.328518 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 23:38:43.329252 systemd[1]: Reached target basic.target - Basic System. Sep 9 23:38:43.330044 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:38:43.330074 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 9 23:38:43.331068 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:38:43.332954 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 23:38:43.333853 lvm[1373]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 23:38:43.335576 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 23:38:43.340724 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 23:38:43.341813 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 9 23:38:43.343018 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 23:38:43.343515 jq[1376]: false Sep 9 23:38:43.346509 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 23:38:43.350745 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 23:38:43.358627 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 23:38:43.360106 extend-filesystems[1377]: Found loop2 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found loop3 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda1 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda2 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda3 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found usr Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda4 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda6 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda7 Sep 9 23:38:43.360106 extend-filesystems[1377]: Found vda9 Sep 9 23:38:43.360106 extend-filesystems[1377]: Checking size of /dev/vda9 Sep 9 23:38:43.360053 dbus-daemon[1375]: [system] SELinux support is enabled Sep 9 23:38:43.360325 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 23:38:43.374253 jq[1393]: true Sep 9 23:38:43.360847 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 23:38:43.362665 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 23:38:43.366539 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 23:38:43.368253 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 23:38:43.373223 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 9 23:38:43.375882 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 23:38:43.376071 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 9 23:38:43.376332 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 23:38:43.376565 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 23:38:43.377813 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 23:38:43.377989 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 23:38:43.380765 extend-filesystems[1377]: Old size kept for /dev/vda9 Sep 9 23:38:43.383187 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 23:38:43.383437 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 23:38:43.396238 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 9 23:38:43.396269 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 23:38:43.398161 jq[1398]: true Sep 9 23:38:43.401536 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 9 23:38:43.401558 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 23:38:43.407141 (ntainerd)[1399]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:38:43.413955 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1339) Sep 9 23:38:43.428856 update_engine[1390]: I20250909 23:38:43.428634 1390 main.cc:92] Flatcar Update Engine starting Sep 9 23:38:43.432665 systemd[1]: Started update-engine.service - Update Engine. Sep 9 23:38:43.437457 update_engine[1390]: I20250909 23:38:43.434993 1390 update_check_scheduler.cc:74] Next update check in 11m49s Sep 9 23:38:43.443670 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 23:38:43.448021 systemd-logind[1384]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 23:38:43.454045 systemd-logind[1384]: New seat seat0. Sep 9 23:38:43.456355 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 23:38:43.479229 locksmithd[1418]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 23:38:43.556198 containerd[1399]: time="2025-09-09T23:38:43.556084787Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Sep 9 23:38:43.580975 containerd[1399]: time="2025-09-09T23:38:43.580921587Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.582545 containerd[1399]: time="2025-09-09T23:38:43.582508427Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.104-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:38:43.582624 containerd[1399]: time="2025-09-09T23:38:43.582610587Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.582692547Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.582855187Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.582873627Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.582927547Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.582939467Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583127507Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583142947Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583156667Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583165547Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583231707Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.583839 containerd[1399]: time="2025-09-09T23:38:43.583452187Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:38:43.584047 containerd[1399]: time="2025-09-09T23:38:43.583576427Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:38:43.584047 containerd[1399]: time="2025-09-09T23:38:43.583588907Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 23:38:43.584047 containerd[1399]: time="2025-09-09T23:38:43.583666227Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 23:38:43.584047 containerd[1399]: time="2025-09-09T23:38:43.583705147Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:38:43.646779 bash[1425]: Updated "/home/core/.ssh/authorized_keys" Sep 9 23:38:43.651099 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652650707Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652725107Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652743227Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652788147Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652808667Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.652980067Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653291867Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653411107Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653428627Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653443347Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653457747Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653470467Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653482627Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655484 containerd[1399]: time="2025-09-09T23:38:43.653495547Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.654694 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653509147Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653523387Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653535707Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653547347Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653568027Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653581067Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653593627Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653605867Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653617467Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653630227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653641467Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653654107Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653667267Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.655811 containerd[1399]: time="2025-09-09T23:38:43.653680587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653692227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653703787Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653715787Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653729987Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653752547Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653766947Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656058 containerd[1399]: time="2025-09-09T23:38:43.653777507Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 23:38:43.656817 containerd[1399]: time="2025-09-09T23:38:43.656777907Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 23:38:43.656878 containerd[1399]: time="2025-09-09T23:38:43.656824987Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Sep 9 23:38:43.656878 containerd[1399]: time="2025-09-09T23:38:43.656838267Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 23:38:43.656878 containerd[1399]: time="2025-09-09T23:38:43.656851307Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 9 23:38:43.656878 containerd[1399]: time="2025-09-09T23:38:43.656861547Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.656878 containerd[1399]: time="2025-09-09T23:38:43.656875667Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 23:38:43.656971 containerd[1399]: time="2025-09-09T23:38:43.656886427Z" level=info msg="NRI interface is disabled by configuration." Sep 9 23:38:43.656971 containerd[1399]: time="2025-09-09T23:38:43.656896867Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 23:38:43.657282 containerd[1399]: time="2025-09-09T23:38:43.657238267Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 9 23:38:43.657553 containerd[1399]: time="2025-09-09T23:38:43.657291747Z" level=info msg="Connect containerd service" Sep 9 23:38:43.657553 containerd[1399]: time="2025-09-09T23:38:43.657359507Z" level=info msg="using legacy CRI server" Sep 9 23:38:43.657553 containerd[1399]: time="2025-09-09T23:38:43.657377587Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:38:43.657663 containerd[1399]: time="2025-09-09T23:38:43.657643387Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 23:38:43.658312 containerd[1399]: time="2025-09-09T23:38:43.658287507Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 9 23:38:43.658541 containerd[1399]: time="2025-09-09T23:38:43.658510467Z" level=info msg="Start subscribing containerd event" Sep 9 23:38:43.658791 containerd[1399]: time="2025-09-09T23:38:43.658605547Z" level=info msg="Start recovering state" Sep 9 23:38:43.658791 containerd[1399]: time="2025-09-09T23:38:43.658681747Z" level=info msg="Start event monitor" Sep 9 23:38:43.658791 containerd[1399]: time="2025-09-09T23:38:43.658693107Z" level=info msg="Start snapshots syncer" Sep 9 23:38:43.658791 containerd[1399]: time="2025-09-09T23:38:43.658701827Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:38:43.658791 containerd[1399]: time="2025-09-09T23:38:43.658708907Z" level=info msg="Start streaming server" Sep 9 23:38:43.658893 containerd[1399]: time="2025-09-09T23:38:43.658793867Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:38:43.658893 containerd[1399]: time="2025-09-09T23:38:43.658835627Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:38:43.660053 containerd[1399]: time="2025-09-09T23:38:43.659035787Z" level=info msg="containerd successfully booted in 0.105919s" Sep 9 23:38:43.659133 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:38:43.671037 sshd_keygen[1394]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 23:38:43.689870 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 23:38:43.701686 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 23:38:43.707166 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 23:38:43.708444 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 23:38:43.710987 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 23:38:43.721971 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 23:38:43.724633 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 23:38:43.726599 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 9 23:38:43.727666 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 23:38:44.534549 systemd-networkd[1334]: eth0: Gained IPv6LL Sep 9 23:38:44.538448 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 9 23:38:44.539883 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 23:38:44.552648 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 9 23:38:44.554629 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 23:38:44.569913 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 23:38:44.570179 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 9 23:38:44.571708 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 9 23:38:44.572944 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 23:38:44.574173 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 23:38:44.577500 systemd[1]: Startup finished in 577ms (kernel) + 3.594s (initrd) + 2.814s (userspace) = 6.986s. Sep 9 23:38:50.738707 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 23:38:50.739784 systemd[1]: Started sshd@0-10.0.0.91:22-10.0.0.1:45330.service - OpenSSH per-connection server daemon (10.0.0.1:45330). Sep 9 23:38:50.802027 sshd[1477]: Accepted publickey for core from 10.0.0.1 port 45330 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:50.804161 sshd-session[1477]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:50.813683 systemd-logind[1384]: New session 1 of user core. Sep 9 23:38:50.814666 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 23:38:50.825676 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 23:38:50.834688 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 23:38:50.838716 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 23:38:50.843576 (systemd)[1481]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 23:38:50.845708 systemd-logind[1384]: New session c1 of user core. Sep 9 23:38:50.951563 systemd[1481]: Queued start job for default target default.target. Sep 9 23:38:50.962353 systemd[1481]: Created slice app.slice - User Application Slice. Sep 9 23:38:50.962384 systemd[1481]: Reached target paths.target - Paths. Sep 9 23:38:50.962441 systemd[1481]: Reached target timers.target - Timers. Sep 9 23:38:50.963699 systemd[1481]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 23:38:50.972737 systemd[1481]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 23:38:50.972803 systemd[1481]: Reached target sockets.target - Sockets. Sep 9 23:38:50.972840 systemd[1481]: Reached target basic.target - Basic System. Sep 9 23:38:50.972871 systemd[1481]: Reached target default.target - Main User Target. Sep 9 23:38:50.972898 systemd[1481]: Startup finished in 121ms. Sep 9 23:38:50.973086 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 23:38:50.974487 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 23:38:51.039666 systemd[1]: Started sshd@1-10.0.0.91:22-10.0.0.1:45346.service - OpenSSH per-connection server daemon (10.0.0.1:45346). Sep 9 23:38:51.080973 sshd[1492]: Accepted publickey for core from 10.0.0.1 port 45346 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.082115 sshd-session[1492]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.086173 systemd-logind[1384]: New session 2 of user core. Sep 9 23:38:51.092581 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 23:38:51.145652 sshd[1494]: Connection closed by 10.0.0.1 port 45346 Sep 9 23:38:51.145967 sshd-session[1492]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:51.156442 systemd[1]: sshd@1-10.0.0.91:22-10.0.0.1:45346.service: Deactivated successfully. Sep 9 23:38:51.158166 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 23:38:51.160469 systemd-logind[1384]: Session 2 logged out. Waiting for processes to exit. Sep 9 23:38:51.177743 systemd[1]: Started sshd@2-10.0.0.91:22-10.0.0.1:45362.service - OpenSSH per-connection server daemon (10.0.0.1:45362). Sep 9 23:38:51.178978 systemd-logind[1384]: Removed session 2. Sep 9 23:38:51.214912 sshd[1499]: Accepted publickey for core from 10.0.0.1 port 45362 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.215983 sshd-session[1499]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.219676 systemd-logind[1384]: New session 3 of user core. Sep 9 23:38:51.231560 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 23:38:51.280605 sshd[1502]: Connection closed by 10.0.0.1 port 45362 Sep 9 23:38:51.280923 sshd-session[1499]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:51.297445 systemd[1]: sshd@2-10.0.0.91:22-10.0.0.1:45362.service: Deactivated successfully. Sep 9 23:38:51.299073 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 23:38:51.300286 systemd-logind[1384]: Session 3 logged out. Waiting for processes to exit. Sep 9 23:38:51.308640 systemd[1]: Started sshd@3-10.0.0.91:22-10.0.0.1:45374.service - OpenSSH per-connection server daemon (10.0.0.1:45374). Sep 9 23:38:51.309810 systemd-logind[1384]: Removed session 3. Sep 9 23:38:51.345347 sshd[1507]: Accepted publickey for core from 10.0.0.1 port 45374 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.346490 sshd-session[1507]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.350211 systemd-logind[1384]: New session 4 of user core. Sep 9 23:38:51.364563 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 9 23:38:51.415006 sshd[1510]: Connection closed by 10.0.0.1 port 45374 Sep 9 23:38:51.415303 sshd-session[1507]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:51.425344 systemd[1]: sshd@3-10.0.0.91:22-10.0.0.1:45374.service: Deactivated successfully. Sep 9 23:38:51.426807 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 23:38:51.428003 systemd-logind[1384]: Session 4 logged out. Waiting for processes to exit. Sep 9 23:38:51.429080 systemd[1]: Started sshd@4-10.0.0.91:22-10.0.0.1:45382.service - OpenSSH per-connection server daemon (10.0.0.1:45382). Sep 9 23:38:51.430170 systemd-logind[1384]: Removed session 4. Sep 9 23:38:51.467714 sshd[1515]: Accepted publickey for core from 10.0.0.1 port 45382 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.468936 sshd-session[1515]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.473587 systemd-logind[1384]: New session 5 of user core. Sep 9 23:38:51.480547 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 23:38:51.537504 sudo[1519]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 23:38:51.537769 sudo[1519]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:38:51.556392 sudo[1519]: pam_unix(sudo:session): session closed for user root Sep 9 23:38:51.557730 sshd[1518]: Connection closed by 10.0.0.1 port 45382 Sep 9 23:38:51.558061 sshd-session[1515]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:51.570545 systemd[1]: sshd@4-10.0.0.91:22-10.0.0.1:45382.service: Deactivated successfully. Sep 9 23:38:51.572050 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 23:38:51.572800 systemd-logind[1384]: Session 5 logged out. Waiting for processes to exit. Sep 9 23:38:51.574562 systemd[1]: Started sshd@5-10.0.0.91:22-10.0.0.1:45386.service - OpenSSH per-connection server daemon (10.0.0.1:45386). Sep 9 23:38:51.575835 systemd-logind[1384]: Removed session 5. Sep 9 23:38:51.615141 sshd[1524]: Accepted publickey for core from 10.0.0.1 port 45386 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.616389 sshd-session[1524]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.620641 systemd-logind[1384]: New session 6 of user core. Sep 9 23:38:51.631606 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 23:38:51.683090 sudo[1529]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 9 23:38:51.683374 sudo[1529]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:38:51.686375 sudo[1529]: pam_unix(sudo:session): session closed for user root Sep 9 23:38:51.690657 sudo[1528]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Sep 9 23:38:51.690905 sudo[1528]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:38:51.711749 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 9 23:38:51.735591 augenrules[1551]: No rules Sep 9 23:38:51.736961 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 23:38:51.738446 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 9 23:38:51.739641 sudo[1528]: pam_unix(sudo:session): session closed for user root Sep 9 23:38:51.741231 sshd[1527]: Connection closed by 10.0.0.1 port 45386 Sep 9 23:38:51.741104 sshd-session[1524]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:51.757702 systemd[1]: sshd@5-10.0.0.91:22-10.0.0.1:45386.service: Deactivated successfully. Sep 9 23:38:51.759100 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 23:38:51.759808 systemd-logind[1384]: Session 6 logged out. Waiting for processes to exit. Sep 9 23:38:51.761384 systemd[1]: Started sshd@6-10.0.0.91:22-10.0.0.1:45392.service - OpenSSH per-connection server daemon (10.0.0.1:45392). Sep 9 23:38:51.762114 systemd-logind[1384]: Removed session 6. Sep 9 23:38:51.800763 sshd[1559]: Accepted publickey for core from 10.0.0.1 port 45392 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:51.801848 sshd-session[1559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:51.806133 systemd-logind[1384]: New session 7 of user core. Sep 9 23:38:51.827614 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 23:38:51.890646 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:38:51.891026 (dockerd)[1564]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 9 23:38:52.098000 dockerd[1564]: time="2025-09-09T23:38:52.097833187Z" level=info msg="Starting up" Sep 9 23:38:52.172988 dockerd[1564]: time="2025-09-09T23:38:52.172936227Z" level=info msg="Loading containers: start." Sep 9 23:38:52.317461 kernel: Initializing XFRM netlink socket Sep 9 23:38:52.387170 systemd-networkd[1334]: docker0: Link UP Sep 9 23:38:52.423990 dockerd[1564]: time="2025-09-09T23:38:52.423917507Z" level=info msg="Loading containers: done." Sep 9 23:38:52.537229 dockerd[1564]: time="2025-09-09T23:38:52.537117827Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 9 23:38:52.537467 dockerd[1564]: time="2025-09-09T23:38:52.537272307Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Sep 9 23:38:52.537628 dockerd[1564]: time="2025-09-09T23:38:52.537564707Z" level=info msg="Daemon has completed initialization" Sep 9 23:38:52.616536 dockerd[1564]: time="2025-09-09T23:38:52.616459987Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:38:52.616679 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:38:52.626428 sshd[1562]: Connection closed by 10.0.0.1 port 45392 Sep 9 23:38:52.626748 sshd-session[1559]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:52.636395 systemd[1]: sshd@6-10.0.0.91:22-10.0.0.1:45392.service: Deactivated successfully. Sep 9 23:38:52.637738 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 23:38:52.639589 systemd-logind[1384]: Session 7 logged out. Waiting for processes to exit. Sep 9 23:38:52.649709 systemd[1]: Started sshd@7-10.0.0.91:22-10.0.0.1:45394.service - OpenSSH per-connection server daemon (10.0.0.1:45394). Sep 9 23:38:52.651638 systemd-logind[1384]: Removed session 7. Sep 9 23:38:52.687044 sshd[1755]: Accepted publickey for core from 10.0.0.1 port 45394 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:52.688385 sshd-session[1755]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:52.692479 systemd-logind[1384]: New session 8 of user core. Sep 9 23:38:52.701559 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 9 23:38:53.946443 kernel: docker0: port 1(vethdc6110d) entered blocking state Sep 9 23:38:53.946549 kernel: docker0: port 1(vethdc6110d) entered disabled state Sep 9 23:38:53.946566 kernel: vethdc6110d: entered allmulticast mode Sep 9 23:38:53.947424 kernel: vethdc6110d: entered promiscuous mode Sep 9 23:38:53.949190 systemd-networkd[1334]: vethdc6110d: Link UP Sep 9 23:38:54.037465 containerd[1399]: time="2025-09-09T23:38:54.037189627Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 23:38:54.037465 containerd[1399]: time="2025-09-09T23:38:54.037271547Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 23:38:54.037465 containerd[1399]: time="2025-09-09T23:38:54.037287067Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:38:54.037465 containerd[1399]: time="2025-09-09T23:38:54.037430947Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:38:54.059600 systemd[1]: Started docker-ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf.scope - libcontainer container ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf. Sep 9 23:38:54.109448 kernel: eth0: renamed from vethe028c17 Sep 9 23:38:54.116251 systemd-networkd[1334]: vethdc6110d: Gained carrier Sep 9 23:38:54.116455 kernel: docker0: port 1(vethdc6110d) entered blocking state Sep 9 23:38:54.116483 kernel: docker0: port 1(vethdc6110d) entered forwarding state Sep 9 23:38:54.116689 systemd-networkd[1334]: docker0: Gained carrier Sep 9 23:38:54.121930 systemd-resolved[1263]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:38:54.162852 sshd[1758]: Connection closed by 10.0.0.1 port 45394 Sep 9 23:38:54.163214 sshd-session[1755]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:54.173748 systemd[1]: sshd@7-10.0.0.91:22-10.0.0.1:45394.service: Deactivated successfully. Sep 9 23:38:54.179462 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 23:38:54.183127 systemd-logind[1384]: Session 8 logged out. Waiting for processes to exit. Sep 9 23:38:54.190684 systemd[1]: Started sshd@8-10.0.0.91:22-10.0.0.1:45408.service - OpenSSH per-connection server daemon (10.0.0.1:45408). Sep 9 23:38:54.191588 systemd-logind[1384]: Removed session 8. Sep 9 23:38:54.231455 sshd[1835]: Accepted publickey for core from 10.0.0.1 port 45408 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:54.232973 sshd-session[1835]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:54.240699 systemd-logind[1384]: New session 9 of user core. Sep 9 23:38:54.256639 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 9 23:38:54.311795 sshd[1838]: Connection closed by 10.0.0.1 port 45408 Sep 9 23:38:54.312125 sshd-session[1835]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:54.334717 systemd[1]: sshd@8-10.0.0.91:22-10.0.0.1:45408.service: Deactivated successfully. Sep 9 23:38:54.336509 systemd[1]: session-9.scope: Deactivated successfully. Sep 9 23:38:54.337858 systemd-logind[1384]: Session 9 logged out. Waiting for processes to exit. Sep 9 23:38:54.339491 systemd[1]: Started sshd@9-10.0.0.91:22-10.0.0.1:45420.service - OpenSSH per-connection server daemon (10.0.0.1:45420). Sep 9 23:38:54.340393 systemd-logind[1384]: Removed session 9. Sep 9 23:38:54.384042 sshd[1843]: Accepted publickey for core from 10.0.0.1 port 45420 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:54.385421 sshd-session[1843]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:54.390459 systemd-logind[1384]: New session 10 of user core. Sep 9 23:38:54.402600 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 9 23:38:54.454184 sudo[1847]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1399 Sep 9 23:38:54.454885 sudo[1847]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:38:54.458959 sudo[1847]: pam_unix(sudo:session): session closed for user root Sep 9 23:38:54.461221 containerd[1399]: time="2025-09-09T23:38:54.459150787Z" level=info msg="Stop CRI service" Sep 9 23:38:54.461298 dockerd[1564]: time="2025-09-09T23:38:54.459415107Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 9 23:38:54.461298 dockerd[1564]: time="2025-09-09T23:38:54.459452587Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 23:38:54.461298 dockerd[1564]: time="2025-09-09T23:38:54.459425667Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 23:38:54.461298 dockerd[1564]: time="2025-09-09T23:38:54.459600947Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 23:38:54.462658 sshd[1846]: Connection closed by 10.0.0.1 port 45420 Sep 9 23:38:54.463100 sshd-session[1843]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:54.473529 systemd[1]: containerd.service: Deactivated successfully. Sep 9 23:38:54.473624 systemd[1]: containerd.service: Unit process 1792 (containerd-shim) remains running after unit stopped. Sep 9 23:38:54.473836 systemd[1]: containerd.service: Consumed 311ms CPU time, 136.2M memory peak. Sep 9 23:38:54.474202 systemd[1]: sshd@9-10.0.0.91:22-10.0.0.1:45420.service: Deactivated successfully. Sep 9 23:38:54.475555 systemd[1]: session-10.scope: Deactivated successfully. Sep 9 23:38:54.478009 systemd-logind[1384]: Session 10 logged out. Waiting for processes to exit. Sep 9 23:38:54.478950 systemd[1]: Started sshd@10-10.0.0.91:22-10.0.0.1:45430.service - OpenSSH per-connection server daemon (10.0.0.1:45430). Sep 9 23:38:54.480064 systemd-logind[1384]: Removed session 10. Sep 9 23:38:54.548804 sshd[1853]: Accepted publickey for core from 10.0.0.1 port 45430 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:38:54.550000 sshd-session[1853]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:38:54.554500 systemd-logind[1384]: New session 11 of user core. Sep 9 23:38:54.566591 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 9 23:38:54.621791 sshd[1856]: Connection closed by 10.0.0.1 port 45430 Sep 9 23:38:54.622347 sshd-session[1853]: pam_unix(sshd:session): session closed for user core Sep 9 23:38:54.626903 systemd[1]: sshd@10-10.0.0.91:22-10.0.0.1:45430.service: Deactivated successfully. Sep 9 23:38:54.630977 systemd[1]: session-11.scope: Deactivated successfully. Sep 9 23:38:54.633084 systemd-logind[1384]: Session 11 logged out. Waiting for processes to exit. Sep 9 23:38:54.634231 systemd-logind[1384]: Removed session 11. Sep 9 23:38:55.670590 systemd-networkd[1334]: docker0: Gained IPv6LL Sep 9 23:38:55.926574 systemd-networkd[1334]: vethdc6110d: Gained IPv6LL Sep 9 23:38:59.724154 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 9 23:38:59.724528 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 23:38:59.726007 dockerd[1564]: time="2025-09-09T23:38:59.724999187Z" level=info msg="Processing signal 'terminated'" Sep 9 23:39:00.649760 systemd[1]: Started sshd@11-10.0.0.91:22-10.0.0.1:48462.service - OpenSSH per-connection server daemon (10.0.0.1:48462). Sep 9 23:39:00.708047 sshd[1862]: Accepted publickey for core from 10.0.0.1 port 48462 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:00.710090 sshd-session[1862]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:00.715333 systemd-logind[1384]: New session 12 of user core. Sep 9 23:39:00.724651 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 9 23:39:00.781311 sshd[1864]: Connection closed by 10.0.0.1 port 48462 Sep 9 23:39:00.781866 sshd-session[1862]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:00.785784 systemd[1]: sshd@11-10.0.0.91:22-10.0.0.1:48462.service: Deactivated successfully. Sep 9 23:39:00.787943 systemd[1]: session-12.scope: Deactivated successfully. Sep 9 23:39:00.789182 systemd-logind[1384]: Session 12 logged out. Waiting for processes to exit. Sep 9 23:39:00.790866 systemd-logind[1384]: Removed session 12. Sep 9 23:39:01.726808 dockerd[1564]: time="2025-09-09T23:39:01.726550627Z" level=error msg="Error sending stop (signal 15) to container" container=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf error="Cannot kill container ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Sep 9 23:39:01.726808 dockerd[1564]: time="2025-09-09T23:39:01.726608427Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf Sep 9 23:39:06.798657 systemd[1]: Started sshd@12-10.0.0.91:22-10.0.0.1:48476.service - OpenSSH per-connection server daemon (10.0.0.1:48476). Sep 9 23:39:06.844900 sshd[1870]: Accepted publickey for core from 10.0.0.1 port 48476 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:06.846429 sshd-session[1870]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:06.855795 systemd-logind[1384]: New session 13 of user core. Sep 9 23:39:06.865646 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 9 23:39:06.924255 sshd[1872]: Connection closed by 10.0.0.1 port 48476 Sep 9 23:39:06.924809 sshd-session[1870]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:06.928697 systemd[1]: sshd@12-10.0.0.91:22-10.0.0.1:48476.service: Deactivated successfully. Sep 9 23:39:06.930359 systemd[1]: session-13.scope: Deactivated successfully. Sep 9 23:39:06.935512 systemd-logind[1384]: Session 13 logged out. Waiting for processes to exit. Sep 9 23:39:06.936578 systemd-logind[1384]: Removed session 13. Sep 9 23:39:11.727854 dockerd[1564]: time="2025-09-09T23:39:11.727770467Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf error="context deadline exceeded" Sep 9 23:39:11.729094 systemd[1]: docker-ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf.scope: Deactivated successfully. Sep 9 23:39:12.938773 systemd[1]: Started sshd@13-10.0.0.91:22-10.0.0.1:37740.service - OpenSSH per-connection server daemon (10.0.0.1:37740). Sep 9 23:39:12.990541 sshd[1879]: Accepted publickey for core from 10.0.0.1 port 37740 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:12.993696 sshd-session[1879]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:13.000139 systemd-logind[1384]: New session 14 of user core. Sep 9 23:39:13.010622 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 9 23:39:13.066871 sshd[1881]: Connection closed by 10.0.0.1 port 37740 Sep 9 23:39:13.067428 sshd-session[1879]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:13.070993 systemd[1]: sshd@13-10.0.0.91:22-10.0.0.1:37740.service: Deactivated successfully. Sep 9 23:39:13.073985 systemd[1]: session-14.scope: Deactivated successfully. Sep 9 23:39:13.075043 systemd-logind[1384]: Session 14 logged out. Waiting for processes to exit. Sep 9 23:39:13.076043 systemd-logind[1384]: Removed session 14. Sep 9 23:39:14.726124 dockerd[1564]: time="2025-09-09T23:39:14.725990587Z" level=error msg="Force shutdown daemon" Sep 9 23:39:14.729520 dockerd[1564]: time="2025-09-09T23:39:14.726495067Z" level=info msg="Daemon shutdown complete" Sep 9 23:39:14.732158 systemd[1]: docker.service: Deactivated successfully. Sep 9 23:39:14.733342 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 23:39:14.733657 systemd[1]: docker.service: Consumed 897ms CPU time, 143.3M memory peak. Sep 9 23:39:14.736566 systemd[1]: docker.socket: Deactivated successfully. Sep 9 23:39:14.737329 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 23:39:14.737461 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 23:39:14.739393 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:39:14.739632 systemd[1]: containerd.service: Found left-over process 1792 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:39:14.739641 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:39:14.746774 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:39:14.747714 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:39:14.759758 systemd[1]: containerd.service: Found left-over process 1792 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:39:14.759769 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:39:14.767133 (ntainerd)[1892]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:39:14.792312 containerd[1892]: time="2025-09-09T23:39:14.792229427Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Sep 9 23:39:14.820633 containerd[1892]: time="2025-09-09T23:39:14.820490507Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.822790 containerd[1892]: time="2025-09-09T23:39:14.822718307Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.104-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:14.822790 containerd[1892]: time="2025-09-09T23:39:14.822766827Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 23:39:14.822790 containerd[1892]: time="2025-09-09T23:39:14.822785707Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 23:39:14.822918 containerd[1892]: time="2025-09-09T23:39:14.822829027Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 23:39:14.822918 containerd[1892]: time="2025-09-09T23:39:14.822844747Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.822918 containerd[1892]: time="2025-09-09T23:39:14.822868547Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:14.822918 containerd[1892]: time="2025-09-09T23:39:14.822878867Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823107 containerd[1892]: time="2025-09-09T23:39:14.823063707Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823107 containerd[1892]: time="2025-09-09T23:39:14.823093307Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823107 containerd[1892]: time="2025-09-09T23:39:14.823105947Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823182 containerd[1892]: time="2025-09-09T23:39:14.823114667Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823182 containerd[1892]: time="2025-09-09T23:39:14.823138027Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823395 containerd[1892]: time="2025-09-09T23:39:14.823356707Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823582 containerd[1892]: time="2025-09-09T23:39:14.823544587Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:14.823582 containerd[1892]: time="2025-09-09T23:39:14.823567147Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 23:39:14.823667 containerd[1892]: time="2025-09-09T23:39:14.823593987Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 23:39:14.823667 containerd[1892]: time="2025-09-09T23:39:14.823612307Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:39:14.823958 containerd[1892]: time="2025-09-09T23:39:14.823878187Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 23:39:14.823958 containerd[1892]: time="2025-09-09T23:39:14.823922547Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 23:39:14.823958 containerd[1892]: time="2025-09-09T23:39:14.823938787Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 23:39:14.823958 containerd[1892]: time="2025-09-09T23:39:14.823954427Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 23:39:14.824136 containerd[1892]: time="2025-09-09T23:39:14.823968667Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 23:39:14.824136 containerd[1892]: time="2025-09-09T23:39:14.824031427Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 23:39:14.824287 containerd[1892]: time="2025-09-09T23:39:14.824268827Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 23:39:14.833348 containerd[1892]: time="2025-09-09T23:39:14.833302387Z" level=info msg="cleaning leaked shim process" id=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf namespace=moby Sep 9 23:39:14.846694 containerd[1892]: time="2025-09-09T23:39:14.846563107Z" level=info msg="shim disconnected" id=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf namespace=moby Sep 9 23:39:14.846694 containerd[1892]: time="2025-09-09T23:39:14.846635387Z" level=warning msg="cleaning up after shim disconnected" id=ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf namespace=moby Sep 9 23:39:14.846694 containerd[1892]: time="2025-09-09T23:39:14.846644267Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 23:39:14.846694 containerd[1892]: time="2025-09-09T23:39:14.846569947Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 9 23:39:14.863612 containerd[1892]: time="2025-09-09T23:39:14.863546027Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 23:39:14.863612 containerd[1892]: time="2025-09-09T23:39:14.863590587Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 23:39:14.863612 containerd[1892]: time="2025-09-09T23:39:14.863609187Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863628587Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863643387Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863656747Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863672227Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863707067Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863721307Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863733867Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863746227Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863768387Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863783507Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863797987Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863811147Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863823227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.863847 containerd[1892]: time="2025-09-09T23:39:14.863836107Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863847507Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863866587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863879587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863894947Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863906307Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863918227Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863931067Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863946227Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863970187Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863982667Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.863996067Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.864054827Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.864073427Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Sep 9 23:39:14.864129 containerd[1892]: time="2025-09-09T23:39:14.864085547Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 23:39:14.864369 containerd[1892]: time="2025-09-09T23:39:14.864097547Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 9 23:39:14.864369 containerd[1892]: time="2025-09-09T23:39:14.864106707Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864369 containerd[1892]: time="2025-09-09T23:39:14.864118467Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 23:39:14.864369 containerd[1892]: time="2025-09-09T23:39:14.864130867Z" level=info msg="NRI interface is disabled by configuration." Sep 9 23:39:14.864369 containerd[1892]: time="2025-09-09T23:39:14.864141587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 23:39:14.864578 containerd[1892]: time="2025-09-09T23:39:14.864482787Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 9 23:39:14.864578 containerd[1892]: time="2025-09-09T23:39:14.864544267Z" level=info msg="Connect containerd service" Sep 9 23:39:14.864756 containerd[1892]: time="2025-09-09T23:39:14.864583627Z" level=info msg="using legacy CRI server" Sep 9 23:39:14.864756 containerd[1892]: time="2025-09-09T23:39:14.864592267Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:39:14.864756 containerd[1892]: time="2025-09-09T23:39:14.864699627Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 23:39:14.865481 containerd[1892]: time="2025-09-09T23:39:14.865447147Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 9 23:39:14.865700 containerd[1892]: time="2025-09-09T23:39:14.865652187Z" level=info msg="Start subscribing containerd event" Sep 9 23:39:14.865727 containerd[1892]: time="2025-09-09T23:39:14.865710587Z" level=info msg="Start recovering state" Sep 9 23:39:14.865760 containerd[1892]: time="2025-09-09T23:39:14.865745467Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:39:14.865797 containerd[1892]: time="2025-09-09T23:39:14.865786347Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:39:14.866729 containerd[1892]: time="2025-09-09T23:39:14.866695707Z" level=info msg="Start event monitor" Sep 9 23:39:14.866779 containerd[1892]: time="2025-09-09T23:39:14.866729827Z" level=info msg="Start snapshots syncer" Sep 9 23:39:14.866779 containerd[1892]: time="2025-09-09T23:39:14.866743107Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:39:14.866779 containerd[1892]: time="2025-09-09T23:39:14.866758667Z" level=info msg="Start streaming server" Sep 9 23:39:14.866919 containerd[1892]: time="2025-09-09T23:39:14.866898427Z" level=info msg="containerd successfully booted in 0.075866s" Sep 9 23:39:14.867645 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:39:14.879771 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:39:14.879889 (dockerd)[1926]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 9 23:39:14.908408 dockerd[1926]: time="2025-09-09T23:39:14.908221587Z" level=info msg="Starting up" Sep 9 23:39:14.943845 dockerd[1926]: time="2025-09-09T23:39:14.943791547Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 23:39:14.951448 dockerd[1926]: time="2025-09-09T23:39:14.951365587Z" level=info msg="Loading containers: start." Sep 9 23:39:14.967621 systemd[1]: var-lib-docker-overlay2-080b886fb5c48fa112c2149d3b0e48a4e3938e75a6c03a1f1b13711db8091a15-merged.mount: Deactivated successfully. Sep 9 23:39:15.293513 dockerd[1926]: time="2025-09-09T23:39:15.293181307Z" level=info msg="Removing stale sandbox 67f124b7f5a7f8d53b782e149a98ba35415ae3fcae6537a06efc23283fa23e4c (ceaa5f2da7543139441de576193d6f141c273099d56cca718bc32c326156aaaf)" Sep 9 23:39:15.296335 dockerd[1926]: time="2025-09-09T23:39:15.296284547Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 317bd0ee1e7e4a4b19736f7875854426bf70a56f2ca635252cb5c6a785fcc91d 77ff84465d835bf963ff2eba8cfeaf783138ff52c10063da4774473e919f84c2], retrying...." Sep 9 23:39:15.301468 kernel: docker0: port 1(vethdc6110d) entered disabled state Sep 9 23:39:15.300869 systemd-networkd[1334]: vethdc6110d: Link DOWN Sep 9 23:39:15.300875 systemd-networkd[1334]: vethdc6110d: Lost carrier Sep 9 23:39:15.303489 kernel: vethdc6110d (unregistering): left allmulticast mode Sep 9 23:39:15.303584 kernel: vethdc6110d (unregistering): left promiscuous mode Sep 9 23:39:15.303602 kernel: docker0: port 1(vethdc6110d) entered disabled state Sep 9 23:39:15.316337 systemd-networkd[1334]: docker0: Lost carrier Sep 9 23:39:15.443084 dockerd[1926]: time="2025-09-09T23:39:15.443021787Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Sep 9 23:39:15.530292 dockerd[1926]: time="2025-09-09T23:39:15.530206707Z" level=warning msg="error locating sandbox id 67f124b7f5a7f8d53b782e149a98ba35415ae3fcae6537a06efc23283fa23e4c: sandbox 67f124b7f5a7f8d53b782e149a98ba35415ae3fcae6537a06efc23283fa23e4c not found" Sep 9 23:39:15.530429 dockerd[1926]: time="2025-09-09T23:39:15.530307947Z" level=info msg="Loading containers: done." Sep 9 23:39:15.552975 dockerd[1926]: time="2025-09-09T23:39:15.552834347Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 9 23:39:15.552975 dockerd[1926]: time="2025-09-09T23:39:15.552953227Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Sep 9 23:39:15.553184 dockerd[1926]: time="2025-09-09T23:39:15.553010507Z" level=info msg="Daemon has completed initialization" Sep 9 23:39:15.590762 dockerd[1926]: time="2025-09-09T23:39:15.590694107Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:39:15.590918 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:39:15.929880 systemd[1]: run-docker-netns-67f124b7f5a7.mount: Deactivated successfully. Sep 9 23:39:19.080563 systemd[1]: Started sshd@14-10.0.0.91:22-10.0.0.1:37752.service - OpenSSH per-connection server daemon (10.0.0.1:37752). Sep 9 23:39:19.124022 sshd[2124]: Accepted publickey for core from 10.0.0.1 port 37752 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:19.125475 sshd-session[2124]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:19.129780 systemd-logind[1384]: New session 15 of user core. Sep 9 23:39:19.144704 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 9 23:39:19.200743 sshd[2126]: Connection closed by 10.0.0.1 port 37752 Sep 9 23:39:19.200907 sshd-session[2124]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:19.214837 systemd[1]: sshd@14-10.0.0.91:22-10.0.0.1:37752.service: Deactivated successfully. Sep 9 23:39:19.218160 systemd[1]: session-15.scope: Deactivated successfully. Sep 9 23:39:19.218996 systemd-logind[1384]: Session 15 logged out. Waiting for processes to exit. Sep 9 23:39:19.231852 systemd[1]: Started sshd@15-10.0.0.91:22-10.0.0.1:37764.service - OpenSSH per-connection server daemon (10.0.0.1:37764). Sep 9 23:39:19.233162 systemd-logind[1384]: Removed session 15. Sep 9 23:39:19.273255 sshd[2131]: Accepted publickey for core from 10.0.0.1 port 37764 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:19.274509 sshd-session[2131]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:19.278790 systemd-logind[1384]: New session 16 of user core. Sep 9 23:39:19.286636 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 9 23:39:19.343744 sshd[2134]: Connection closed by 10.0.0.1 port 37764 Sep 9 23:39:19.344279 sshd-session[2131]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:19.363803 systemd[1]: sshd@15-10.0.0.91:22-10.0.0.1:37764.service: Deactivated successfully. Sep 9 23:39:19.365650 systemd[1]: session-16.scope: Deactivated successfully. Sep 9 23:39:19.366521 systemd-logind[1384]: Session 16 logged out. Waiting for processes to exit. Sep 9 23:39:19.379710 systemd[1]: Started sshd@16-10.0.0.91:22-10.0.0.1:37778.service - OpenSSH per-connection server daemon (10.0.0.1:37778). Sep 9 23:39:19.381810 systemd-logind[1384]: Removed session 16. Sep 9 23:39:19.420017 sshd[2139]: Accepted publickey for core from 10.0.0.1 port 37778 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:19.421265 sshd-session[2139]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:19.427529 systemd-logind[1384]: New session 17 of user core. Sep 9 23:39:19.448635 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 9 23:39:19.509482 sshd[2142]: Connection closed by 10.0.0.1 port 37778 Sep 9 23:39:19.510027 sshd-session[2139]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:19.521961 systemd[1]: sshd@16-10.0.0.91:22-10.0.0.1:37778.service: Deactivated successfully. Sep 9 23:39:19.526946 systemd[1]: session-17.scope: Deactivated successfully. Sep 9 23:39:19.529543 systemd-logind[1384]: Session 17 logged out. Waiting for processes to exit. Sep 9 23:39:19.544918 systemd[1]: Started sshd@17-10.0.0.91:22-10.0.0.1:37790.service - OpenSSH per-connection server daemon (10.0.0.1:37790). Sep 9 23:39:19.546213 systemd-logind[1384]: Removed session 17. Sep 9 23:39:19.584764 sshd[2154]: Accepted publickey for core from 10.0.0.1 port 37790 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:19.586326 sshd-session[2154]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:19.591912 systemd-logind[1384]: New session 18 of user core. Sep 9 23:39:19.609641 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 9 23:39:19.695891 systemd[1]: var-lib-docker-overlay2-5e22f0dc7c09f7a1bf62fbb8438ff94574cf15510475a3720e7b6d34d5709183\x2dinit-merged.mount: Deactivated successfully. Sep 9 23:39:19.740965 kernel: docker0: port 1(vethb5b5035) entered blocking state Sep 9 23:39:19.741101 kernel: docker0: port 1(vethb5b5035) entered disabled state Sep 9 23:39:19.741140 kernel: vethb5b5035: entered allmulticast mode Sep 9 23:39:19.742446 kernel: vethb5b5035: entered promiscuous mode Sep 9 23:39:19.745415 systemd-networkd[1334]: vethb5b5035: Link UP Sep 9 23:39:19.786984 containerd[1892]: time="2025-09-09T23:39:19.786832322Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 23:39:19.786984 containerd[1892]: time="2025-09-09T23:39:19.786946683Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 23:39:19.787495 containerd[1892]: time="2025-09-09T23:39:19.786965683Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:39:19.787495 containerd[1892]: time="2025-09-09T23:39:19.787084044Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:39:19.811612 systemd[1]: Started docker-c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c.scope - libcontainer container c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c. Sep 9 23:39:19.864439 kernel: eth0: renamed from vethf4652d8 Sep 9 23:39:19.879359 systemd-networkd[1334]: vethb5b5035: Gained carrier Sep 9 23:39:19.879548 kernel: docker0: port 1(vethb5b5035) entered blocking state Sep 9 23:39:19.879575 kernel: docker0: port 1(vethb5b5035) entered forwarding state Sep 9 23:39:19.879779 systemd-networkd[1334]: docker0: Gained carrier Sep 9 23:39:19.883059 systemd-resolved[1263]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:39:19.912763 sshd[2157]: Connection closed by 10.0.0.1 port 37790 Sep 9 23:39:19.910989 sshd-session[2154]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:19.923914 systemd[1]: sshd@17-10.0.0.91:22-10.0.0.1:37790.service: Deactivated successfully. Sep 9 23:39:19.927178 systemd[1]: session-18.scope: Deactivated successfully. Sep 9 23:39:19.928046 systemd-logind[1384]: Session 18 logged out. Waiting for processes to exit. Sep 9 23:39:19.937804 systemd[1]: Started sshd@18-10.0.0.91:22-10.0.0.1:56142.service - OpenSSH per-connection server daemon (10.0.0.1:56142). Sep 9 23:39:19.939150 systemd-logind[1384]: Removed session 18. Sep 9 23:39:19.976923 sshd[2233]: Accepted publickey for core from 10.0.0.1 port 56142 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:19.978312 sshd-session[2233]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:19.982689 systemd-logind[1384]: New session 19 of user core. Sep 9 23:39:20.008639 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 9 23:39:20.064112 sshd[2236]: Connection closed by 10.0.0.1 port 56142 Sep 9 23:39:20.064535 sshd-session[2233]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:20.079987 systemd[1]: sshd@18-10.0.0.91:22-10.0.0.1:56142.service: Deactivated successfully. Sep 9 23:39:20.081845 systemd[1]: session-19.scope: Deactivated successfully. Sep 9 23:39:20.084617 systemd-logind[1384]: Session 19 logged out. Waiting for processes to exit. Sep 9 23:39:20.093817 systemd[1]: Started sshd@19-10.0.0.91:22-10.0.0.1:56152.service - OpenSSH per-connection server daemon (10.0.0.1:56152). Sep 9 23:39:20.095304 systemd-logind[1384]: Removed session 19. Sep 9 23:39:20.133704 sshd[2241]: Accepted publickey for core from 10.0.0.1 port 56152 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:20.135946 sshd-session[2241]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:20.141294 systemd-logind[1384]: New session 20 of user core. Sep 9 23:39:20.152633 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 9 23:39:20.206201 sudo[2245]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1892 Sep 9 23:39:20.206601 sudo[2245]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 23:39:20.209986 sudo[2245]: pam_unix(sudo:session): session closed for user root Sep 9 23:39:20.212441 sshd[2244]: Connection closed by 10.0.0.1 port 56152 Sep 9 23:39:20.212723 dockerd[1926]: time="2025-09-09T23:39:20.212539841Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 23:39:20.212723 dockerd[1926]: time="2025-09-09T23:39:20.212588282Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 23:39:20.212723 dockerd[1926]: time="2025-09-09T23:39:20.212636002Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 9 23:39:20.212723 dockerd[1926]: time="2025-09-09T23:39:20.212667082Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 23:39:20.213199 sshd-session[2241]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:20.227013 systemd[1]: containerd.service: Deactivated successfully. Sep 9 23:39:20.227122 systemd[1]: containerd.service: Unit process 2187 (containerd-shim) remains running after unit stopped. Sep 9 23:39:20.227447 systemd[1]: containerd.service: Consumed 216ms CPU time, 139.3M memory peak. Sep 9 23:39:20.227951 systemd[1]: sshd@19-10.0.0.91:22-10.0.0.1:56152.service: Deactivated successfully. Sep 9 23:39:20.229752 systemd[1]: session-20.scope: Deactivated successfully. Sep 9 23:39:20.232764 systemd-logind[1384]: Session 20 logged out. Waiting for processes to exit. Sep 9 23:39:20.238785 systemd[1]: Started sshd@20-10.0.0.91:22-10.0.0.1:56156.service - OpenSSH per-connection server daemon (10.0.0.1:56156). Sep 9 23:39:20.239465 systemd-logind[1384]: Removed session 20. Sep 9 23:39:20.280720 sshd[2251]: Accepted publickey for core from 10.0.0.1 port 56156 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:20.282229 sshd-session[2251]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:20.287238 systemd-logind[1384]: New session 21 of user core. Sep 9 23:39:20.298622 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 9 23:39:20.358241 sshd[2254]: Connection closed by 10.0.0.1 port 56156 Sep 9 23:39:20.358667 sshd-session[2251]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:20.362627 systemd[1]: sshd@20-10.0.0.91:22-10.0.0.1:56156.service: Deactivated successfully. Sep 9 23:39:20.365023 systemd[1]: session-21.scope: Deactivated successfully. Sep 9 23:39:20.365878 systemd-logind[1384]: Session 21 logged out. Waiting for processes to exit. Sep 9 23:39:20.366765 systemd-logind[1384]: Removed session 21. Sep 9 23:39:21.142638 systemd-networkd[1334]: vethb5b5035: Gained IPv6LL Sep 9 23:39:25.280691 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 9 23:39:25.281028 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 23:39:25.281215 dockerd[1926]: time="2025-09-09T23:39:25.281150042Z" level=info msg="Processing signal 'terminated'" Sep 9 23:39:26.370232 systemd[1]: Started sshd@21-10.0.0.91:22-10.0.0.1:56164.service - OpenSSH per-connection server daemon (10.0.0.1:56164). Sep 9 23:39:26.411156 sshd[2260]: Accepted publickey for core from 10.0.0.1 port 56164 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:26.412549 sshd-session[2260]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:26.418563 systemd-logind[1384]: New session 22 of user core. Sep 9 23:39:26.427684 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 9 23:39:26.488888 sshd[2262]: Connection closed by 10.0.0.1 port 56164 Sep 9 23:39:26.489333 sshd-session[2260]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:26.494562 systemd[1]: sshd@21-10.0.0.91:22-10.0.0.1:56164.service: Deactivated successfully. Sep 9 23:39:26.496964 systemd[1]: session-22.scope: Deactivated successfully. Sep 9 23:39:26.500585 systemd-logind[1384]: Session 22 logged out. Waiting for processes to exit. Sep 9 23:39:26.501674 systemd-logind[1384]: Removed session 22. Sep 9 23:39:27.283458 dockerd[1926]: time="2025-09-09T23:39:27.283252969Z" level=error msg="Error sending stop (signal 15) to container" container=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c error="Cannot kill container c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Sep 9 23:39:27.283458 dockerd[1926]: time="2025-09-09T23:39:27.283311169Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c Sep 9 23:39:28.594064 update_engine[1390]: I20250909 23:39:28.593951 1390 update_attempter.cc:509] Updating boot flags... Sep 9 23:39:28.619423 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2274) Sep 9 23:39:28.654106 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2275) Sep 9 23:39:32.499371 systemd[1]: Started sshd@22-10.0.0.91:22-10.0.0.1:41754.service - OpenSSH per-connection server daemon (10.0.0.1:41754). Sep 9 23:39:32.539912 sshd[2282]: Accepted publickey for core from 10.0.0.1 port 41754 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:32.541470 sshd-session[2282]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:32.545432 systemd-logind[1384]: New session 23 of user core. Sep 9 23:39:32.556671 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 9 23:39:32.614821 sshd[2284]: Connection closed by 10.0.0.1 port 41754 Sep 9 23:39:32.615155 sshd-session[2282]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:32.622082 systemd[1]: sshd@22-10.0.0.91:22-10.0.0.1:41754.service: Deactivated successfully. Sep 9 23:39:32.623706 systemd[1]: session-23.scope: Deactivated successfully. Sep 9 23:39:32.624866 systemd-logind[1384]: Session 23 logged out. Waiting for processes to exit. Sep 9 23:39:32.625680 systemd-logind[1384]: Removed session 23. Sep 9 23:39:37.284726 dockerd[1926]: time="2025-09-09T23:39:37.284485612Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c error="context deadline exceeded" Sep 9 23:39:37.285132 systemd[1]: docker-c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c.scope: Deactivated successfully. Sep 9 23:39:38.626515 systemd[1]: Started sshd@23-10.0.0.91:22-10.0.0.1:41762.service - OpenSSH per-connection server daemon (10.0.0.1:41762). Sep 9 23:39:38.669042 sshd[2290]: Accepted publickey for core from 10.0.0.1 port 41762 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:38.670622 sshd-session[2290]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:38.674099 systemd-logind[1384]: New session 24 of user core. Sep 9 23:39:38.685591 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 9 23:39:38.740344 sshd[2292]: Connection closed by 10.0.0.1 port 41762 Sep 9 23:39:38.740807 sshd-session[2290]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:38.744736 systemd[1]: sshd@23-10.0.0.91:22-10.0.0.1:41762.service: Deactivated successfully. Sep 9 23:39:38.746420 systemd[1]: session-24.scope: Deactivated successfully. Sep 9 23:39:38.747016 systemd-logind[1384]: Session 24 logged out. Waiting for processes to exit. Sep 9 23:39:38.747825 systemd-logind[1384]: Removed session 24. Sep 9 23:39:40.281716 dockerd[1926]: time="2025-09-09T23:39:40.281613641Z" level=error msg="Force shutdown daemon" Sep 9 23:39:40.282213 dockerd[1926]: time="2025-09-09T23:39:40.281857481Z" level=info msg="Daemon shutdown complete" Sep 9 23:39:40.286528 systemd[1]: docker.service: Deactivated successfully. Sep 9 23:39:40.287114 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 23:39:40.288048 systemd[1]: docker.socket: Deactivated successfully. Sep 9 23:39:40.289031 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 23:39:40.289098 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 23:39:40.291707 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 23:39:40.291946 systemd[1]: containerd.service: Found left-over process 2187 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:39:40.291954 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:39:40.299786 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 23:39:40.300441 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 23:39:40.309901 systemd[1]: containerd.service: Found left-over process 2187 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 23:39:40.309914 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 23:39:40.316428 (ntainerd)[2303]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 23:39:40.334767 containerd[2303]: time="2025-09-09T23:39:40.334688090Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Sep 9 23:39:40.361719 containerd[2303]: time="2025-09-09T23:39:40.361665055Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363105657Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.104-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363140417Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363157577Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363206697Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363220577Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363258457Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363447 containerd[2303]: time="2025-09-09T23:39:40.363271777Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363514138Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." 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" type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363530018Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363542778Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363552538Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363577058Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363691 containerd[2303]: time="2025-09-09T23:39:40.363670178Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363809 containerd[2303]: time="2025-09-09T23:39:40.363795458Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 23:39:40.363828 containerd[2303]: time="2025-09-09T23:39:40.363808058Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 23:39:40.363845 containerd[2303]: time="2025-09-09T23:39:40.363827458Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 23:39:40.363845 containerd[2303]: time="2025-09-09T23:39:40.363842498Z" level=info msg="metadata content store policy set" policy=shared Sep 9 23:39:40.364102 containerd[2303]: time="2025-09-09T23:39:40.364072739Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 23:39:40.364164 containerd[2303]: time="2025-09-09T23:39:40.364108379Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 23:39:40.364164 containerd[2303]: time="2025-09-09T23:39:40.364161139Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 23:39:40.364225 containerd[2303]: time="2025-09-09T23:39:40.364191579Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 23:39:40.364225 containerd[2303]: time="2025-09-09T23:39:40.364205259Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 23:39:40.364298 containerd[2303]: time="2025-09-09T23:39:40.364284579Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 23:39:40.364571 containerd[2303]: time="2025-09-09T23:39:40.364545340Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 23:39:40.372350 containerd[2303]: time="2025-09-09T23:39:40.372303673Z" level=info msg="cleaning leaked shim process" id=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c namespace=moby Sep 9 23:39:40.383293 containerd[2303]: time="2025-09-09T23:39:40.383197771Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 9 23:39:40.384693 containerd[2303]: time="2025-09-09T23:39:40.384609173Z" level=info msg="shim disconnected" id=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c namespace=moby Sep 9 23:39:40.384693 containerd[2303]: time="2025-09-09T23:39:40.384691173Z" level=warning msg="cleaning up after shim disconnected" id=c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c namespace=moby Sep 9 23:39:40.384768 containerd[2303]: time="2025-09-09T23:39:40.384700813Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 23:39:40.399307 containerd[2303]: time="2025-09-09T23:39:40.399262678Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 23:39:40.399307 containerd[2303]: time="2025-09-09T23:39:40.399306798Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399328038Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399343678Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399357038Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399370078Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399392558Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399430078Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399443838Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399463 containerd[2303]: time="2025-09-09T23:39:40.399458998Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399471758Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399493238Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399506038Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399520078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399532478Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399544598Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399558398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399570478Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399583918Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399596158Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399608 containerd[2303]: time="2025-09-09T23:39:40.399610918Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399624078Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399636398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399649038Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399665078Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399693118Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399707278Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399718638Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399778639Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399798479Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399808479Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399819759Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399829199Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.399840 containerd[2303]: time="2025-09-09T23:39:40.399846159Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 23:39:40.400060 containerd[2303]: time="2025-09-09T23:39:40.399856679Z" level=info msg="NRI interface is disabled by configuration." Sep 9 23:39:40.400060 containerd[2303]: time="2025-09-09T23:39:40.399871119Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 23:39:40.400172 containerd[2303]: time="2025-09-09T23:39:40.400122159Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 9 23:39:40.400258 containerd[2303]: time="2025-09-09T23:39:40.400172359Z" level=info msg="Connect containerd service" Sep 9 23:39:40.400258 containerd[2303]: time="2025-09-09T23:39:40.400207319Z" level=info msg="using legacy CRI server" Sep 9 23:39:40.400258 containerd[2303]: time="2025-09-09T23:39:40.400215559Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 23:39:40.400535 containerd[2303]: time="2025-09-09T23:39:40.400437600Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 23:39:40.401083 containerd[2303]: time="2025-09-09T23:39:40.401056801Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 9 23:39:40.401350 containerd[2303]: time="2025-09-09T23:39:40.401207521Z" level=info msg="Start subscribing containerd event" Sep 9 23:39:40.401350 containerd[2303]: time="2025-09-09T23:39:40.401265121Z" level=info msg="Start recovering state" Sep 9 23:39:40.401350 containerd[2303]: time="2025-09-09T23:39:40.401318601Z" level=info msg="Start event monitor" Sep 9 23:39:40.401350 containerd[2303]: time="2025-09-09T23:39:40.401321081Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 23:39:40.401484 containerd[2303]: time="2025-09-09T23:39:40.401329401Z" level=info msg="Start snapshots syncer" Sep 9 23:39:40.401484 containerd[2303]: time="2025-09-09T23:39:40.401371601Z" level=info msg="Start cni network conf syncer for default" Sep 9 23:39:40.401484 containerd[2303]: time="2025-09-09T23:39:40.401377441Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 23:39:40.401484 containerd[2303]: time="2025-09-09T23:39:40.401380441Z" level=info msg="Start streaming server" Sep 9 23:39:40.401552 containerd[2303]: time="2025-09-09T23:39:40.401485721Z" level=info msg="containerd successfully booted in 0.067362s" Sep 9 23:39:40.401593 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 23:39:40.417764 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 23:39:40.417856 (dockerd)[2338]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Sep 9 23:39:40.444201 dockerd[2338]: time="2025-09-09T23:39:40.444145953Z" level=info msg="Starting up" Sep 9 23:39:40.476836 dockerd[2338]: time="2025-09-09T23:39:40.476783728Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 23:39:40.483316 dockerd[2338]: time="2025-09-09T23:39:40.483261658Z" level=info msg="Loading containers: start." Sep 9 23:39:40.498166 systemd[1]: var-lib-docker-overlay2-5e22f0dc7c09f7a1bf62fbb8438ff94574cf15510475a3720e7b6d34d5709183-merged.mount: Deactivated successfully. Sep 9 23:39:40.831469 dockerd[2338]: time="2025-09-09T23:39:40.831429602Z" level=info msg="Removing stale sandbox 9e3ecb55af6b6b6714d415358caa9a95651baac3db6125c8c410d59d93749dd0 (c9fc0179381cf4c962d94806ae8c4f4a54aa33ff2454112e61eca8eb1d7dd23c)" Sep 9 23:39:40.832075 systemd[1]: run-docker-netns-9e3ecb55af6b.mount: Deactivated successfully. Sep 9 23:39:40.839343 systemd-networkd[1334]: vethb5b5035: Link DOWN Sep 9 23:39:40.839350 systemd-networkd[1334]: vethb5b5035: Lost carrier Sep 9 23:39:40.840146 kernel: docker0: port 1(vethb5b5035) entered disabled state Sep 9 23:39:40.841521 kernel: vethb5b5035 (unregistering): left allmulticast mode Sep 9 23:39:40.841573 kernel: vethb5b5035 (unregistering): left promiscuous mode Sep 9 23:39:40.841597 kernel: docker0: port 1(vethb5b5035) entered disabled state Sep 9 23:39:40.844041 dockerd[2338]: time="2025-09-09T23:39:40.843973663Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint e58256087ff3486dd140bf2b06e7f46e396e05aa48555d3101a2ebaac95d4ae6 9b5a48bcf53e2950bae6bb1a9af8adc912a6f585656a86454f276bedfbd33a8b], retrying...." Sep 9 23:39:40.848212 systemd-networkd[1334]: docker0: Lost carrier Sep 9 23:39:40.979248 dockerd[2338]: time="2025-09-09T23:39:40.979189209Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Sep 9 23:39:41.059862 dockerd[2338]: time="2025-09-09T23:39:41.059800258Z" level=warning msg="error locating sandbox id 67f124b7f5a7f8d53b782e149a98ba35415ae3fcae6537a06efc23283fa23e4c: sandbox 67f124b7f5a7f8d53b782e149a98ba35415ae3fcae6537a06efc23283fa23e4c not found" Sep 9 23:39:41.059862 dockerd[2338]: time="2025-09-09T23:39:41.059844098Z" level=warning msg="error locating sandbox id 9e3ecb55af6b6b6714d415358caa9a95651baac3db6125c8c410d59d93749dd0: sandbox 9e3ecb55af6b6b6714d415358caa9a95651baac3db6125c8c410d59d93749dd0 not found" Sep 9 23:39:41.060000 dockerd[2338]: time="2025-09-09T23:39:41.059902058Z" level=info msg="Loading containers: done." Sep 9 23:39:41.072650 dockerd[2338]: time="2025-09-09T23:39:41.072587078Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Sep 9 23:39:41.072808 dockerd[2338]: time="2025-09-09T23:39:41.072694158Z" level=info msg="Docker daemon" commit=41ca978a0a5400cc24b274137efa9f25517fcc0b containerd-snapshotter=false storage-driver=overlay2 version=27.3.1 Sep 9 23:39:41.072808 dockerd[2338]: time="2025-09-09T23:39:41.072748198Z" level=info msg="Daemon has completed initialization" Sep 9 23:39:41.095733 dockerd[2338]: time="2025-09-09T23:39:41.095599314Z" level=info msg="API listen on /run/docker.sock" Sep 9 23:39:41.095766 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 23:39:44.751993 systemd[1]: Started sshd@24-10.0.0.91:22-10.0.0.1:49602.service - OpenSSH per-connection server daemon (10.0.0.1:49602). Sep 9 23:39:44.795889 sshd[2539]: Accepted publickey for core from 10.0.0.1 port 49602 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:44.797657 sshd-session[2539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:44.802453 systemd-logind[1384]: New session 25 of user core. Sep 9 23:39:44.816679 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 9 23:39:44.883283 sshd[2541]: Connection closed by 10.0.0.1 port 49602 Sep 9 23:39:44.884196 sshd-session[2539]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:44.898154 systemd[1]: sshd@24-10.0.0.91:22-10.0.0.1:49602.service: Deactivated successfully. Sep 9 23:39:44.901426 systemd[1]: session-25.scope: Deactivated successfully. Sep 9 23:39:44.902197 systemd-logind[1384]: Session 25 logged out. Waiting for processes to exit. Sep 9 23:39:44.914767 systemd[1]: Started sshd@25-10.0.0.91:22-10.0.0.1:49610.service - OpenSSH per-connection server daemon (10.0.0.1:49610). Sep 9 23:39:44.915731 systemd-logind[1384]: Removed session 25. Sep 9 23:39:44.962932 sshd[2546]: Accepted publickey for core from 10.0.0.1 port 49610 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:44.964342 sshd-session[2546]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:44.968932 systemd-logind[1384]: New session 26 of user core. Sep 9 23:39:44.985617 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 9 23:39:45.040710 sshd[2549]: Connection closed by 10.0.0.1 port 49610 Sep 9 23:39:45.041184 sshd-session[2546]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:45.060878 systemd[1]: sshd@25-10.0.0.91:22-10.0.0.1:49610.service: Deactivated successfully. Sep 9 23:39:45.062780 systemd[1]: session-26.scope: Deactivated successfully. Sep 9 23:39:45.064658 systemd-logind[1384]: Session 26 logged out. Waiting for processes to exit. Sep 9 23:39:45.066117 systemd[1]: Started sshd@26-10.0.0.91:22-10.0.0.1:49626.service - OpenSSH per-connection server daemon (10.0.0.1:49626). Sep 9 23:39:45.067033 systemd-logind[1384]: Removed session 26. Sep 9 23:39:45.109070 sshd[2554]: Accepted publickey for core from 10.0.0.1 port 49626 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:45.110541 sshd-session[2554]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:45.114838 systemd-logind[1384]: New session 27 of user core. Sep 9 23:39:45.124625 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 9 23:39:45.184335 sshd[2557]: Connection closed by 10.0.0.1 port 49626 Sep 9 23:39:45.184915 sshd-session[2554]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:45.196182 systemd[1]: sshd@26-10.0.0.91:22-10.0.0.1:49626.service: Deactivated successfully. Sep 9 23:39:45.198565 systemd[1]: session-27.scope: Deactivated successfully. Sep 9 23:39:45.200665 systemd-logind[1384]: Session 27 logged out. Waiting for processes to exit. Sep 9 23:39:45.210765 systemd[1]: Started sshd@27-10.0.0.91:22-10.0.0.1:49642.service - OpenSSH per-connection server daemon (10.0.0.1:49642). Sep 9 23:39:45.211768 systemd-logind[1384]: Removed session 27. Sep 9 23:39:45.253513 sshd[2569]: Accepted publickey for core from 10.0.0.1 port 49642 ssh2: RSA SHA256:JTwbHKgnxC/1WG4HHOKqnbtsiVhIIcUc9S0pdkPDSJk Sep 9 23:39:45.254916 sshd-session[2569]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 23:39:45.259373 systemd-logind[1384]: New session 28 of user core. Sep 9 23:39:45.277630 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 9 23:39:45.352732 systemd[1]: var-lib-docker-overlay2-95fa1a9e8edcfe92e71279f1eddc7a4455c07ee9afb6cdb70b901d7372719abe\x2dinit-merged.mount: Deactivated successfully. Sep 9 23:39:45.387763 kernel: docker0: port 1(vethadb58bd) entered blocking state Sep 9 23:39:45.387960 kernel: docker0: port 1(vethadb58bd) entered disabled state Sep 9 23:39:45.387982 kernel: vethadb58bd: entered allmulticast mode Sep 9 23:39:45.387996 kernel: vethadb58bd: entered promiscuous mode Sep 9 23:39:45.388954 kernel: docker0: port 1(vethadb58bd) entered blocking state Sep 9 23:39:45.388999 kernel: docker0: port 1(vethadb58bd) entered forwarding state Sep 9 23:39:45.390421 kernel: docker0: port 1(vethadb58bd) entered disabled state Sep 9 23:39:45.391263 systemd-networkd[1334]: vethadb58bd: Link UP Sep 9 23:39:45.436176 containerd[2303]: time="2025-09-09T23:39:45.436064501Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 23:39:45.436176 containerd[2303]: time="2025-09-09T23:39:45.436124062Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 23:39:45.436176 containerd[2303]: time="2025-09-09T23:39:45.436135702Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:39:45.436828 containerd[2303]: time="2025-09-09T23:39:45.436226262Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 23:39:45.460616 systemd[1]: Started docker-3e3fa871ca5311bced8283fed4f88c75d81bc8e9575269d0d228b47e1703d529.scope - libcontainer container 3e3fa871ca5311bced8283fed4f88c75d81bc8e9575269d0d228b47e1703d529. Sep 9 23:39:45.510446 kernel: eth0: renamed from vethd821126 Sep 9 23:39:45.517543 kernel: docker0: port 1(vethadb58bd) entered blocking state Sep 9 23:39:45.517642 kernel: docker0: port 1(vethadb58bd) entered forwarding state Sep 9 23:39:45.517652 systemd-networkd[1334]: vethadb58bd: Gained carrier Sep 9 23:39:45.517914 systemd-networkd[1334]: docker0: Gained carrier Sep 9 23:39:45.520804 systemd-resolved[1263]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 23:39:45.546655 sshd[2572]: Connection closed by 10.0.0.1 port 49642 Sep 9 23:39:45.547100 sshd-session[2569]: pam_unix(sshd:session): session closed for user core Sep 9 23:39:45.550141 systemd[1]: sshd@27-10.0.0.91:22-10.0.0.1:49642.service: Deactivated successfully. Sep 9 23:39:45.553273 systemd[1]: session-28.scope: Deactivated successfully. Sep 9 23:39:45.555104 systemd-logind[1384]: Session 28 logged out. Waiting for processes to exit. Sep 9 23:39:45.556332 systemd-logind[1384]: Removed session 28. Sep 9 23:39:46.742623 systemd-networkd[1334]: vethadb58bd: Gained IPv6LL