Sep 9 00:07:41.871552 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Sep 9 00:07:41.871576 kernel: Linux version 6.6.104-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Mon Sep 8 22:48:00 -00 2025 Sep 9 00:07:41.871586 kernel: KASLR enabled Sep 9 00:07:41.871592 kernel: efi: EFI v2.7 by EDK II Sep 9 00:07:41.871598 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Sep 9 00:07:41.871604 kernel: random: crng init done Sep 9 00:07:41.871611 kernel: ACPI: Early table checksum verification disabled Sep 9 00:07:41.871618 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Sep 9 00:07:41.871624 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Sep 9 00:07:41.871632 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871638 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871644 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871650 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871657 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871664 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871672 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871679 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871685 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Sep 9 00:07:41.871692 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Sep 9 00:07:41.871698 kernel: NUMA: Failed to initialise from firmware Sep 9 00:07:41.871705 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:07:41.871711 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Sep 9 00:07:41.871718 kernel: Zone ranges: Sep 9 00:07:41.871724 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:07:41.871731 kernel: DMA32 empty Sep 9 00:07:41.871738 kernel: Normal empty Sep 9 00:07:41.871745 kernel: Movable zone start for each node Sep 9 00:07:41.871751 kernel: Early memory node ranges Sep 9 00:07:41.871758 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Sep 9 00:07:41.871764 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Sep 9 00:07:41.871771 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Sep 9 00:07:41.871777 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Sep 9 00:07:41.871783 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Sep 9 00:07:41.871790 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Sep 9 00:07:41.871796 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Sep 9 00:07:41.871803 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Sep 9 00:07:41.871809 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Sep 9 00:07:41.871817 kernel: psci: probing for conduit method from ACPI. Sep 9 00:07:41.871824 kernel: psci: PSCIv1.1 detected in firmware. Sep 9 00:07:41.871830 kernel: psci: Using standard PSCI v0.2 function IDs Sep 9 00:07:41.871840 kernel: psci: Trusted OS migration not required Sep 9 00:07:41.871846 kernel: psci: SMC Calling Convention v1.1 Sep 9 00:07:41.871853 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Sep 9 00:07:41.871862 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Sep 9 00:07:41.871869 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Sep 9 00:07:41.871876 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Sep 9 00:07:41.871883 kernel: Detected PIPT I-cache on CPU0 Sep 9 00:07:41.871889 kernel: CPU features: detected: GIC system register CPU interface Sep 9 00:07:41.871896 kernel: CPU features: detected: Hardware dirty bit management Sep 9 00:07:41.871903 kernel: CPU features: detected: Spectre-v4 Sep 9 00:07:41.871910 kernel: CPU features: detected: Spectre-BHB Sep 9 00:07:41.871916 kernel: CPU features: kernel page table isolation forced ON by KASLR Sep 9 00:07:41.871923 kernel: CPU features: detected: Kernel page table isolation (KPTI) Sep 9 00:07:41.871932 kernel: CPU features: detected: ARM erratum 1418040 Sep 9 00:07:41.871939 kernel: CPU features: detected: SSBS not fully self-synchronizing Sep 9 00:07:41.871946 kernel: alternatives: applying boot alternatives Sep 9 00:07:41.871954 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=7395fe4f9fb368b2829f9349e2a89e9a9e96b552675d3b261a5a30cf3c6cb15c Sep 9 00:07:41.871961 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 9 00:07:41.871968 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 9 00:07:41.871983 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 9 00:07:41.872018 kernel: Fallback order for Node 0: 0 Sep 9 00:07:41.872025 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Sep 9 00:07:41.872032 kernel: Policy zone: DMA Sep 9 00:07:41.872039 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 9 00:07:41.872048 kernel: software IO TLB: area num 4. Sep 9 00:07:41.872055 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Sep 9 00:07:41.872063 kernel: Memory: 2386400K/2572288K available (10304K kernel code, 2186K rwdata, 8108K rodata, 39424K init, 897K bss, 185888K reserved, 0K cma-reserved) Sep 9 00:07:41.872070 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 9 00:07:41.872076 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 9 00:07:41.872084 kernel: rcu: RCU event tracing is enabled. Sep 9 00:07:41.872091 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 9 00:07:41.872098 kernel: Trampoline variant of Tasks RCU enabled. Sep 9 00:07:41.872105 kernel: Tracing variant of Tasks RCU enabled. Sep 9 00:07:41.872112 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 9 00:07:41.872118 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 9 00:07:41.872127 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 9 00:07:41.872133 kernel: GICv3: 256 SPIs implemented Sep 9 00:07:41.872140 kernel: GICv3: 0 Extended SPIs implemented Sep 9 00:07:41.872147 kernel: Root IRQ handler: gic_handle_irq Sep 9 00:07:41.872154 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Sep 9 00:07:41.872161 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Sep 9 00:07:41.872168 kernel: ITS [mem 0x08080000-0x0809ffff] Sep 9 00:07:41.872175 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Sep 9 00:07:41.872182 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Sep 9 00:07:41.872189 kernel: GICv3: using LPI property table @0x00000000400f0000 Sep 9 00:07:41.872196 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Sep 9 00:07:41.872202 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 9 00:07:41.872211 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:07:41.872218 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Sep 9 00:07:41.872225 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Sep 9 00:07:41.872232 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Sep 9 00:07:41.872239 kernel: arm-pv: using stolen time PV Sep 9 00:07:41.872247 kernel: Console: colour dummy device 80x25 Sep 9 00:07:41.872254 kernel: ACPI: Core revision 20230628 Sep 9 00:07:41.872261 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Sep 9 00:07:41.872268 kernel: pid_max: default: 32768 minimum: 301 Sep 9 00:07:41.872275 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 9 00:07:41.872283 kernel: landlock: Up and running. Sep 9 00:07:41.872290 kernel: SELinux: Initializing. Sep 9 00:07:41.872297 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 00:07:41.872304 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 9 00:07:41.872311 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 00:07:41.872318 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Sep 9 00:07:41.872326 kernel: rcu: Hierarchical SRCU implementation. Sep 9 00:07:41.872333 kernel: rcu: Max phase no-delay instances is 400. Sep 9 00:07:41.872340 kernel: Platform MSI: ITS@0x8080000 domain created Sep 9 00:07:41.872349 kernel: PCI/MSI: ITS@0x8080000 domain created Sep 9 00:07:41.872356 kernel: Remapping and enabling EFI services. Sep 9 00:07:41.872363 kernel: smp: Bringing up secondary CPUs ... Sep 9 00:07:41.872370 kernel: Detected PIPT I-cache on CPU1 Sep 9 00:07:41.872377 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Sep 9 00:07:41.872383 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Sep 9 00:07:41.872390 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:07:41.872397 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Sep 9 00:07:41.872404 kernel: Detected PIPT I-cache on CPU2 Sep 9 00:07:41.872411 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Sep 9 00:07:41.872420 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Sep 9 00:07:41.872427 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:07:41.872439 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Sep 9 00:07:41.872448 kernel: Detected PIPT I-cache on CPU3 Sep 9 00:07:41.872455 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Sep 9 00:07:41.872463 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Sep 9 00:07:41.872470 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Sep 9 00:07:41.872477 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Sep 9 00:07:41.872485 kernel: smp: Brought up 1 node, 4 CPUs Sep 9 00:07:41.872494 kernel: SMP: Total of 4 processors activated. Sep 9 00:07:41.872501 kernel: CPU features: detected: 32-bit EL0 Support Sep 9 00:07:41.872509 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Sep 9 00:07:41.872517 kernel: CPU features: detected: Common not Private translations Sep 9 00:07:41.872524 kernel: CPU features: detected: CRC32 instructions Sep 9 00:07:41.872531 kernel: CPU features: detected: Enhanced Virtualization Traps Sep 9 00:07:41.872539 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Sep 9 00:07:41.872546 kernel: CPU features: detected: LSE atomic instructions Sep 9 00:07:41.872567 kernel: CPU features: detected: Privileged Access Never Sep 9 00:07:41.872575 kernel: CPU features: detected: RAS Extension Support Sep 9 00:07:41.872583 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Sep 9 00:07:41.872590 kernel: CPU: All CPU(s) started at EL1 Sep 9 00:07:41.872598 kernel: alternatives: applying system-wide alternatives Sep 9 00:07:41.872605 kernel: devtmpfs: initialized Sep 9 00:07:41.872612 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 9 00:07:41.872620 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 9 00:07:41.872627 kernel: pinctrl core: initialized pinctrl subsystem Sep 9 00:07:41.872636 kernel: SMBIOS 3.0.0 present. Sep 9 00:07:41.872644 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Sep 9 00:07:41.872651 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 9 00:07:41.872659 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 9 00:07:41.872666 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 9 00:07:41.872674 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 9 00:07:41.872681 kernel: audit: initializing netlink subsys (disabled) Sep 9 00:07:41.872689 kernel: audit: type=2000 audit(0.028:1): state=initialized audit_enabled=0 res=1 Sep 9 00:07:41.872697 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 9 00:07:41.872705 kernel: cpuidle: using governor menu Sep 9 00:07:41.872713 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 9 00:07:41.872720 kernel: ASID allocator initialised with 32768 entries Sep 9 00:07:41.872728 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 9 00:07:41.872735 kernel: Serial: AMBA PL011 UART driver Sep 9 00:07:41.872743 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Sep 9 00:07:41.872750 kernel: Modules: 0 pages in range for non-PLT usage Sep 9 00:07:41.872758 kernel: Modules: 509008 pages in range for PLT usage Sep 9 00:07:41.872765 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 9 00:07:41.872774 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 9 00:07:41.872782 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 9 00:07:41.872789 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 9 00:07:41.872796 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 9 00:07:41.872804 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 9 00:07:41.872811 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 9 00:07:41.872819 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 9 00:07:41.872826 kernel: ACPI: Added _OSI(Module Device) Sep 9 00:07:41.872833 kernel: ACPI: Added _OSI(Processor Device) Sep 9 00:07:41.872842 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 9 00:07:41.872850 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 9 00:07:41.872857 kernel: ACPI: Interpreter enabled Sep 9 00:07:41.872864 kernel: ACPI: Using GIC for interrupt routing Sep 9 00:07:41.872871 kernel: ACPI: MCFG table detected, 1 entries Sep 9 00:07:41.872879 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Sep 9 00:07:41.872886 kernel: printk: console [ttyAMA0] enabled Sep 9 00:07:41.872894 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 9 00:07:41.873054 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 9 00:07:41.873136 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 9 00:07:41.873203 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 9 00:07:41.873267 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Sep 9 00:07:41.873332 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Sep 9 00:07:41.873342 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Sep 9 00:07:41.873349 kernel: PCI host bridge to bus 0000:00 Sep 9 00:07:41.873422 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Sep 9 00:07:41.873486 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 9 00:07:41.873551 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Sep 9 00:07:41.873611 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 9 00:07:41.873697 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Sep 9 00:07:41.873782 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Sep 9 00:07:41.873852 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Sep 9 00:07:41.873922 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Sep 9 00:07:41.874026 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 00:07:41.874101 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Sep 9 00:07:41.874169 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Sep 9 00:07:41.874237 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Sep 9 00:07:41.874299 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Sep 9 00:07:41.874359 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 9 00:07:41.874423 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Sep 9 00:07:41.874433 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 9 00:07:41.874440 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 9 00:07:41.874448 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 9 00:07:41.874455 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 9 00:07:41.874463 kernel: iommu: Default domain type: Translated Sep 9 00:07:41.874470 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 9 00:07:41.874478 kernel: efivars: Registered efivars operations Sep 9 00:07:41.874487 kernel: vgaarb: loaded Sep 9 00:07:41.874495 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 9 00:07:41.874502 kernel: VFS: Disk quotas dquot_6.6.0 Sep 9 00:07:41.874510 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 9 00:07:41.874517 kernel: pnp: PnP ACPI init Sep 9 00:07:41.874592 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Sep 9 00:07:41.874603 kernel: pnp: PnP ACPI: found 1 devices Sep 9 00:07:41.874611 kernel: NET: Registered PF_INET protocol family Sep 9 00:07:41.874618 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 9 00:07:41.874628 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 9 00:07:41.874636 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 9 00:07:41.874643 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 9 00:07:41.874651 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 9 00:07:41.874658 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 9 00:07:41.874666 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 00:07:41.874673 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 9 00:07:41.874681 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 9 00:07:41.874690 kernel: PCI: CLS 0 bytes, default 64 Sep 9 00:07:41.874697 kernel: kvm [1]: HYP mode not available Sep 9 00:07:41.874705 kernel: Initialise system trusted keyrings Sep 9 00:07:41.874712 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 9 00:07:41.874719 kernel: Key type asymmetric registered Sep 9 00:07:41.874727 kernel: Asymmetric key parser 'x509' registered Sep 9 00:07:41.874734 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 9 00:07:41.874742 kernel: io scheduler mq-deadline registered Sep 9 00:07:41.874750 kernel: io scheduler kyber registered Sep 9 00:07:41.874757 kernel: io scheduler bfq registered Sep 9 00:07:41.874766 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 9 00:07:41.874773 kernel: ACPI: button: Power Button [PWRB] Sep 9 00:07:41.874781 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 9 00:07:41.874847 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Sep 9 00:07:41.874857 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 9 00:07:41.874865 kernel: thunder_xcv, ver 1.0 Sep 9 00:07:41.874873 kernel: thunder_bgx, ver 1.0 Sep 9 00:07:41.874880 kernel: nicpf, ver 1.0 Sep 9 00:07:41.874888 kernel: nicvf, ver 1.0 Sep 9 00:07:41.874967 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 9 00:07:41.875075 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-09T00:07:41 UTC (1757376461) Sep 9 00:07:41.875087 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 9 00:07:41.875094 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Sep 9 00:07:41.875102 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 9 00:07:41.875110 kernel: watchdog: Hard watchdog permanently disabled Sep 9 00:07:41.875117 kernel: NET: Registered PF_INET6 protocol family Sep 9 00:07:41.875125 kernel: Segment Routing with IPv6 Sep 9 00:07:41.875137 kernel: In-situ OAM (IOAM) with IPv6 Sep 9 00:07:41.875145 kernel: NET: Registered PF_PACKET protocol family Sep 9 00:07:41.875152 kernel: Key type dns_resolver registered Sep 9 00:07:41.875160 kernel: registered taskstats version 1 Sep 9 00:07:41.875167 kernel: Loading compiled-in X.509 certificates Sep 9 00:07:41.875175 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.104-flatcar: f5b097e6797722e0cc665195a3c415b6be267631' Sep 9 00:07:41.875182 kernel: Key type .fscrypt registered Sep 9 00:07:41.875190 kernel: Key type fscrypt-provisioning registered Sep 9 00:07:41.875197 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 9 00:07:41.875206 kernel: ima: Allocated hash algorithm: sha1 Sep 9 00:07:41.875213 kernel: ima: No architecture policies found Sep 9 00:07:41.875221 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 9 00:07:41.875229 kernel: clk: Disabling unused clocks Sep 9 00:07:41.875236 kernel: Freeing unused kernel memory: 39424K Sep 9 00:07:41.875244 kernel: Run /init as init process Sep 9 00:07:41.875251 kernel: with arguments: Sep 9 00:07:41.875259 kernel: /init Sep 9 00:07:41.875266 kernel: with environment: Sep 9 00:07:41.875275 kernel: HOME=/ Sep 9 00:07:41.875282 kernel: TERM=linux Sep 9 00:07:41.875290 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 9 00:07:41.875300 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 9 00:07:41.875310 systemd[1]: Detected virtualization kvm. Sep 9 00:07:41.875318 systemd[1]: Detected architecture arm64. Sep 9 00:07:41.875325 systemd[1]: Running in initrd. Sep 9 00:07:41.875335 systemd[1]: No hostname configured, using default hostname. Sep 9 00:07:41.875343 systemd[1]: Hostname set to . Sep 9 00:07:41.875352 systemd[1]: Initializing machine ID from VM UUID. Sep 9 00:07:41.875360 systemd[1]: Queued start job for default target initrd.target. Sep 9 00:07:41.875369 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 00:07:41.875377 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 00:07:41.875386 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 9 00:07:41.875395 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 00:07:41.875405 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 9 00:07:41.875414 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 9 00:07:41.875424 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 00:07:41.875432 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 9 00:07:41.875441 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 00:07:41.875449 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 00:07:41.875457 systemd[1]: Reached target paths.target - Path Units. Sep 9 00:07:41.875466 systemd[1]: Reached target slices.target - Slice Units. Sep 9 00:07:41.875474 systemd[1]: Reached target swap.target - Swaps. Sep 9 00:07:41.875482 systemd[1]: Reached target timers.target - Timer Units. Sep 9 00:07:41.875490 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 00:07:41.875498 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 00:07:41.875506 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 9 00:07:41.875514 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 9 00:07:41.875522 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 00:07:41.875531 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 00:07:41.875541 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 00:07:41.875549 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 00:07:41.875557 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 9 00:07:41.875565 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 00:07:41.875573 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 9 00:07:41.875581 systemd[1]: Starting systemd-fsck-usr.service... Sep 9 00:07:41.875590 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 00:07:41.875597 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 00:07:41.875607 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 00:07:41.875615 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 9 00:07:41.875623 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 00:07:41.875631 systemd[1]: Finished systemd-fsck-usr.service. Sep 9 00:07:41.875659 systemd-journald[238]: Collecting audit messages is disabled. Sep 9 00:07:41.875680 systemd-journald[238]: Journal started Sep 9 00:07:41.875698 systemd-journald[238]: Runtime Journal (/run/log/journal/6afc8232aab2401094d8076694ddb5d1) is 5.9M, max 47.3M, 41.4M free. Sep 9 00:07:41.879064 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 00:07:41.879102 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 9 00:07:41.868081 systemd-modules-load[239]: Inserted module 'overlay' Sep 9 00:07:41.882781 systemd-modules-load[239]: Inserted module 'br_netfilter' Sep 9 00:07:41.884400 kernel: Bridge firewalling registered Sep 9 00:07:41.884430 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 00:07:41.885507 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 00:07:41.887434 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 00:07:41.888540 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 9 00:07:41.893078 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 00:07:41.894668 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 00:07:41.897165 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 00:07:41.901690 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 00:07:41.906388 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 00:07:41.912698 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 00:07:41.916538 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 00:07:41.927173 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 9 00:07:41.928240 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 00:07:41.931697 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 00:07:41.940399 dracut-cmdline[277]: dracut-dracut-053 Sep 9 00:07:41.942961 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=7395fe4f9fb368b2829f9349e2a89e9a9e96b552675d3b261a5a30cf3c6cb15c Sep 9 00:07:41.959727 systemd-resolved[281]: Positive Trust Anchors: Sep 9 00:07:41.959749 systemd-resolved[281]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 00:07:41.959781 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 00:07:41.964841 systemd-resolved[281]: Defaulting to hostname 'linux'. Sep 9 00:07:41.968834 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 00:07:41.970073 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 00:07:42.012036 kernel: SCSI subsystem initialized Sep 9 00:07:42.017008 kernel: Loading iSCSI transport class v2.0-870. Sep 9 00:07:42.025017 kernel: iscsi: registered transport (tcp) Sep 9 00:07:42.038016 kernel: iscsi: registered transport (qla4xxx) Sep 9 00:07:42.038032 kernel: QLogic iSCSI HBA Driver Sep 9 00:07:42.081407 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 9 00:07:42.090151 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 9 00:07:42.107526 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 9 00:07:42.107591 kernel: device-mapper: uevent: version 1.0.3 Sep 9 00:07:42.107603 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 9 00:07:42.154009 kernel: raid6: neonx8 gen() 15771 MB/s Sep 9 00:07:42.170998 kernel: raid6: neonx4 gen() 15660 MB/s Sep 9 00:07:42.187995 kernel: raid6: neonx2 gen() 13240 MB/s Sep 9 00:07:42.204995 kernel: raid6: neonx1 gen() 10508 MB/s Sep 9 00:07:42.222004 kernel: raid6: int64x8 gen() 6928 MB/s Sep 9 00:07:42.239000 kernel: raid6: int64x4 gen() 7357 MB/s Sep 9 00:07:42.256002 kernel: raid6: int64x2 gen() 6131 MB/s Sep 9 00:07:42.273021 kernel: raid6: int64x1 gen() 5052 MB/s Sep 9 00:07:42.273055 kernel: raid6: using algorithm neonx8 gen() 15771 MB/s Sep 9 00:07:42.290020 kernel: raid6: .... xor() 12019 MB/s, rmw enabled Sep 9 00:07:42.290045 kernel: raid6: using neon recovery algorithm Sep 9 00:07:42.295135 kernel: xor: measuring software checksum speed Sep 9 00:07:42.295149 kernel: 8regs : 19745 MB/sec Sep 9 00:07:42.296217 kernel: 32regs : 19650 MB/sec Sep 9 00:07:42.296230 kernel: arm64_neon : 26910 MB/sec Sep 9 00:07:42.296243 kernel: xor: using function: arm64_neon (26910 MB/sec) Sep 9 00:07:42.345015 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 9 00:07:42.355826 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 9 00:07:42.370198 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 00:07:42.381950 systemd-udevd[463]: Using default interface naming scheme 'v255'. Sep 9 00:07:42.385247 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 00:07:42.394179 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 9 00:07:42.406836 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation Sep 9 00:07:42.434304 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 00:07:42.445136 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 00:07:42.486053 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 00:07:42.495148 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 9 00:07:42.506065 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 9 00:07:42.507598 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 00:07:42.510248 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 00:07:42.512257 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 00:07:42.518156 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 9 00:07:42.531047 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 9 00:07:42.544108 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Sep 9 00:07:42.546014 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 9 00:07:42.547610 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 00:07:42.547736 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 00:07:42.556239 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:07:42.554744 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 00:07:42.556962 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 00:07:42.557142 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 00:07:42.559066 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 00:07:42.570298 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 00:07:42.576015 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (516) Sep 9 00:07:42.580660 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 00:07:42.584094 kernel: BTRFS: device fsid 7c1eef97-905d-47ac-bb4a-010204f95541 devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (515) Sep 9 00:07:42.586469 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 9 00:07:42.591207 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 9 00:07:42.601112 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 00:07:42.604861 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 00:07:42.605957 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 9 00:07:42.627328 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 9 00:07:42.629707 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 9 00:07:42.645481 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 00:07:42.653001 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:07:42.681008 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:07:42.684014 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:07:43.685000 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 9 00:07:43.685653 disk-uuid[561]: The operation has completed successfully. Sep 9 00:07:43.709854 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 9 00:07:43.709955 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 9 00:07:43.727205 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 9 00:07:43.732099 sh[575]: Success Sep 9 00:07:43.743015 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 9 00:07:43.769857 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 9 00:07:43.786529 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 9 00:07:43.788818 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 9 00:07:43.800631 kernel: BTRFS info (device dm-0): first mount of filesystem 7c1eef97-905d-47ac-bb4a-010204f95541 Sep 9 00:07:43.800680 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:07:43.800700 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 9 00:07:43.800711 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 9 00:07:43.801247 kernel: BTRFS info (device dm-0): using free space tree Sep 9 00:07:43.805182 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 9 00:07:43.806450 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 9 00:07:43.816168 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 9 00:07:43.817854 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 9 00:07:43.827696 kernel: BTRFS info (device vda6): first mount of filesystem 995cc93a-6fc6-4281-a722-821717f17817 Sep 9 00:07:43.827749 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:07:43.827761 kernel: BTRFS info (device vda6): using free space tree Sep 9 00:07:43.831028 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 00:07:43.838649 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 9 00:07:43.840590 kernel: BTRFS info (device vda6): last unmount of filesystem 995cc93a-6fc6-4281-a722-821717f17817 Sep 9 00:07:43.845695 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 9 00:07:43.853146 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 9 00:07:43.917085 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 00:07:43.925467 ignition[668]: Ignition 2.19.0 Sep 9 00:07:43.933295 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 00:07:43.925477 ignition[668]: Stage: fetch-offline Sep 9 00:07:43.925512 ignition[668]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:43.925521 ignition[668]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:43.925678 ignition[668]: parsed url from cmdline: "" Sep 9 00:07:43.925681 ignition[668]: no config URL provided Sep 9 00:07:43.925686 ignition[668]: reading system config file "/usr/lib/ignition/user.ign" Sep 9 00:07:43.925693 ignition[668]: no config at "/usr/lib/ignition/user.ign" Sep 9 00:07:43.941627 unknown[668]: fetched base config from "system" Sep 9 00:07:43.925715 ignition[668]: op(1): [started] loading QEMU firmware config module Sep 9 00:07:43.941634 unknown[668]: fetched user config from "qemu" Sep 9 00:07:43.925719 ignition[668]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 9 00:07:43.943682 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 00:07:43.931876 ignition[668]: op(1): [finished] loading QEMU firmware config module Sep 9 00:07:43.936472 ignition[668]: parsing config with SHA512: d6d33e4c1348bb77e161c94ca0fb483bc825d32c84073f7ca4882743ae48783d720e730286236e4fc11166e73944256795f6c495ad175d450c6cedfd7779bbfa Sep 9 00:07:43.941803 ignition[668]: fetch-offline: fetch-offline passed Sep 9 00:07:43.941877 ignition[668]: Ignition finished successfully Sep 9 00:07:43.955115 systemd-networkd[765]: lo: Link UP Sep 9 00:07:43.955126 systemd-networkd[765]: lo: Gained carrier Sep 9 00:07:43.955850 systemd-networkd[765]: Enumeration completed Sep 9 00:07:43.955934 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 00:07:43.956306 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 00:07:43.956309 systemd-networkd[765]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 00:07:43.957079 systemd-networkd[765]: eth0: Link UP Sep 9 00:07:43.957082 systemd-networkd[765]: eth0: Gained carrier Sep 9 00:07:43.957089 systemd-networkd[765]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 00:07:43.957793 systemd[1]: Reached target network.target - Network. Sep 9 00:07:43.958818 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 9 00:07:43.969134 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 9 00:07:43.977045 systemd-networkd[765]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 00:07:43.980950 ignition[769]: Ignition 2.19.0 Sep 9 00:07:43.980959 ignition[769]: Stage: kargs Sep 9 00:07:43.981161 ignition[769]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:43.981171 ignition[769]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:43.981747 ignition[769]: kargs: kargs passed Sep 9 00:07:43.984271 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 9 00:07:43.981785 ignition[769]: Ignition finished successfully Sep 9 00:07:43.990147 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 9 00:07:44.001126 ignition[777]: Ignition 2.19.0 Sep 9 00:07:44.001137 ignition[777]: Stage: disks Sep 9 00:07:44.001536 systemd-resolved[281]: Detected conflict on linux IN A 10.0.0.5 Sep 9 00:07:44.001305 ignition[777]: no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:44.001545 systemd-resolved[281]: Hostname conflict, changing published hostname from 'linux' to 'linux7'. Sep 9 00:07:44.001315 ignition[777]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:44.001881 ignition[777]: disks: disks passed Sep 9 00:07:44.001922 ignition[777]: Ignition finished successfully Sep 9 00:07:44.006026 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 9 00:07:44.007424 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 9 00:07:44.008705 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 9 00:07:44.010333 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 00:07:44.011881 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 00:07:44.013769 systemd[1]: Reached target basic.target - Basic System. Sep 9 00:07:44.025218 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 9 00:07:44.034838 systemd-fsck[789]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 9 00:07:44.039187 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 9 00:07:44.041168 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 9 00:07:44.090888 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 9 00:07:44.092264 kernel: EXT4-fs (vda9): mounted filesystem d987a4c8-1278-4a59-9d40-0c91e08e9423 r/w with ordered data mode. Quota mode: none. Sep 9 00:07:44.092082 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 9 00:07:44.109091 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 00:07:44.110678 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 9 00:07:44.112040 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 9 00:07:44.116028 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (797) Sep 9 00:07:44.112080 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 9 00:07:44.112102 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 00:07:44.118898 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 9 00:07:44.121586 kernel: BTRFS info (device vda6): first mount of filesystem 995cc93a-6fc6-4281-a722-821717f17817 Sep 9 00:07:44.121604 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:07:44.121615 kernel: BTRFS info (device vda6): using free space tree Sep 9 00:07:44.124008 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 00:07:44.136157 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 9 00:07:44.137981 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 00:07:44.171358 initrd-setup-root[821]: cut: /sysroot/etc/passwd: No such file or directory Sep 9 00:07:44.175159 initrd-setup-root[828]: cut: /sysroot/etc/group: No such file or directory Sep 9 00:07:44.179591 initrd-setup-root[835]: cut: /sysroot/etc/shadow: No such file or directory Sep 9 00:07:44.182513 initrd-setup-root[842]: cut: /sysroot/etc/gshadow: No such file or directory Sep 9 00:07:44.347895 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 9 00:07:44.353166 systemd-resolved[281]: Detected conflict on linux7 IN A 10.0.0.5 Sep 9 00:07:44.353182 systemd-resolved[281]: Hostname conflict, changing published hostname from 'linux7' to 'linux15'. Sep 9 00:07:44.357130 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 9 00:07:44.358728 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 9 00:07:44.366029 kernel: BTRFS info (device vda6): last unmount of filesystem 995cc93a-6fc6-4281-a722-821717f17817 Sep 9 00:07:44.384503 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 9 00:07:44.401571 ignition[914]: INFO : Ignition 2.19.0 Sep 9 00:07:44.401571 ignition[914]: INFO : Stage: mount Sep 9 00:07:44.403147 ignition[914]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:44.403147 ignition[914]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:44.403147 ignition[914]: INFO : mount: mount passed Sep 9 00:07:44.403147 ignition[914]: INFO : Ignition finished successfully Sep 9 00:07:44.404156 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 9 00:07:44.416111 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 9 00:07:44.798980 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 9 00:07:44.815193 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 9 00:07:44.821036 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (924) Sep 9 00:07:44.821108 kernel: BTRFS info (device vda6): first mount of filesystem 995cc93a-6fc6-4281-a722-821717f17817 Sep 9 00:07:44.822599 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Sep 9 00:07:44.823121 kernel: BTRFS info (device vda6): using free space tree Sep 9 00:07:44.825004 kernel: BTRFS info (device vda6): auto enabling async discard Sep 9 00:07:44.826212 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 9 00:07:44.845625 ignition[941]: INFO : Ignition 2.19.0 Sep 9 00:07:44.845625 ignition[941]: INFO : Stage: files Sep 9 00:07:44.849979 ignition[941]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:44.849979 ignition[941]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:44.849979 ignition[941]: DEBUG : files: compiled without relabeling support, skipping Sep 9 00:07:44.857699 ignition[941]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 9 00:07:44.857699 ignition[941]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 9 00:07:44.864344 ignition[941]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 9 00:07:44.865418 ignition[941]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 9 00:07:44.866749 ignition[941]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 9 00:07:44.865459 unknown[941]: wrote ssh authorized keys file for user: core Sep 9 00:07:44.868942 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 00:07:44.868942 ignition[941]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 9 00:07:44.868942 ignition[941]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(6): [started] processing unit "docker.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(6): [finished] processing unit "docker.service" Sep 9 00:07:44.872965 ignition[941]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 9 00:07:45.028088 ignition[941]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 00:07:45.032809 ignition[941]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 9 00:07:45.034178 ignition[941]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 9 00:07:45.034178 ignition[941]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 9 00:07:45.034178 ignition[941]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 9 00:07:45.034178 ignition[941]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 9 00:07:45.034178 ignition[941]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 9 00:07:45.034178 ignition[941]: INFO : files: files passed Sep 9 00:07:45.034178 ignition[941]: INFO : Ignition finished successfully Sep 9 00:07:45.036407 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 9 00:07:45.052175 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 9 00:07:45.053744 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 9 00:07:45.055277 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 9 00:07:45.055355 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 9 00:07:45.062632 initrd-setup-root-after-ignition[970]: grep: /sysroot/oem/oem-release: No such file or directory Sep 9 00:07:45.064887 initrd-setup-root-after-ignition[972]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 00:07:45.064887 initrd-setup-root-after-ignition[972]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 9 00:07:45.067738 initrd-setup-root-after-ignition[976]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 9 00:07:45.069201 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 00:07:45.070596 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 9 00:07:45.078174 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 9 00:07:45.097507 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 9 00:07:45.097619 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 9 00:07:45.099536 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 9 00:07:45.101230 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 9 00:07:45.102777 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 9 00:07:45.111137 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 9 00:07:45.123381 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 00:07:45.125665 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 9 00:07:45.137427 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 9 00:07:45.138540 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 00:07:45.140357 systemd[1]: Stopped target timers.target - Timer Units. Sep 9 00:07:45.141890 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 9 00:07:45.142079 systemd-networkd[765]: eth0: Gained IPv6LL Sep 9 00:07:45.142145 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 9 00:07:45.145415 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 9 00:07:45.147187 systemd[1]: Stopped target basic.target - Basic System. Sep 9 00:07:45.148769 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 9 00:07:45.150357 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 9 00:07:45.152058 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 9 00:07:45.154000 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 9 00:07:45.155725 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 9 00:07:45.157439 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 9 00:07:45.159111 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 9 00:07:45.160632 systemd[1]: Stopped target swap.target - Swaps. Sep 9 00:07:45.161935 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 9 00:07:45.162083 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 9 00:07:45.164232 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 9 00:07:45.165974 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 00:07:45.167848 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 9 00:07:45.171032 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 00:07:45.172108 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 9 00:07:45.172217 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 9 00:07:45.174777 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 9 00:07:45.174884 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 9 00:07:45.176865 systemd[1]: Stopped target paths.target - Path Units. Sep 9 00:07:45.178243 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 9 00:07:45.179343 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 00:07:45.180462 systemd[1]: Stopped target slices.target - Slice Units. Sep 9 00:07:45.181733 systemd[1]: Stopped target sockets.target - Socket Units. Sep 9 00:07:45.183217 systemd[1]: iscsid.socket: Deactivated successfully. Sep 9 00:07:45.183303 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 9 00:07:45.185138 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 9 00:07:45.185218 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 9 00:07:45.186599 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 9 00:07:45.186707 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 9 00:07:45.188190 systemd[1]: ignition-files.service: Deactivated successfully. Sep 9 00:07:45.188292 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 9 00:07:45.201171 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 9 00:07:45.201920 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 9 00:07:45.202067 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 00:07:45.207219 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 9 00:07:45.207944 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 9 00:07:45.208102 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 00:07:45.210550 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 9 00:07:45.213613 ignition[997]: INFO : Ignition 2.19.0 Sep 9 00:07:45.213613 ignition[997]: INFO : Stage: umount Sep 9 00:07:45.213613 ignition[997]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 9 00:07:45.213613 ignition[997]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 9 00:07:45.213613 ignition[997]: INFO : umount: umount passed Sep 9 00:07:45.213613 ignition[997]: INFO : Ignition finished successfully Sep 9 00:07:45.210651 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 9 00:07:45.215280 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 9 00:07:45.215380 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 9 00:07:45.217236 systemd[1]: Stopped target network.target - Network. Sep 9 00:07:45.218148 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 9 00:07:45.218208 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 9 00:07:45.219025 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 9 00:07:45.219062 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 9 00:07:45.220707 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 9 00:07:45.220745 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 9 00:07:45.222316 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 9 00:07:45.222354 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 9 00:07:45.224321 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 9 00:07:45.225971 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 9 00:07:45.229065 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 9 00:07:45.229636 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 9 00:07:45.229727 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 9 00:07:45.231219 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 9 00:07:45.231298 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 9 00:07:45.234262 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 9 00:07:45.234346 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 9 00:07:45.236057 systemd-networkd[765]: eth0: DHCPv6 lease lost Sep 9 00:07:45.237930 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 9 00:07:45.238124 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 9 00:07:45.240403 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 9 00:07:45.240441 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 9 00:07:45.243151 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 9 00:07:45.243203 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 9 00:07:45.249064 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 9 00:07:45.250506 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 9 00:07:45.250560 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 9 00:07:45.252301 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 9 00:07:45.252338 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 9 00:07:45.253887 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 9 00:07:45.253924 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 9 00:07:45.255535 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 9 00:07:45.255571 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 00:07:45.257280 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 00:07:45.269156 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 9 00:07:45.269273 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 9 00:07:45.271035 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 9 00:07:45.271171 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 00:07:45.275197 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 9 00:07:45.275242 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 9 00:07:45.276923 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 9 00:07:45.276953 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 00:07:45.278448 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 9 00:07:45.278490 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 9 00:07:45.280945 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 9 00:07:45.281098 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 9 00:07:45.283522 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 9 00:07:45.283572 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 9 00:07:45.294185 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 9 00:07:45.295088 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 9 00:07:45.295141 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 00:07:45.297010 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 9 00:07:45.297051 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 00:07:45.299028 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 9 00:07:45.301018 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 9 00:07:45.302926 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 9 00:07:45.305017 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 9 00:07:45.314786 systemd[1]: Switching root. Sep 9 00:07:45.350050 systemd-journald[238]: Journal stopped Sep 9 00:07:46.053092 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Sep 9 00:07:46.053163 kernel: SELinux: policy capability network_peer_controls=1 Sep 9 00:07:46.053176 kernel: SELinux: policy capability open_perms=1 Sep 9 00:07:46.053185 kernel: SELinux: policy capability extended_socket_class=1 Sep 9 00:07:46.053195 kernel: SELinux: policy capability always_check_network=0 Sep 9 00:07:46.053209 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 9 00:07:46.053221 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 9 00:07:46.053238 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 9 00:07:46.053248 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 9 00:07:46.053258 kernel: audit: type=1403 audit(1757376465.418:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 9 00:07:46.053269 systemd[1]: Successfully loaded SELinux policy in 30.847ms. Sep 9 00:07:46.053287 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.189ms. Sep 9 00:07:46.053300 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 9 00:07:46.053311 systemd[1]: Detected virtualization kvm. Sep 9 00:07:46.053325 systemd[1]: Detected architecture arm64. Sep 9 00:07:46.053336 systemd[1]: Detected first boot. Sep 9 00:07:46.053349 systemd[1]: Initializing machine ID from VM UUID. Sep 9 00:07:46.053361 zram_generator::config[1042]: No configuration found. Sep 9 00:07:46.053372 systemd[1]: Populated /etc with preset unit settings. Sep 9 00:07:46.053382 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 9 00:07:46.053392 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 9 00:07:46.053403 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 9 00:07:46.053413 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 9 00:07:46.053424 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 9 00:07:46.053436 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 9 00:07:46.053447 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 9 00:07:46.053457 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 9 00:07:46.053469 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 9 00:07:46.053480 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 9 00:07:46.053491 systemd[1]: Created slice user.slice - User and Session Slice. Sep 9 00:07:46.053503 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 9 00:07:46.053514 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 9 00:07:46.053524 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 9 00:07:46.053535 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 9 00:07:46.053545 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 9 00:07:46.053556 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 9 00:07:46.053566 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Sep 9 00:07:46.053576 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 9 00:07:46.053587 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 9 00:07:46.053599 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 9 00:07:46.053609 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 9 00:07:46.053623 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 9 00:07:46.053634 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 9 00:07:46.053645 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 9 00:07:46.053655 systemd[1]: Reached target slices.target - Slice Units. Sep 9 00:07:46.053665 systemd[1]: Reached target swap.target - Swaps. Sep 9 00:07:46.053676 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 9 00:07:46.053688 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 9 00:07:46.053699 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 9 00:07:46.053710 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 9 00:07:46.053731 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 9 00:07:46.053742 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 9 00:07:46.053753 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 9 00:07:46.053764 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 9 00:07:46.053774 systemd[1]: Mounting media.mount - External Media Directory... Sep 9 00:07:46.053784 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 9 00:07:46.053796 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 9 00:07:46.053807 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 9 00:07:46.053818 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 00:07:46.053830 systemd[1]: Reached target machines.target - Containers. Sep 9 00:07:46.053841 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 9 00:07:46.053852 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 00:07:46.053862 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 9 00:07:46.053873 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 9 00:07:46.053885 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 00:07:46.053896 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 00:07:46.053906 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 00:07:46.053917 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 9 00:07:46.053927 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 00:07:46.053939 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 9 00:07:46.053949 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 9 00:07:46.053969 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 9 00:07:46.053982 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 9 00:07:46.054001 kernel: fuse: init (API version 7.39) Sep 9 00:07:46.054015 systemd[1]: Stopped systemd-fsck-usr.service. Sep 9 00:07:46.054030 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 9 00:07:46.054040 kernel: loop: module loaded Sep 9 00:07:46.054051 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 9 00:07:46.054061 kernel: ACPI: bus type drm_connector registered Sep 9 00:07:46.054071 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 9 00:07:46.054082 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 9 00:07:46.054094 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 9 00:07:46.054105 systemd[1]: verity-setup.service: Deactivated successfully. Sep 9 00:07:46.054115 systemd[1]: Stopped verity-setup.service. Sep 9 00:07:46.054125 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 9 00:07:46.054153 systemd-journald[1109]: Collecting audit messages is disabled. Sep 9 00:07:46.054177 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 9 00:07:46.054189 systemd[1]: Mounted media.mount - External Media Directory. Sep 9 00:07:46.054200 systemd-journald[1109]: Journal started Sep 9 00:07:46.054223 systemd-journald[1109]: Runtime Journal (/run/log/journal/6afc8232aab2401094d8076694ddb5d1) is 5.9M, max 47.3M, 41.4M free. Sep 9 00:07:45.860282 systemd[1]: Queued start job for default target multi-user.target. Sep 9 00:07:45.878891 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 9 00:07:45.879295 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 9 00:07:46.057391 systemd[1]: Started systemd-journald.service - Journal Service. Sep 9 00:07:46.058114 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 9 00:07:46.059301 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 9 00:07:46.060565 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 9 00:07:46.063024 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 9 00:07:46.064567 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 9 00:07:46.064740 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 9 00:07:46.067391 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 00:07:46.067521 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 00:07:46.068844 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 00:07:46.068981 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 00:07:46.070216 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 00:07:46.070348 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 00:07:46.071634 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 9 00:07:46.071751 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 9 00:07:46.073159 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 9 00:07:46.074504 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 00:07:46.074626 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 00:07:46.077429 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 9 00:07:46.078701 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 9 00:07:46.080092 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 9 00:07:46.091534 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 9 00:07:46.097089 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 9 00:07:46.098944 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 9 00:07:46.099998 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 9 00:07:46.100029 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 9 00:07:46.101854 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 9 00:07:46.103891 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 9 00:07:46.105928 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 9 00:07:46.106945 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 00:07:46.108641 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 9 00:07:46.110476 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 9 00:07:46.111549 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 00:07:46.113170 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 9 00:07:46.114047 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 00:07:46.115704 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 9 00:07:46.121146 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 9 00:07:46.123746 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 9 00:07:46.128012 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 9 00:07:46.129512 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 9 00:07:46.130804 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 9 00:07:46.132304 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 9 00:07:46.134416 systemd-journald[1109]: Time spent on flushing to /var/log/journal/6afc8232aab2401094d8076694ddb5d1 is 13.567ms for 835 entries. Sep 9 00:07:46.134416 systemd-journald[1109]: System Journal (/var/log/journal/6afc8232aab2401094d8076694ddb5d1) is 8.0M, max 195.6M, 187.6M free. Sep 9 00:07:46.260339 systemd-journald[1109]: Received client request to flush runtime journal. Sep 9 00:07:46.260405 kernel: loop0: detected capacity change from 0 to 114432 Sep 9 00:07:46.260429 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 9 00:07:46.260446 kernel: loop1: detected capacity change from 0 to 114328 Sep 9 00:07:46.140188 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 9 00:07:46.152981 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 9 00:07:46.161775 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 9 00:07:46.163186 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 9 00:07:46.165026 udevadm[1161]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Sep 9 00:07:46.182027 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 9 00:07:46.182098 systemd-tmpfiles[1164]: ACLs are not supported, ignoring. Sep 9 00:07:46.182108 systemd-tmpfiles[1164]: ACLs are not supported, ignoring. Sep 9 00:07:46.183237 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 9 00:07:46.191194 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 9 00:07:46.193830 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 9 00:07:46.262027 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 9 00:07:46.265044 kernel: loop2: detected capacity change from 0 to 114432 Sep 9 00:07:46.288027 kernel: loop3: detected capacity change from 0 to 114328 Sep 9 00:07:46.292876 (sd-merge)[1174]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 9 00:07:46.293581 (sd-merge)[1174]: Merged extensions into '/usr'. Sep 9 00:07:46.296890 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 9 00:07:46.308226 systemd[1]: Starting ensure-sysext.service... Sep 9 00:07:46.310694 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 9 00:07:46.320452 systemd[1]: Reloading requested from client PID 1177 ('systemctl') (unit ensure-sysext.service)... Sep 9 00:07:46.320467 systemd[1]: Reloading... Sep 9 00:07:46.330673 systemd-tmpfiles[1178]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 9 00:07:46.330942 systemd-tmpfiles[1178]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 9 00:07:46.331663 systemd-tmpfiles[1178]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 9 00:07:46.331874 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Sep 9 00:07:46.331932 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Sep 9 00:07:46.334498 systemd-tmpfiles[1178]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 00:07:46.334512 systemd-tmpfiles[1178]: Skipping /boot Sep 9 00:07:46.342091 systemd-tmpfiles[1178]: Detected autofs mount point /boot during canonicalization of boot. Sep 9 00:07:46.342104 systemd-tmpfiles[1178]: Skipping /boot Sep 9 00:07:46.378004 zram_generator::config[1210]: No configuration found. Sep 9 00:07:46.467035 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 00:07:46.502657 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 9 00:07:46.503242 systemd[1]: Reloading finished in 182 ms. Sep 9 00:07:46.535850 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 9 00:07:46.550422 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 9 00:07:46.555796 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 9 00:07:46.558026 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 9 00:07:46.562183 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 9 00:07:46.567015 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 9 00:07:46.572345 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 9 00:07:46.579542 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 9 00:07:46.581748 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 00:07:46.583165 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 00:07:46.585234 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 00:07:46.589257 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 00:07:46.590398 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 00:07:46.594629 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 00:07:46.594829 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 00:07:46.595380 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 00:07:46.595533 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 00:07:46.598753 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 9 00:07:46.600507 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 00:07:46.600679 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 00:07:46.603771 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 00:07:46.603902 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 00:07:46.607671 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 9 00:07:46.615324 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 9 00:07:46.617577 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 9 00:07:46.621449 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 9 00:07:46.625845 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 9 00:07:46.628949 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 9 00:07:46.629666 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 9 00:07:46.631133 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 9 00:07:46.631293 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 9 00:07:46.632762 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 9 00:07:46.632896 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 9 00:07:46.634490 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 9 00:07:46.634685 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 9 00:07:46.639309 systemd[1]: Finished ensure-sysext.service. Sep 9 00:07:46.650368 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 9 00:07:46.655305 augenrules[1286]: No rules Sep 9 00:07:46.660267 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 9 00:07:46.661509 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 9 00:07:46.662697 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 9 00:07:46.662852 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 9 00:07:46.666294 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 9 00:07:46.671047 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 9 00:07:46.679514 systemd-resolved[1248]: Positive Trust Anchors: Sep 9 00:07:46.679535 systemd-resolved[1248]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 9 00:07:46.679568 systemd-resolved[1248]: 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 00:07:46.690734 systemd-resolved[1248]: Defaulting to hostname 'linux'. Sep 9 00:07:46.692973 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 9 00:07:46.694837 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 9 00:07:46.714332 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 9 00:07:46.715429 systemd[1]: Reached target time-set.target - System Time Set. Sep 9 00:07:46.852558 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 9 00:07:46.853861 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 00:07:46.863687 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 9 00:07:46.871162 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 9 00:07:46.890443 systemd-udevd[1297]: Using default interface naming scheme 'v255'. Sep 9 00:07:46.960367 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 9 00:07:46.973248 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 9 00:07:46.996492 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Sep 9 00:07:47.015097 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1313) Sep 9 00:07:47.049807 systemd-networkd[1306]: lo: Link UP Sep 9 00:07:47.049812 systemd-networkd[1306]: lo: Gained carrier Sep 9 00:07:47.050933 systemd-networkd[1306]: Enumeration completed Sep 9 00:07:47.051069 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 9 00:07:47.051999 systemd-networkd[1306]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 00:07:47.052007 systemd-networkd[1306]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 9 00:07:47.052645 systemd-networkd[1306]: eth0: Link UP Sep 9 00:07:47.052651 systemd-networkd[1306]: eth0: Gained carrier Sep 9 00:07:47.052665 systemd-networkd[1306]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 9 00:07:47.052906 systemd[1]: Reached target network.target - Network. Sep 9 00:07:47.060151 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 9 00:07:47.062893 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 9 00:07:47.067236 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 9 00:07:47.071056 systemd-networkd[1306]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 9 00:07:47.071786 systemd-timesyncd[1287]: Network configuration changed, trying to establish connection. Sep 9 00:07:46.637550 systemd-timesyncd[1287]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 9 00:07:46.689783 systemd-journald[1109]: Time jumped backwards, rotating. Sep 9 00:07:46.637611 systemd-timesyncd[1287]: Initial clock synchronization to Tue 2025-09-09 00:07:46.637440 UTC. Sep 9 00:07:46.637914 systemd-resolved[1248]: Clock change detected. Flushing caches. Sep 9 00:07:46.648590 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 9 00:07:46.667605 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 9 00:07:46.683502 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 9 00:07:46.691648 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 9 00:07:46.718612 lvm[1335]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 00:07:46.767001 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 9 00:07:46.768229 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 9 00:07:46.779626 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 9 00:07:46.783732 lvm[1340]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 9 00:07:46.796269 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 9 00:07:46.823989 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 9 00:07:46.898013 ldconfig[1148]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 9 00:07:46.935202 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 9 00:07:46.953572 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 9 00:07:46.961886 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 9 00:07:46.963053 systemd[1]: Reached target sysinit.target - System Initialization. Sep 9 00:07:46.964084 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 9 00:07:46.965110 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 00:07:46.966323 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 9 00:07:46.967418 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 9 00:07:46.968357 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 9 00:07:46.969494 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 9 00:07:46.969525 systemd[1]: Reached target paths.target - Path Units. Sep 9 00:07:46.970202 systemd[1]: Reached target timers.target - Timer Units. Sep 9 00:07:46.971845 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 9 00:07:46.974175 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 00:07:46.985454 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 9 00:07:46.986796 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 00:07:46.987818 systemd[1]: Reached target sockets.target - Socket Units. Sep 9 00:07:46.988648 systemd[1]: Reached target basic.target - Basic System. Sep 9 00:07:46.989421 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 9 00:07:46.989451 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 9 00:07:46.990489 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 00:07:46.992305 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 9 00:07:46.994084 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 9 00:07:46.996592 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 9 00:07:46.997472 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 00:07:47.000185 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 9 00:07:47.001869 jq[1351]: false Sep 9 00:07:47.004580 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 9 00:07:47.008592 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 9 00:07:47.014329 extend-filesystems[1352]: Found loop2 Sep 9 00:07:47.014329 extend-filesystems[1352]: Found loop3 Sep 9 00:07:47.014329 extend-filesystems[1352]: Found vda Sep 9 00:07:47.014329 extend-filesystems[1352]: Found vda1 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda2 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda3 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found usr Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda4 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda6 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda7 Sep 9 00:07:47.019466 extend-filesystems[1352]: Found vda9 Sep 9 00:07:47.019466 extend-filesystems[1352]: Checking size of /dev/vda9 Sep 9 00:07:47.014683 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 9 00:07:47.026837 dbus-daemon[1350]: [system] SELinux support is enabled Sep 9 00:07:47.016824 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 9 00:07:47.017279 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 9 00:07:47.018632 systemd[1]: Starting update-engine.service - Update Engine... Sep 9 00:07:47.021647 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 9 00:07:47.026858 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 9 00:07:47.027021 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 9 00:07:47.027219 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 9 00:07:47.032381 systemd[1]: motdgen.service: Deactivated successfully. Sep 9 00:07:47.032743 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 9 00:07:47.033932 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 9 00:07:47.034451 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 9 00:07:47.039024 extend-filesystems[1352]: Old size kept for /dev/vda9 Sep 9 00:07:47.043873 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 9 00:07:47.044079 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 9 00:07:47.048224 jq[1366]: true Sep 9 00:07:47.054424 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1311) Sep 9 00:07:47.060419 update_engine[1364]: I20250909 00:07:47.059132 1364 main.cc:92] Flatcar Update Engine starting Sep 9 00:07:47.064844 update_engine[1364]: I20250909 00:07:47.064800 1364 update_check_scheduler.cc:74] Next update check in 9m40s Sep 9 00:07:47.072523 systemd[1]: Started update-engine.service - Update Engine. Sep 9 00:07:47.074065 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 00:07:47.074111 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 9 00:07:47.076743 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 00:07:47.076771 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 9 00:07:47.080847 (ntainerd)[1379]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 00:07:47.081930 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 9 00:07:47.084324 jq[1378]: true Sep 9 00:07:47.089575 systemd-logind[1362]: Watching system buttons on /dev/input/event0 (Power Button) Sep 9 00:07:47.091427 systemd-logind[1362]: New seat seat0. Sep 9 00:07:47.100066 systemd[1]: Started systemd-logind.service - User Login Management. Sep 9 00:07:47.131691 locksmithd[1383]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 9 00:07:47.138603 bash[1402]: Updated "/home/core/.ssh/authorized_keys" Sep 9 00:07:47.140268 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 9 00:07:47.141987 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 9 00:07:47.236785 containerd[1379]: time="2025-09-09T00:07:47.236490409Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 9 00:07:47.261670 containerd[1379]: time="2025-09-09T00:07:47.261441689Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.262903809Z" 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 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.262948049Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.262965169Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263133489Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263150969Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263203409Z" 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 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263215409Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263414569Z" 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 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263433449Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263447529Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264220 containerd[1379]: time="2025-09-09T00:07:47.263456849Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.263584369Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.263824329Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.263937009Z" 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 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.263951849Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.264026449Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 00:07:47.264527 containerd[1379]: time="2025-09-09T00:07:47.264078609Z" level=info msg="metadata content store policy set" policy=shared Sep 9 00:07:47.298954 containerd[1379]: time="2025-09-09T00:07:47.298905969Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 00:07:47.299099 containerd[1379]: time="2025-09-09T00:07:47.299083009Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 00:07:47.299154 containerd[1379]: time="2025-09-09T00:07:47.299141449Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 00:07:47.299208 containerd[1379]: time="2025-09-09T00:07:47.299195689Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 00:07:47.299270 containerd[1379]: time="2025-09-09T00:07:47.299257529Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 00:07:47.299526 containerd[1379]: time="2025-09-09T00:07:47.299505449Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 00:07:47.299907 containerd[1379]: time="2025-09-09T00:07:47.299848009Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 00:07:47.300025 containerd[1379]: time="2025-09-09T00:07:47.300006769Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 00:07:47.300056 containerd[1379]: time="2025-09-09T00:07:47.300030049Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 00:07:47.300056 containerd[1379]: time="2025-09-09T00:07:47.300045129Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 00:07:47.300171 containerd[1379]: time="2025-09-09T00:07:47.300147209Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300171 containerd[1379]: time="2025-09-09T00:07:47.300165689Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300217 containerd[1379]: time="2025-09-09T00:07:47.300179329Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300217 containerd[1379]: time="2025-09-09T00:07:47.300193969Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300217 containerd[1379]: time="2025-09-09T00:07:47.300209849Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300268 containerd[1379]: time="2025-09-09T00:07:47.300222529Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300268 containerd[1379]: time="2025-09-09T00:07:47.300234969Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300268 containerd[1379]: time="2025-09-09T00:07:47.300246369Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 00:07:47.300316 containerd[1379]: time="2025-09-09T00:07:47.300266369Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300316 containerd[1379]: time="2025-09-09T00:07:47.300280569Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300316 containerd[1379]: time="2025-09-09T00:07:47.300292409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300316 containerd[1379]: time="2025-09-09T00:07:47.300304329Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300315809Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300328289Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300340009Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300352649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300373609Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300394 containerd[1379]: time="2025-09-09T00:07:47.300391489Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300429049Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300444569Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300457569Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300472889Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300493089Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300511 containerd[1379]: time="2025-09-09T00:07:47.300505569Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.300642 containerd[1379]: time="2025-09-09T00:07:47.300517409Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.300790969Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.300829089Z" 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 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301027689Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301076329Z" 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 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301090329Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301113169Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301131769Z" level=info msg="NRI interface is disabled by configuration." Sep 9 00:07:47.301463 containerd[1379]: time="2025-09-09T00:07:47.301144809Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 00:07:47.301798 containerd[1379]: time="2025-09-09T00:07:47.301721969Z" 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 00:07:47.301961 containerd[1379]: time="2025-09-09T00:07:47.301945089Z" level=info msg="Connect containerd service" Sep 9 00:07:47.302043 containerd[1379]: time="2025-09-09T00:07:47.302029089Z" level=info msg="using legacy CRI server" Sep 9 00:07:47.302092 containerd[1379]: time="2025-09-09T00:07:47.302078929Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 00:07:47.302206 containerd[1379]: time="2025-09-09T00:07:47.302190529Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 00:07:47.303016 containerd[1379]: time="2025-09-09T00:07:47.302987529Z" 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 00:07:47.303429 containerd[1379]: time="2025-09-09T00:07:47.303304249Z" level=info msg="Start subscribing containerd event" Sep 9 00:07:47.303429 containerd[1379]: time="2025-09-09T00:07:47.303393889Z" level=info msg="Start recovering state" Sep 9 00:07:47.303531 containerd[1379]: time="2025-09-09T00:07:47.303510489Z" level=info msg="Start event monitor" Sep 9 00:07:47.303557 containerd[1379]: time="2025-09-09T00:07:47.303538769Z" level=info msg="Start snapshots syncer" Sep 9 00:07:47.303557 containerd[1379]: time="2025-09-09T00:07:47.303549849Z" level=info msg="Start cni network conf syncer for default" Sep 9 00:07:47.303605 containerd[1379]: time="2025-09-09T00:07:47.303565049Z" level=info msg="Start streaming server" Sep 9 00:07:47.303787 containerd[1379]: time="2025-09-09T00:07:47.303765489Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 00:07:47.303890 containerd[1379]: time="2025-09-09T00:07:47.303875169Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 00:07:47.304064 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 00:07:47.305813 containerd[1379]: time="2025-09-09T00:07:47.305304809Z" level=info msg="containerd successfully booted in 0.069758s" Sep 9 00:07:47.626019 sshd_keygen[1370]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 9 00:07:47.645027 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 9 00:07:47.662698 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 9 00:07:47.671712 systemd[1]: issuegen.service: Deactivated successfully. Sep 9 00:07:47.671945 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 9 00:07:47.677319 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 9 00:07:47.689282 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 9 00:07:47.704849 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 9 00:07:47.709935 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Sep 9 00:07:47.711852 systemd[1]: Reached target getty.target - Login Prompts. Sep 9 00:07:48.287550 systemd-networkd[1306]: eth0: Gained IPv6LL Sep 9 00:07:48.289984 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 9 00:07:48.291638 systemd[1]: Reached target network-online.target - Network is Online. Sep 9 00:07:48.302620 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 9 00:07:48.304434 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 9 00:07:48.317828 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 9 00:07:48.318003 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 9 00:07:48.319249 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 9 00:07:48.320590 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 9 00:07:48.321858 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 9 00:07:48.325458 systemd[1]: Startup finished in 585ms (kernel) + 3.726s (initrd) + 3.374s (userspace) = 7.686s. Sep 9 00:07:53.970110 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 9 00:07:53.971214 systemd[1]: Started sshd@0-10.0.0.5:22-10.0.0.1:35228.service - OpenSSH per-connection server daemon (10.0.0.1:35228). Sep 9 00:07:54.014695 sshd[1450]: Accepted publickey for core from 10.0.0.1 port 35228 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.016606 sshd[1450]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.024586 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 9 00:07:54.041661 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 9 00:07:54.043128 systemd-logind[1362]: New session 1 of user core. Sep 9 00:07:54.050659 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 9 00:07:54.062660 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 9 00:07:54.064933 (systemd)[1454]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 9 00:07:54.133871 systemd[1454]: Queued start job for default target default.target. Sep 9 00:07:54.147352 systemd[1454]: Created slice app.slice - User Application Slice. Sep 9 00:07:54.147383 systemd[1454]: Reached target paths.target - Paths. Sep 9 00:07:54.147424 systemd[1454]: Reached target timers.target - Timers. Sep 9 00:07:54.148636 systemd[1454]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 9 00:07:54.158684 systemd[1454]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 9 00:07:54.158752 systemd[1454]: Reached target sockets.target - Sockets. Sep 9 00:07:54.158764 systemd[1454]: Reached target basic.target - Basic System. Sep 9 00:07:54.158801 systemd[1454]: Reached target default.target - Main User Target. Sep 9 00:07:54.158827 systemd[1454]: Startup finished in 89ms. Sep 9 00:07:54.159172 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 9 00:07:54.160419 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 9 00:07:54.223643 systemd[1]: Started sshd@1-10.0.0.5:22-10.0.0.1:35232.service - OpenSSH per-connection server daemon (10.0.0.1:35232). Sep 9 00:07:54.255720 sshd[1465]: Accepted publickey for core from 10.0.0.1 port 35232 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.256947 sshd[1465]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.261352 systemd-logind[1362]: New session 2 of user core. Sep 9 00:07:54.271574 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 9 00:07:54.322588 sshd[1465]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:54.330536 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:35232.service: Deactivated successfully. Sep 9 00:07:54.331750 systemd[1]: session-2.scope: Deactivated successfully. Sep 9 00:07:54.333304 systemd-logind[1362]: Session 2 logged out. Waiting for processes to exit. Sep 9 00:07:54.334289 systemd[1]: Started sshd@2-10.0.0.5:22-10.0.0.1:35248.service - OpenSSH per-connection server daemon (10.0.0.1:35248). Sep 9 00:07:54.334956 systemd-logind[1362]: Removed session 2. Sep 9 00:07:54.366950 sshd[1472]: Accepted publickey for core from 10.0.0.1 port 35248 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.368038 sshd[1472]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.371254 systemd-logind[1362]: New session 3 of user core. Sep 9 00:07:54.383539 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 9 00:07:54.431218 sshd[1472]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:54.441852 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:35248.service: Deactivated successfully. Sep 9 00:07:54.443168 systemd[1]: session-3.scope: Deactivated successfully. Sep 9 00:07:54.444189 systemd-logind[1362]: Session 3 logged out. Waiting for processes to exit. Sep 9 00:07:54.450614 systemd[1]: Started sshd@3-10.0.0.5:22-10.0.0.1:35260.service - OpenSSH per-connection server daemon (10.0.0.1:35260). Sep 9 00:07:54.451683 systemd-logind[1362]: Removed session 3. Sep 9 00:07:54.479931 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 35260 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.481082 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.484837 systemd-logind[1362]: New session 4 of user core. Sep 9 00:07:54.491529 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 9 00:07:54.544371 sshd[1479]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:54.552476 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:35260.service: Deactivated successfully. Sep 9 00:07:54.553783 systemd[1]: session-4.scope: Deactivated successfully. Sep 9 00:07:54.554919 systemd-logind[1362]: Session 4 logged out. Waiting for processes to exit. Sep 9 00:07:54.555914 systemd[1]: Started sshd@4-10.0.0.5:22-10.0.0.1:35264.service - OpenSSH per-connection server daemon (10.0.0.1:35264). Sep 9 00:07:54.556606 systemd-logind[1362]: Removed session 4. Sep 9 00:07:54.587966 sshd[1486]: Accepted publickey for core from 10.0.0.1 port 35264 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.589160 sshd[1486]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.593187 systemd-logind[1362]: New session 5 of user core. Sep 9 00:07:54.608552 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 9 00:07:54.665337 sudo[1489]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 9 00:07:54.665650 sudo[1489]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 00:07:54.684450 sudo[1489]: pam_unix(sudo:session): session closed for user root Sep 9 00:07:54.686183 sshd[1486]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:54.695880 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:35264.service: Deactivated successfully. Sep 9 00:07:54.697287 systemd[1]: session-5.scope: Deactivated successfully. Sep 9 00:07:54.699363 systemd-logind[1362]: Session 5 logged out. Waiting for processes to exit. Sep 9 00:07:54.700551 systemd[1]: Started sshd@5-10.0.0.5:22-10.0.0.1:35270.service - OpenSSH per-connection server daemon (10.0.0.1:35270). Sep 9 00:07:54.701173 systemd-logind[1362]: Removed session 5. Sep 9 00:07:54.734379 sshd[1494]: Accepted publickey for core from 10.0.0.1 port 35270 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.735555 sshd[1494]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.739159 systemd-logind[1362]: New session 6 of user core. Sep 9 00:07:54.756556 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 9 00:07:54.807889 sudo[1498]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Sep 9 00:07:54.808452 sudo[1498]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 00:07:54.811418 sudo[1498]: pam_unix(sudo:session): session closed for user root Sep 9 00:07:54.815747 sudo[1497]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Sep 9 00:07:54.816012 sudo[1497]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 00:07:54.833642 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Sep 9 00:07:54.835158 auditctl[1501]: No rules Sep 9 00:07:54.836006 systemd[1]: audit-rules.service: Deactivated successfully. Sep 9 00:07:54.837444 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Sep 9 00:07:54.839083 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 9 00:07:54.862511 augenrules[1519]: No rules Sep 9 00:07:54.863877 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 9 00:07:54.865182 sudo[1497]: pam_unix(sudo:session): session closed for user root Sep 9 00:07:54.867095 sshd[1494]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:54.879368 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:35270.service: Deactivated successfully. Sep 9 00:07:54.880960 systemd[1]: session-6.scope: Deactivated successfully. Sep 9 00:07:54.883489 systemd-logind[1362]: Session 6 logged out. Waiting for processes to exit. Sep 9 00:07:54.884950 systemd[1]: Started sshd@6-10.0.0.5:22-10.0.0.1:35286.service - OpenSSH per-connection server daemon (10.0.0.1:35286). Sep 9 00:07:54.886012 systemd-logind[1362]: Removed session 6. Sep 9 00:07:54.917855 sshd[1527]: Accepted publickey for core from 10.0.0.1 port 35286 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:54.919015 sshd[1527]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:54.923275 systemd-logind[1362]: New session 7 of user core. Sep 9 00:07:54.937592 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 9 00:07:55.003666 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 00:07:55.003750 (dockerd)[1531]: 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 00:07:55.218700 dockerd[1531]: time="2025-09-09T00:07:55.218625969Z" level=info msg="Starting up" Sep 9 00:07:55.292386 dockerd[1531]: time="2025-09-09T00:07:55.291995209Z" level=info msg="Loading containers: start." Sep 9 00:07:55.380481 kernel: Initializing XFRM netlink socket Sep 9 00:07:55.443614 systemd-networkd[1306]: docker0: Link UP Sep 9 00:07:55.460657 dockerd[1531]: time="2025-09-09T00:07:55.460607009Z" level=info msg="Loading containers: done." Sep 9 00:07:55.471546 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck843522782-merged.mount: Deactivated successfully. Sep 9 00:07:55.474127 dockerd[1531]: time="2025-09-09T00:07:55.474083249Z" 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 00:07:55.474197 dockerd[1531]: time="2025-09-09T00:07:55.474176809Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Sep 9 00:07:55.474285 dockerd[1531]: time="2025-09-09T00:07:55.474269729Z" level=info msg="Daemon has completed initialization" Sep 9 00:07:55.507532 dockerd[1531]: time="2025-09-09T00:07:55.507390929Z" level=info msg="API listen on /run/docker.sock" Sep 9 00:07:55.507771 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 00:07:55.514677 sshd[1527]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:55.531754 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:35286.service: Deactivated successfully. Sep 9 00:07:55.533118 systemd[1]: session-7.scope: Deactivated successfully. Sep 9 00:07:55.534312 systemd-logind[1362]: Session 7 logged out. Waiting for processes to exit. Sep 9 00:07:55.535383 systemd[1]: Started sshd@7-10.0.0.5:22-10.0.0.1:35288.service - OpenSSH per-connection server daemon (10.0.0.1:35288). Sep 9 00:07:55.536086 systemd-logind[1362]: Removed session 7. Sep 9 00:07:55.568554 sshd[1673]: Accepted publickey for core from 10.0.0.1 port 35288 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:55.570130 sshd[1673]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:55.573906 systemd-logind[1362]: New session 8 of user core. Sep 9 00:07:55.584604 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 9 00:07:56.745493 systemd[1]: var-lib-docker-overlay2-0251aeff8215ea1ccf2f394f93f22c64ef24c4deca6f168f457eefabcb315634\x2dinit-merged.mount: Deactivated successfully. Sep 9 00:07:56.771830 kernel: docker0: port 1(veth9d40c49) entered blocking state Sep 9 00:07:56.771918 kernel: docker0: port 1(veth9d40c49) entered disabled state Sep 9 00:07:56.771936 kernel: veth9d40c49: entered allmulticast mode Sep 9 00:07:56.771951 kernel: veth9d40c49: entered promiscuous mode Sep 9 00:07:56.772506 systemd-networkd[1306]: veth9d40c49: Link UP Sep 9 00:07:56.853461 containerd[1379]: time="2025-09-09T00:07:56.853245929Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 00:07:56.853461 containerd[1379]: time="2025-09-09T00:07:56.853312689Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 00:07:56.853461 containerd[1379]: time="2025-09-09T00:07:56.853337369Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:07:56.853461 containerd[1379]: time="2025-09-09T00:07:56.853446249Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:07:56.876531 systemd[1]: Started docker-e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16.scope - libcontainer container e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16. Sep 9 00:07:56.936422 kernel: eth0: renamed from veth6220c09 Sep 9 00:07:56.946890 kernel: docker0: port 1(veth9d40c49) entered blocking state Sep 9 00:07:56.946924 kernel: docker0: port 1(veth9d40c49) entered forwarding state Sep 9 00:07:56.946943 systemd-networkd[1306]: veth9d40c49: Gained carrier Sep 9 00:07:56.947228 systemd-networkd[1306]: docker0: Gained carrier Sep 9 00:07:56.950396 systemd-resolved[1248]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 00:07:56.974098 sshd[1673]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:56.985610 systemd[1]: sshd@7-10.0.0.5:22-10.0.0.1:35288.service: Deactivated successfully. Sep 9 00:07:56.986896 systemd[1]: session-8.scope: Deactivated successfully. Sep 9 00:07:56.987438 systemd-logind[1362]: Session 8 logged out. Waiting for processes to exit. Sep 9 00:07:57.000682 systemd[1]: Started sshd@8-10.0.0.5:22-10.0.0.1:35300.service - OpenSSH per-connection server daemon (10.0.0.1:35300). Sep 9 00:07:57.002467 systemd-logind[1362]: Removed session 8. Sep 9 00:07:57.029998 sshd[1755]: Accepted publickey for core from 10.0.0.1 port 35300 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:57.031089 sshd[1755]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:57.034964 systemd-logind[1362]: New session 9 of user core. Sep 9 00:07:57.048534 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 9 00:07:57.101482 sshd[1755]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:57.107470 systemd[1]: sshd@8-10.0.0.5:22-10.0.0.1:35300.service: Deactivated successfully. Sep 9 00:07:57.108711 systemd[1]: session-9.scope: Deactivated successfully. Sep 9 00:07:57.109810 systemd-logind[1362]: Session 9 logged out. Waiting for processes to exit. Sep 9 00:07:57.111595 systemd[1]: Started sshd@9-10.0.0.5:22-10.0.0.1:35308.service - OpenSSH per-connection server daemon (10.0.0.1:35308). Sep 9 00:07:57.112265 systemd-logind[1362]: Removed session 9. Sep 9 00:07:57.143063 sshd[1762]: Accepted publickey for core from 10.0.0.1 port 35308 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:57.144136 sshd[1762]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:57.147177 systemd-logind[1362]: New session 10 of user core. Sep 9 00:07:57.159567 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 9 00:07:57.208281 sudo[1765]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGTERM 1379 Sep 9 00:07:57.208579 sudo[1765]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 00:07:57.211379 sudo[1765]: pam_unix(sudo:session): session closed for user root Sep 9 00:07:57.211646 containerd[1379]: time="2025-09-09T00:07:57.211450129Z" level=info msg="Stop CRI service" Sep 9 00:07:57.212243 dockerd[1531]: time="2025-09-09T00:07:57.212192609Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 00:07:57.212243 dockerd[1531]: time="2025-09-09T00:07:57.212240569Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 00:07:57.212509 dockerd[1531]: time="2025-09-09T00:07:57.212231729Z" 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 00:07:57.212509 dockerd[1531]: time="2025-09-09T00:07:57.212363489Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 00:07:57.213568 sshd[1762]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:57.216515 containerd[1379]: time="2025-09-09T00:07:57.216466929Z" level=info msg="Stop CRI service" Sep 9 00:07:57.216592 containerd[1379]: time="2025-09-09T00:07:57.216566369Z" level=info msg="Event monitor stopped" Sep 9 00:07:57.216613 containerd[1379]: time="2025-09-09T00:07:57.216590849Z" level=info msg="Stream server stopped" Sep 9 00:07:57.224528 systemd[1]: containerd.service: Deactivated successfully. Sep 9 00:07:57.224581 systemd[1]: containerd.service: Unit process 1707 (containerd-shim) remains running after unit stopped. Sep 9 00:07:57.225076 systemd[1]: sshd@9-10.0.0.5:22-10.0.0.1:35308.service: Deactivated successfully. Sep 9 00:07:57.226530 systemd[1]: session-10.scope: Deactivated successfully. Sep 9 00:07:57.227005 systemd-logind[1362]: Session 10 logged out. Waiting for processes to exit. Sep 9 00:07:57.229065 systemd[1]: Started sshd@10-10.0.0.5:22-10.0.0.1:35320.service - OpenSSH per-connection server daemon (10.0.0.1:35320). Sep 9 00:07:57.229765 systemd-logind[1362]: Removed session 10. Sep 9 00:07:57.260656 sshd[1771]: Accepted publickey for core from 10.0.0.1 port 35320 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:07:57.262444 sshd[1771]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:07:57.265687 systemd-logind[1362]: New session 11 of user core. Sep 9 00:07:57.274532 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 9 00:07:57.326496 sshd[1771]: pam_unix(sshd:session): session closed for user core Sep 9 00:07:57.329777 systemd[1]: sshd@10-10.0.0.5:22-10.0.0.1:35320.service: Deactivated successfully. Sep 9 00:07:57.331283 systemd[1]: session-11.scope: Deactivated successfully. Sep 9 00:07:57.332145 systemd-logind[1362]: Session 11 logged out. Waiting for processes to exit. Sep 9 00:07:57.333242 systemd-logind[1362]: Removed session 11. Sep 9 00:07:58.719623 systemd-networkd[1306]: veth9d40c49: Gained IPv6LL Sep 9 00:07:58.719908 systemd-networkd[1306]: docker0: Gained IPv6LL Sep 9 00:08:02.475069 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 9 00:08:02.475572 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 00:08:02.475795 dockerd[1531]: time="2025-09-09T00:08:02.475723049Z" level=info msg="Processing signal 'terminated'" Sep 9 00:08:03.336645 systemd[1]: Started sshd@11-10.0.0.5:22-10.0.0.1:42506.service - OpenSSH per-connection server daemon (10.0.0.1:42506). Sep 9 00:08:03.371052 sshd[1778]: Accepted publickey for core from 10.0.0.1 port 42506 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:03.372548 sshd[1778]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:03.376996 systemd-logind[1362]: New session 12 of user core. Sep 9 00:08:03.386620 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 9 00:08:03.450513 sshd[1778]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:03.454294 systemd[1]: sshd@11-10.0.0.5:22-10.0.0.1:42506.service: Deactivated successfully. Sep 9 00:08:03.456703 systemd[1]: session-12.scope: Deactivated successfully. Sep 9 00:08:03.457606 systemd-logind[1362]: Session 12 logged out. Waiting for processes to exit. Sep 9 00:08:03.459058 systemd-logind[1362]: Removed session 12. Sep 9 00:08:04.477141 dockerd[1531]: time="2025-09-09T00:08:04.477063569Z" level=error msg="Error sending stop (signal 15) to container" container=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 error="Cannot kill container e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Sep 9 00:08:04.477141 dockerd[1531]: time="2025-09-09T00:08:04.477119169Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 Sep 9 00:08:09.462711 systemd[1]: Started sshd@12-10.0.0.5:22-10.0.0.1:42510.service - OpenSSH per-connection server daemon (10.0.0.1:42510). Sep 9 00:08:09.495736 sshd[1785]: Accepted publickey for core from 10.0.0.1 port 42510 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:09.496940 sshd[1785]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:09.500213 systemd-logind[1362]: New session 13 of user core. Sep 9 00:08:09.510544 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 9 00:08:09.564034 sshd[1785]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:09.566890 systemd[1]: sshd@12-10.0.0.5:22-10.0.0.1:42510.service: Deactivated successfully. Sep 9 00:08:09.568394 systemd[1]: session-13.scope: Deactivated successfully. Sep 9 00:08:09.569842 systemd-logind[1362]: Session 13 logged out. Waiting for processes to exit. Sep 9 00:08:09.570731 systemd-logind[1362]: Removed session 13. Sep 9 00:08:14.477793 dockerd[1531]: time="2025-09-09T00:08:14.477529449Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 error="context deadline exceeded" Sep 9 00:08:14.478428 systemd[1]: docker-e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16.scope: Deactivated successfully. Sep 9 00:08:15.576868 systemd[1]: Started sshd@13-10.0.0.5:22-10.0.0.1:51062.service - OpenSSH per-connection server daemon (10.0.0.1:51062). Sep 9 00:08:15.609986 sshd[1792]: Accepted publickey for core from 10.0.0.1 port 51062 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:15.611211 sshd[1792]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:15.615052 systemd-logind[1362]: New session 14 of user core. Sep 9 00:08:15.623591 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 9 00:08:15.677740 sshd[1792]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:15.680647 systemd[1]: sshd@13-10.0.0.5:22-10.0.0.1:51062.service: Deactivated successfully. Sep 9 00:08:15.682796 systemd[1]: session-14.scope: Deactivated successfully. Sep 9 00:08:15.683459 systemd-logind[1362]: Session 14 logged out. Waiting for processes to exit. Sep 9 00:08:15.684198 systemd-logind[1362]: Removed session 14. Sep 9 00:08:17.476514 dockerd[1531]: time="2025-09-09T00:08:17.476433529Z" level=error msg="Force shutdown daemon" Sep 9 00:08:17.476925 dockerd[1531]: time="2025-09-09T00:08:17.476623249Z" level=info msg="Daemon shutdown complete" Sep 9 00:08:17.482077 systemd[1]: docker.service: Deactivated successfully. Sep 9 00:08:17.482728 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 00:08:17.483921 systemd[1]: docker.socket: Deactivated successfully. Sep 9 00:08:17.484719 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 00:08:17.484917 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 00:08:17.487739 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 00:08:17.494671 systemd[1]: containerd.service: Found left-over process 1707 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 00:08:17.494685 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 00:08:17.497725 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 00:08:17.498003 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 00:08:17.517971 systemd[1]: containerd.service: Found left-over process 1707 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 00:08:17.517983 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 00:08:17.526742 (ntainerd)[1804]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 00:08:17.543509 containerd[1804]: time="2025-09-09T00:08:17.543426169Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 9 00:08:17.569364 containerd[1804]: time="2025-09-09T00:08:17.569277529Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.570809 containerd[1804]: time="2025-09-09T00:08:17.570758289Z" 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 00:08:17.570809 containerd[1804]: time="2025-09-09T00:08:17.570795409Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 00:08:17.570809 containerd[1804]: time="2025-09-09T00:08:17.570811849Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 00:08:17.570908 containerd[1804]: time="2025-09-09T00:08:17.570855449Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 00:08:17.570908 containerd[1804]: time="2025-09-09T00:08:17.570870129Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.570908 containerd[1804]: time="2025-09-09T00:08:17.570893369Z" 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 00:08:17.570908 containerd[1804]: time="2025-09-09T00:08:17.570903689Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571096 containerd[1804]: time="2025-09-09T00:08:17.571063409Z" 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 00:08:17.571096 containerd[1804]: time="2025-09-09T00:08:17.571083809Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571142 containerd[1804]: time="2025-09-09T00:08:17.571096889Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571142 containerd[1804]: time="2025-09-09T00:08:17.571107529Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571142 containerd[1804]: time="2025-09-09T00:08:17.571131209Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571312 containerd[1804]: time="2025-09-09T00:08:17.571247889Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:17.571448 containerd[1804]: time="2025-09-09T00:08:17.571354369Z" 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 00:08:17.571448 containerd[1804]: time="2025-09-09T00:08:17.571378009Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 00:08:17.571448 containerd[1804]: time="2025-09-09T00:08:17.571419849Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 00:08:17.571448 containerd[1804]: time="2025-09-09T00:08:17.571436649Z" level=info msg="metadata content store policy set" policy=shared Sep 9 00:08:17.571599 containerd[1804]: time="2025-09-09T00:08:17.571585769Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 00:08:17.571633 containerd[1804]: time="2025-09-09T00:08:17.571616169Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 00:08:17.571656 containerd[1804]: time="2025-09-09T00:08:17.571637249Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 00:08:17.571679 containerd[1804]: time="2025-09-09T00:08:17.571658529Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 00:08:17.571679 containerd[1804]: time="2025-09-09T00:08:17.571673249Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 00:08:17.572384 containerd[1804]: time="2025-09-09T00:08:17.571732569Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 00:08:17.572384 containerd[1804]: time="2025-09-09T00:08:17.571959489Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 00:08:17.582520 containerd[1804]: time="2025-09-09T00:08:17.582473689Z" level=info msg="cleaning leaked shim process" id=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 namespace=moby Sep 9 00:08:17.593565 containerd[1804]: time="2025-09-09T00:08:17.593319449Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 9 00:08:17.593639 containerd[1804]: time="2025-09-09T00:08:17.593551569Z" level=info msg="shim disconnected" id=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 namespace=moby Sep 9 00:08:17.593639 containerd[1804]: time="2025-09-09T00:08:17.593604729Z" level=warning msg="cleaning up after shim disconnected" id=e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16 namespace=moby Sep 9 00:08:17.593639 containerd[1804]: time="2025-09-09T00:08:17.593613089Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 00:08:17.604533 containerd[1804]: time="2025-09-09T00:08:17.604487729Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 00:08:17.604533 containerd[1804]: time="2025-09-09T00:08:17.604535649Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 00:08:17.604658 containerd[1804]: time="2025-09-09T00:08:17.604556489Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 00:08:17.604658 containerd[1804]: time="2025-09-09T00:08:17.604573289Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604658 containerd[1804]: time="2025-09-09T00:08:17.604593089Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604712 containerd[1804]: time="2025-09-09T00:08:17.604615809Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604869 containerd[1804]: time="2025-09-09T00:08:17.604748209Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604869 containerd[1804]: time="2025-09-09T00:08:17.604793969Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604869 containerd[1804]: time="2025-09-09T00:08:17.604837449Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604869 containerd[1804]: time="2025-09-09T00:08:17.604865249Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.604963 containerd[1804]: time="2025-09-09T00:08:17.604889009Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 00:08:17.605050 containerd[1804]: time="2025-09-09T00:08:17.605033609Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605075 containerd[1804]: time="2025-09-09T00:08:17.605058769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605094 containerd[1804]: time="2025-09-09T00:08:17.605074169Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605094 containerd[1804]: time="2025-09-09T00:08:17.605088489Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605134 containerd[1804]: time="2025-09-09T00:08:17.605101249Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605134 containerd[1804]: time="2025-09-09T00:08:17.605114889Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605134 containerd[1804]: time="2025-09-09T00:08:17.605127409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605189 containerd[1804]: time="2025-09-09T00:08:17.605140129Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605189 containerd[1804]: time="2025-09-09T00:08:17.605153289Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605189 containerd[1804]: time="2025-09-09T00:08:17.605169769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605189 containerd[1804]: time="2025-09-09T00:08:17.605181449Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605265 containerd[1804]: time="2025-09-09T00:08:17.605193929Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605265 containerd[1804]: time="2025-09-09T00:08:17.605206969Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605265 containerd[1804]: time="2025-09-09T00:08:17.605231329Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 00:08:17.605265 containerd[1804]: time="2025-09-09T00:08:17.605257409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605336 containerd[1804]: time="2025-09-09T00:08:17.605269969Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605336 containerd[1804]: time="2025-09-09T00:08:17.605281529Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 00:08:17.605370 containerd[1804]: time="2025-09-09T00:08:17.605332969Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 00:08:17.605370 containerd[1804]: time="2025-09-09T00:08:17.605350929Z" 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 00:08:17.605370 containerd[1804]: time="2025-09-09T00:08:17.605361969Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 00:08:17.605502 containerd[1804]: time="2025-09-09T00:08:17.605375009Z" 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 00:08:17.605502 containerd[1804]: time="2025-09-09T00:08:17.605384809Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605502 containerd[1804]: time="2025-09-09T00:08:17.605396809Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 00:08:17.605502 containerd[1804]: time="2025-09-09T00:08:17.605424049Z" level=info msg="NRI interface is disabled by configuration." Sep 9 00:08:17.605502 containerd[1804]: time="2025-09-09T00:08:17.605434649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 00:08:17.605762 containerd[1804]: time="2025-09-09T00:08:17.605691049Z" 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 00:08:17.605762 containerd[1804]: time="2025-09-09T00:08:17.605755409Z" level=info msg="Connect containerd service" Sep 9 00:08:17.605879 containerd[1804]: time="2025-09-09T00:08:17.605787729Z" level=info msg="using legacy CRI server" Sep 9 00:08:17.605879 containerd[1804]: time="2025-09-09T00:08:17.605795289Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 00:08:17.605913 containerd[1804]: time="2025-09-09T00:08:17.605886849Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 00:08:17.606531 containerd[1804]: time="2025-09-09T00:08:17.606505009Z" 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 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606686089Z" level=info msg="Start subscribing containerd event" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606745329Z" level=info msg="Start recovering state" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606748769Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606884089Z" level=info msg="Start event monitor" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606901529Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606909529Z" level=info msg="Start snapshots syncer" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606921609Z" level=info msg="Start cni network conf syncer for default" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.606938009Z" level=info msg="Start streaming server" Sep 9 00:08:17.607113 containerd[1804]: time="2025-09-09T00:08:17.607010489Z" level=info msg="containerd successfully booted in 0.064523s" Sep 9 00:08:17.607133 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 00:08:17.614674 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 00:08:17.614795 (dockerd)[1838]: 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 00:08:17.653926 dockerd[1838]: time="2025-09-09T00:08:17.653860489Z" level=info msg="Starting up" Sep 9 00:08:17.683932 dockerd[1838]: time="2025-09-09T00:08:17.683892929Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 00:08:17.689913 dockerd[1838]: time="2025-09-09T00:08:17.689881249Z" level=info msg="Loading containers: start." Sep 9 00:08:17.706267 systemd[1]: var-lib-docker-overlay2-0251aeff8215ea1ccf2f394f93f22c64ef24c4deca6f168f457eefabcb315634-merged.mount: Deactivated successfully. Sep 9 00:08:17.890285 dockerd[1838]: time="2025-09-09T00:08:17.890155569Z" level=info msg="Removing stale sandbox c6a82a42872a14eeaa92c3b28dcf848d583c523045222082ddfb965af3557293 (e8987c1542160d831d0dab5d58211c4feaf539ebac864fabc4c4fea308375f16)" Sep 9 00:08:17.894503 kernel: docker0: port 1(veth9d40c49) entered disabled state Sep 9 00:08:17.894574 kernel: veth9d40c49 (unregistering): left allmulticast mode Sep 9 00:08:17.894331 systemd-networkd[1306]: veth9d40c49: Link DOWN Sep 9 00:08:17.894337 systemd-networkd[1306]: veth9d40c49: Lost carrier Sep 9 00:08:17.895416 dockerd[1838]: time="2025-09-09T00:08:17.895000529Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 62f2ccafa7e6903edf1123225552fb475aa2e200257156acf87744eb01d7b96f 17be05664ab886cd2843d78a7b901e043723d0dc1b98a7ac9a4b0171983a291b], retrying...." Sep 9 00:08:17.895877 kernel: veth9d40c49 (unregistering): left promiscuous mode Sep 9 00:08:17.895932 kernel: docker0: port 1(veth9d40c49) entered disabled state Sep 9 00:08:17.903905 systemd-networkd[1306]: docker0: Lost carrier Sep 9 00:08:18.065547 dockerd[1838]: time="2025-09-09T00:08:18.065492209Z" 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 00:08:18.224413 dockerd[1838]: time="2025-09-09T00:08:18.223694329Z" level=info msg="Loading containers: done." Sep 9 00:08:18.270640 dockerd[1838]: time="2025-09-09T00:08:18.270577009Z" 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 00:08:18.270796 dockerd[1838]: time="2025-09-09T00:08:18.270687049Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Sep 9 00:08:18.270796 dockerd[1838]: time="2025-09-09T00:08:18.270748249Z" level=info msg="Daemon has completed initialization" Sep 9 00:08:18.288368 dockerd[1838]: time="2025-09-09T00:08:18.288291049Z" level=info msg="API listen on /run/docker.sock" Sep 9 00:08:18.288543 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 00:08:18.671011 systemd[1]: run-docker-netns-c6a82a42872a.mount: Deactivated successfully. Sep 9 00:08:21.689897 systemd[1]: Started sshd@14-10.0.0.5:22-10.0.0.1:49736.service - OpenSSH per-connection server daemon (10.0.0.1:49736). Sep 9 00:08:21.721178 sshd[1990]: Accepted publickey for core from 10.0.0.1 port 49736 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:21.722306 sshd[1990]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:21.727446 systemd-logind[1362]: New session 15 of user core. Sep 9 00:08:21.733627 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 9 00:08:21.790499 sshd[1990]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:21.798557 systemd[1]: sshd@14-10.0.0.5:22-10.0.0.1:49736.service: Deactivated successfully. Sep 9 00:08:21.799863 systemd[1]: session-15.scope: Deactivated successfully. Sep 9 00:08:21.803372 systemd-logind[1362]: Session 15 logged out. Waiting for processes to exit. Sep 9 00:08:21.805522 systemd[1]: Started sshd@15-10.0.0.5:22-10.0.0.1:49748.service - OpenSSH per-connection server daemon (10.0.0.1:49748). Sep 9 00:08:21.809359 systemd-logind[1362]: Removed session 15. Sep 9 00:08:21.835357 sshd[1997]: Accepted publickey for core from 10.0.0.1 port 49748 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:21.836455 sshd[1997]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:21.841311 systemd-logind[1362]: New session 16 of user core. Sep 9 00:08:21.848916 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 9 00:08:21.910908 sshd[1997]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:21.918707 systemd[1]: sshd@15-10.0.0.5:22-10.0.0.1:49748.service: Deactivated successfully. Sep 9 00:08:21.920102 systemd[1]: session-16.scope: Deactivated successfully. Sep 9 00:08:21.920954 systemd-logind[1362]: Session 16 logged out. Waiting for processes to exit. Sep 9 00:08:21.922578 systemd[1]: Started sshd@16-10.0.0.5:22-10.0.0.1:49750.service - OpenSSH per-connection server daemon (10.0.0.1:49750). Sep 9 00:08:21.923275 systemd-logind[1362]: Removed session 16. Sep 9 00:08:21.955111 sshd[2004]: Accepted publickey for core from 10.0.0.1 port 49750 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:21.956423 sshd[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:21.959982 systemd-logind[1362]: New session 17 of user core. Sep 9 00:08:21.972530 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 9 00:08:22.028688 sshd[2004]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:22.042744 systemd[1]: sshd@16-10.0.0.5:22-10.0.0.1:49750.service: Deactivated successfully. Sep 9 00:08:22.044126 systemd[1]: session-17.scope: Deactivated successfully. Sep 9 00:08:22.045334 systemd-logind[1362]: Session 17 logged out. Waiting for processes to exit. Sep 9 00:08:22.046419 systemd[1]: Started sshd@17-10.0.0.5:22-10.0.0.1:49766.service - OpenSSH per-connection server daemon (10.0.0.1:49766). Sep 9 00:08:22.047725 systemd-logind[1362]: Removed session 17. Sep 9 00:08:22.079140 sshd[2018]: Accepted publickey for core from 10.0.0.1 port 49766 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:22.080252 sshd[2018]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:22.083697 systemd-logind[1362]: New session 18 of user core. Sep 9 00:08:22.095605 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 9 00:08:22.183379 kernel: docker0: port 1(vethf452735) entered blocking state Sep 9 00:08:22.183523 kernel: docker0: port 1(vethf452735) entered disabled state Sep 9 00:08:22.183546 kernel: vethf452735: entered allmulticast mode Sep 9 00:08:22.183564 kernel: vethf452735: entered promiscuous mode Sep 9 00:08:22.184835 systemd-networkd[1306]: vethf452735: Link UP Sep 9 00:08:22.214175 containerd[1804]: time="2025-09-09T00:08:22.213981078Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 00:08:22.214175 containerd[1804]: time="2025-09-09T00:08:22.214055918Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 00:08:22.214175 containerd[1804]: time="2025-09-09T00:08:22.214074519Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:08:22.214175 containerd[1804]: time="2025-09-09T00:08:22.214162199Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:08:22.237577 systemd[1]: Started docker-9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba.scope - libcontainer container 9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba. Sep 9 00:08:22.290433 kernel: eth0: renamed from veth6754159 Sep 9 00:08:22.300979 kernel: docker0: port 1(vethf452735) entered blocking state Sep 9 00:08:22.301038 kernel: docker0: port 1(vethf452735) entered forwarding state Sep 9 00:08:22.301024 systemd-networkd[1306]: vethf452735: Gained carrier Sep 9 00:08:22.301322 systemd-networkd[1306]: docker0: Gained carrier Sep 9 00:08:22.303794 systemd-resolved[1248]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 00:08:22.327158 sshd[2018]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:22.334673 systemd[1]: sshd@17-10.0.0.5:22-10.0.0.1:49766.service: Deactivated successfully. Sep 9 00:08:22.335950 systemd[1]: session-18.scope: Deactivated successfully. Sep 9 00:08:22.337950 systemd-logind[1362]: Session 18 logged out. Waiting for processes to exit. Sep 9 00:08:22.348687 systemd[1]: Started sshd@18-10.0.0.5:22-10.0.0.1:49768.service - OpenSSH per-connection server daemon (10.0.0.1:49768). Sep 9 00:08:22.350547 systemd-logind[1362]: Removed session 18. Sep 9 00:08:22.378583 sshd[2093]: Accepted publickey for core from 10.0.0.1 port 49768 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:22.379831 sshd[2093]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:22.383677 systemd-logind[1362]: New session 19 of user core. Sep 9 00:08:22.395544 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 9 00:08:22.448429 sshd[2093]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:22.456728 systemd[1]: sshd@18-10.0.0.5:22-10.0.0.1:49768.service: Deactivated successfully. Sep 9 00:08:22.457954 systemd[1]: session-19.scope: Deactivated successfully. Sep 9 00:08:22.459953 systemd-logind[1362]: Session 19 logged out. Waiting for processes to exit. Sep 9 00:08:22.461567 systemd[1]: Started sshd@19-10.0.0.5:22-10.0.0.1:49782.service - OpenSSH per-connection server daemon (10.0.0.1:49782). Sep 9 00:08:22.462279 systemd-logind[1362]: Removed session 19. Sep 9 00:08:22.496113 sshd[2100]: Accepted publickey for core from 10.0.0.1 port 49782 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:22.497363 sshd[2100]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:22.502019 systemd-logind[1362]: New session 20 of user core. Sep 9 00:08:22.512619 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 9 00:08:22.563703 sudo[2103]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGHUP 1804 Sep 9 00:08:22.563970 sudo[2103]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 9 00:08:22.567609 sudo[2103]: pam_unix(sudo:session): session closed for user root Sep 9 00:08:22.569911 dockerd[1838]: time="2025-09-09T00:08:22.569543416Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 9 00:08:22.569911 dockerd[1838]: time="2025-09-09T00:08:22.569581376Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 9 00:08:22.569911 dockerd[1838]: time="2025-09-09T00:08:22.569559096Z" 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 00:08:22.569911 dockerd[1838]: time="2025-09-09T00:08:22.569716817Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 9 00:08:22.570555 systemd[1]: containerd.service: Deactivated successfully. Sep 9 00:08:22.570634 systemd[1]: containerd.service: Unit process 2048 (containerd-shim) remains running after unit stopped. Sep 9 00:08:22.571772 sshd[2100]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:22.584465 systemd[1]: sshd@19-10.0.0.5:22-10.0.0.1:49782.service: Deactivated successfully. Sep 9 00:08:22.586430 systemd[1]: session-20.scope: Deactivated successfully. Sep 9 00:08:22.587159 systemd-logind[1362]: Session 20 logged out. Waiting for processes to exit. Sep 9 00:08:22.597714 systemd[1]: Started sshd@20-10.0.0.5:22-10.0.0.1:49796.service - OpenSSH per-connection server daemon (10.0.0.1:49796). Sep 9 00:08:22.598835 systemd-logind[1362]: Removed session 20. Sep 9 00:08:22.630969 sshd[2109]: Accepted publickey for core from 10.0.0.1 port 49796 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:22.632307 sshd[2109]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:22.635589 systemd-logind[1362]: New session 21 of user core. Sep 9 00:08:22.649636 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 9 00:08:22.705557 sshd[2109]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:22.707940 systemd[1]: sshd@20-10.0.0.5:22-10.0.0.1:49796.service: Deactivated successfully. Sep 9 00:08:22.709353 systemd[1]: session-21.scope: Deactivated successfully. Sep 9 00:08:22.712684 systemd-logind[1362]: Session 21 logged out. Waiting for processes to exit. Sep 9 00:08:22.713487 systemd-logind[1362]: Removed session 21. Sep 9 00:08:23.359643 systemd-networkd[1306]: vethf452735: Gained IPv6LL Sep 9 00:08:27.632507 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 9 00:08:27.632936 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 9 00:08:27.633591 dockerd[1838]: time="2025-09-09T00:08:27.633064755Z" level=info msg="Processing signal 'terminated'" Sep 9 00:08:28.714674 systemd[1]: Started sshd@21-10.0.0.5:22-10.0.0.1:49804.service - OpenSSH per-connection server daemon (10.0.0.1:49804). Sep 9 00:08:28.750795 sshd[2116]: Accepted publickey for core from 10.0.0.1 port 49804 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:28.752049 sshd[2116]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:28.756469 systemd-logind[1362]: New session 22 of user core. Sep 9 00:08:28.764566 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 9 00:08:28.818506 sshd[2116]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:28.821740 systemd[1]: sshd@21-10.0.0.5:22-10.0.0.1:49804.service: Deactivated successfully. Sep 9 00:08:28.823668 systemd[1]: session-22.scope: Deactivated successfully. Sep 9 00:08:28.824485 systemd-logind[1362]: Session 22 logged out. Waiting for processes to exit. Sep 9 00:08:28.826337 systemd-logind[1362]: Removed session 22. Sep 9 00:08:29.635250 dockerd[1838]: time="2025-09-09T00:08:29.634935856Z" level=error msg="Error sending stop (signal 15) to container" container=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba error="Cannot kill container 9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Sep 9 00:08:29.635250 dockerd[1838]: time="2025-09-09T00:08:29.634998576Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba Sep 9 00:08:32.644800 update_engine[1364]: I20250909 00:08:32.644116 1364 update_attempter.cc:509] Updating boot flags... Sep 9 00:08:32.666445 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2129) Sep 9 00:08:32.703440 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (2130) Sep 9 00:08:34.829164 systemd[1]: Started sshd@22-10.0.0.5:22-10.0.0.1:45772.service - OpenSSH per-connection server daemon (10.0.0.1:45772). Sep 9 00:08:34.865474 sshd[2137]: Accepted publickey for core from 10.0.0.1 port 45772 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:34.866937 sshd[2137]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:34.871311 systemd-logind[1362]: New session 23 of user core. Sep 9 00:08:34.883574 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 9 00:08:34.939356 sshd[2137]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:34.943538 systemd[1]: sshd@22-10.0.0.5:22-10.0.0.1:45772.service: Deactivated successfully. Sep 9 00:08:34.945250 systemd[1]: session-23.scope: Deactivated successfully. Sep 9 00:08:34.945827 systemd-logind[1362]: Session 23 logged out. Waiting for processes to exit. Sep 9 00:08:34.946606 systemd-logind[1362]: Removed session 23. Sep 9 00:08:39.635374 dockerd[1838]: time="2025-09-09T00:08:39.635298451Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba error="context deadline exceeded" Sep 9 00:08:39.636049 systemd[1]: docker-9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba.scope: Deactivated successfully. Sep 9 00:08:40.949607 systemd[1]: Started sshd@23-10.0.0.5:22-10.0.0.1:50386.service - OpenSSH per-connection server daemon (10.0.0.1:50386). Sep 9 00:08:40.982631 sshd[2144]: Accepted publickey for core from 10.0.0.1 port 50386 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:40.983914 sshd[2144]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:40.987311 systemd-logind[1362]: New session 24 of user core. Sep 9 00:08:41.001589 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 9 00:08:41.055785 sshd[2144]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:41.058670 systemd[1]: sshd@23-10.0.0.5:22-10.0.0.1:50386.service: Deactivated successfully. Sep 9 00:08:41.060772 systemd[1]: session-24.scope: Deactivated successfully. Sep 9 00:08:41.061275 systemd-logind[1362]: Session 24 logged out. Waiting for processes to exit. Sep 9 00:08:41.062198 systemd-logind[1362]: Removed session 24. Sep 9 00:08:42.634821 dockerd[1838]: time="2025-09-09T00:08:42.634752497Z" level=error msg="Force shutdown daemon" Sep 9 00:08:42.635289 dockerd[1838]: time="2025-09-09T00:08:42.634995098Z" level=info msg="Daemon shutdown complete" Sep 9 00:08:42.638290 systemd[1]: docker.service: Deactivated successfully. Sep 9 00:08:42.638614 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 9 00:08:42.639080 systemd[1]: docker.socket: Deactivated successfully. Sep 9 00:08:42.639775 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 9 00:08:42.639813 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 9 00:08:42.641304 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 9 00:08:42.647699 systemd[1]: containerd.service: Found left-over process 2048 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 00:08:42.647712 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 00:08:42.648687 systemd[1]: Starting containerd.service - containerd container runtime... Sep 9 00:08:42.648925 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 9 00:08:42.660796 systemd[1]: containerd.service: Found left-over process 2048 (containerd-shim) in control group while starting unit. Ignoring. Sep 9 00:08:42.660808 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 9 00:08:42.664972 (ntainerd)[2156]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 9 00:08:42.680272 containerd[2156]: time="2025-09-09T00:08:42.680195104Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 9 00:08:42.705881 containerd[2156]: time="2025-09-09T00:08:42.705821992Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707437 containerd[2156]: time="2025-09-09T00:08:42.707303555Z" 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 00:08:42.707437 containerd[2156]: time="2025-09-09T00:08:42.707337595Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 9 00:08:42.707437 containerd[2156]: time="2025-09-09T00:08:42.707356155Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 9 00:08:42.707437 containerd[2156]: time="2025-09-09T00:08:42.707396595Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 9 00:08:42.707437 containerd[2156]: time="2025-09-09T00:08:42.707426395Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707617 containerd[2156]: time="2025-09-09T00:08:42.707451915Z" 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 00:08:42.707617 containerd[2156]: time="2025-09-09T00:08:42.707463595Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707654 containerd[2156]: time="2025-09-09T00:08:42.707631076Z" 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 00:08:42.707654 containerd[2156]: time="2025-09-09T00:08:42.707645596Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707695 containerd[2156]: time="2025-09-09T00:08:42.707658756Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707695 containerd[2156]: time="2025-09-09T00:08:42.707668596Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707695 containerd[2156]: time="2025-09-09T00:08:42.707691756Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707839 containerd[2156]: time="2025-09-09T00:08:42.707782636Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 9 00:08:42.707904 containerd[2156]: time="2025-09-09T00:08:42.707886276Z" 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 00:08:42.707932 containerd[2156]: time="2025-09-09T00:08:42.707904116Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 9 00:08:42.707932 containerd[2156]: time="2025-09-09T00:08:42.707923716Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 9 00:08:42.707981 containerd[2156]: time="2025-09-09T00:08:42.707939676Z" level=info msg="metadata content store policy set" policy=shared Sep 9 00:08:42.708107 containerd[2156]: time="2025-09-09T00:08:42.708085037Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 9 00:08:42.708223 containerd[2156]: time="2025-09-09T00:08:42.708116477Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 9 00:08:42.708223 containerd[2156]: time="2025-09-09T00:08:42.708134357Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 9 00:08:42.708223 containerd[2156]: time="2025-09-09T00:08:42.708151717Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 9 00:08:42.708223 containerd[2156]: time="2025-09-09T00:08:42.708167517Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 9 00:08:42.708391 containerd[2156]: time="2025-09-09T00:08:42.708235717Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 9 00:08:42.708494 containerd[2156]: time="2025-09-09T00:08:42.708458997Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 9 00:08:42.715463 containerd[2156]: time="2025-09-09T00:08:42.715432531Z" level=info msg="cleaning leaked shim process" id=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba namespace=moby Sep 9 00:08:42.723169 containerd[2156]: time="2025-09-09T00:08:42.722891665Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 9 00:08:42.723549 containerd[2156]: time="2025-09-09T00:08:42.723118465Z" level=info msg="shim disconnected" id=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba namespace=moby Sep 9 00:08:42.723549 containerd[2156]: time="2025-09-09T00:08:42.723410506Z" level=warning msg="cleaning up after shim disconnected" id=9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba namespace=moby Sep 9 00:08:42.723549 containerd[2156]: time="2025-09-09T00:08:42.723421746Z" level=info msg="cleaning up dead shim" namespace=moby Sep 9 00:08:42.734431 containerd[2156]: time="2025-09-09T00:08:42.734351287Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 9 00:08:42.734566 containerd[2156]: time="2025-09-09T00:08:42.734551887Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 9 00:08:42.734639 containerd[2156]: time="2025-09-09T00:08:42.734627007Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 9 00:08:42.734701 containerd[2156]: time="2025-09-09T00:08:42.734688847Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734750767Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734777447Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734794647Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734810167Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734823167Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734836688Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734849728Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734872808Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734888008Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734902408Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734922048Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734946488Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734960128Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736432 containerd[2156]: time="2025-09-09T00:08:42.734976208Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.734990848Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735008448Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735027208Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735039568Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735052248Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735065808Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735082728Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735108648Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735121728Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735134808Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735201728Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 9 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735347888Z" 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 00:08:42.736806 containerd[2156]: time="2025-09-09T00:08:42.735360489Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 9 00:08:42.737030 containerd[2156]: time="2025-09-09T00:08:42.735373529Z" 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 00:08:42.737030 containerd[2156]: time="2025-09-09T00:08:42.735385409Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.737030 containerd[2156]: time="2025-09-09T00:08:42.735491169Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 9 00:08:42.737030 containerd[2156]: time="2025-09-09T00:08:42.735510169Z" level=info msg="NRI interface is disabled by configuration." Sep 9 00:08:42.737030 containerd[2156]: time="2025-09-09T00:08:42.735522049Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.735779489Z" 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 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.735836489Z" level=info msg="Connect containerd service" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.735866329Z" level=info msg="using legacy CRI server" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.735873529Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.735964970Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736469771Z" 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 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736590451Z" level=info msg="Start subscribing containerd event" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736646771Z" level=info msg="Start recovering state" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736710771Z" level=info msg="Start event monitor" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736724291Z" level=info msg="Start snapshots syncer" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736734611Z" level=info msg="Start cni network conf syncer for default" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736742491Z" level=info msg="Start streaming server" Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736777451Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736821571Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 9 00:08:42.737123 containerd[2156]: time="2025-09-09T00:08:42.736877931Z" level=info msg="containerd successfully booted in 0.057187s" Sep 9 00:08:42.737532 systemd[1]: Started containerd.service - containerd container runtime. Sep 9 00:08:42.745713 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 9 00:08:42.745828 (dockerd)[2191]: 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 00:08:42.785600 dockerd[2191]: time="2025-09-09T00:08:42.785531984Z" level=info msg="Starting up" Sep 9 00:08:42.811285 dockerd[2191]: time="2025-09-09T00:08:42.811234593Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 9 00:08:42.817765 dockerd[2191]: time="2025-09-09T00:08:42.817710965Z" level=info msg="Loading containers: start." Sep 9 00:08:42.832122 systemd[1]: var-lib-docker-overlay2-66ae83cec74dc441f573ab9c77340347dd56fa43b2bb8b28759056d74f08367c-merged.mount: Deactivated successfully. Sep 9 00:08:43.006440 dockerd[2191]: time="2025-09-09T00:08:43.005218361Z" level=info msg="Removing stale sandbox cd4a5f312c2550c6d1803a74f5a6b877f24ab101d388a25d63f6bab6fd6c6b3d (9411eea9d4f6de0040bd4a78415b82ac60fdf7517c1298df59a5588700e07dba)" Sep 9 00:08:43.008463 dockerd[2191]: time="2025-09-09T00:08:43.008423447Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint e2d5241b2711f0a9bfb80f161abc16848ad886d09dd62c3f5011771817de1ddd 94ddbf2fa194350c4409e3f7c7981ad05e85c0f9302928d9cbdda8b1f1e7c16c], retrying...." Sep 9 00:08:43.012707 systemd-networkd[1306]: vethf452735: Link DOWN Sep 9 00:08:43.013633 kernel: docker0: port 1(vethf452735) entered disabled state Sep 9 00:08:43.013661 kernel: vethf452735 (unregistering): left allmulticast mode Sep 9 00:08:43.012712 systemd-networkd[1306]: vethf452735: Lost carrier Sep 9 00:08:43.014718 kernel: vethf452735 (unregistering): left promiscuous mode Sep 9 00:08:43.014753 kernel: docker0: port 1(vethf452735) entered disabled state Sep 9 00:08:43.026085 systemd-networkd[1306]: docker0: Lost carrier Sep 9 00:08:43.131563 dockerd[2191]: time="2025-09-09T00:08:43.131340946Z" 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 00:08:43.187768 dockerd[2191]: time="2025-09-09T00:08:43.187730527Z" level=info msg="Loading containers: done." Sep 9 00:08:43.198433 dockerd[2191]: time="2025-09-09T00:08:43.198229025Z" 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 00:08:43.198433 dockerd[2191]: time="2025-09-09T00:08:43.198332865Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Sep 9 00:08:43.198433 dockerd[2191]: time="2025-09-09T00:08:43.198374986Z" level=info msg="Daemon has completed initialization" Sep 9 00:08:43.223748 dockerd[2191]: time="2025-09-09T00:08:43.223678391Z" level=info msg="API listen on /run/docker.sock" Sep 9 00:08:43.224058 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 9 00:08:43.801705 systemd[1]: run-docker-netns-cd4a5f312c25.mount: Deactivated successfully. Sep 9 00:08:47.077742 systemd[1]: Started sshd@24-10.0.0.5:22-10.0.0.1:50388.service - OpenSSH per-connection server daemon (10.0.0.1:50388). Sep 9 00:08:47.108768 sshd[2344]: Accepted publickey for core from 10.0.0.1 port 50388 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:47.110011 sshd[2344]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:47.114498 systemd-logind[1362]: New session 25 of user core. Sep 9 00:08:47.124725 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 9 00:08:47.178649 sshd[2344]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:47.197701 systemd[1]: sshd@24-10.0.0.5:22-10.0.0.1:50388.service: Deactivated successfully. Sep 9 00:08:47.199057 systemd[1]: session-25.scope: Deactivated successfully. Sep 9 00:08:47.200681 systemd-logind[1362]: Session 25 logged out. Waiting for processes to exit. Sep 9 00:08:47.214492 systemd[1]: Started sshd@25-10.0.0.5:22-10.0.0.1:50404.service - OpenSSH per-connection server daemon (10.0.0.1:50404). Sep 9 00:08:47.215652 systemd-logind[1362]: Removed session 25. Sep 9 00:08:47.245124 sshd[2351]: Accepted publickey for core from 10.0.0.1 port 50404 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:47.246391 sshd[2351]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:47.251042 systemd-logind[1362]: New session 26 of user core. Sep 9 00:08:47.265573 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 9 00:08:47.319613 sshd[2351]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:47.334815 systemd[1]: sshd@25-10.0.0.5:22-10.0.0.1:50404.service: Deactivated successfully. Sep 9 00:08:47.338046 systemd[1]: session-26.scope: Deactivated successfully. Sep 9 00:08:47.339654 systemd-logind[1362]: Session 26 logged out. Waiting for processes to exit. Sep 9 00:08:47.352811 systemd[1]: Started sshd@26-10.0.0.5:22-10.0.0.1:50410.service - OpenSSH per-connection server daemon (10.0.0.1:50410). Sep 9 00:08:47.355467 systemd-logind[1362]: Removed session 26. Sep 9 00:08:47.386008 sshd[2358]: Accepted publickey for core from 10.0.0.1 port 50410 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:47.387286 sshd[2358]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:47.391289 systemd-logind[1362]: New session 27 of user core. Sep 9 00:08:47.401651 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 9 00:08:47.459629 sshd[2358]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:47.471669 systemd[1]: sshd@26-10.0.0.5:22-10.0.0.1:50410.service: Deactivated successfully. Sep 9 00:08:47.472989 systemd[1]: session-27.scope: Deactivated successfully. Sep 9 00:08:47.475483 systemd-logind[1362]: Session 27 logged out. Waiting for processes to exit. Sep 9 00:08:47.489672 systemd[1]: Started sshd@27-10.0.0.5:22-10.0.0.1:50418.service - OpenSSH per-connection server daemon (10.0.0.1:50418). Sep 9 00:08:47.491449 systemd-logind[1362]: Removed session 27. Sep 9 00:08:47.519657 sshd[2372]: Accepted publickey for core from 10.0.0.1 port 50418 ssh2: RSA SHA256:h2hdqj5up/hBRHZQ3StgDpJiWnWjl57ZEr1UTjCMf5k Sep 9 00:08:47.520831 sshd[2372]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 9 00:08:47.525982 systemd-logind[1362]: New session 28 of user core. Sep 9 00:08:47.539959 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 9 00:08:47.606509 systemd[1]: var-lib-docker-overlay2-de87f944dc1d5861d78faa67398f561387da0d349732a249e38e7b2b3874eb41\x2dinit-merged.mount: Deactivated successfully. Sep 9 00:08:47.626470 kernel: docker0: port 1(veth0fdbc8f) entered blocking state Sep 9 00:08:47.626562 kernel: docker0: port 1(veth0fdbc8f) entered disabled state Sep 9 00:08:47.626581 kernel: veth0fdbc8f: entered allmulticast mode Sep 9 00:08:47.627419 kernel: veth0fdbc8f: entered promiscuous mode Sep 9 00:08:47.627825 systemd-networkd[1306]: veth0fdbc8f: Link UP Sep 9 00:08:47.658717 containerd[2156]: time="2025-09-09T00:08:47.658208035Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 9 00:08:47.658717 containerd[2156]: time="2025-09-09T00:08:47.658683715Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 9 00:08:47.658717 containerd[2156]: time="2025-09-09T00:08:47.658697475Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:08:47.659253 containerd[2156]: time="2025-09-09T00:08:47.659185956Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 9 00:08:47.675601 systemd[1]: Started docker-14cf789f6637fde9833f3a1599a2a6d304bac31a19999a7c34d25086b18e38c3.scope - libcontainer container 14cf789f6637fde9833f3a1599a2a6d304bac31a19999a7c34d25086b18e38c3. Sep 9 00:08:47.736742 kernel: eth0: renamed from veth00da24a Sep 9 00:08:47.768557 kernel: docker0: port 1(veth0fdbc8f) entered blocking state Sep 9 00:08:47.768618 kernel: docker0: port 1(veth0fdbc8f) entered forwarding state Sep 9 00:08:47.768633 systemd-networkd[1306]: veth0fdbc8f: Gained carrier Sep 9 00:08:47.768844 systemd-networkd[1306]: docker0: Gained carrier Sep 9 00:08:47.771703 systemd-resolved[1248]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 9 00:08:47.794141 sshd[2372]: pam_unix(sshd:session): session closed for user core Sep 9 00:08:47.797775 systemd[1]: sshd@27-10.0.0.5:22-10.0.0.1:50418.service: Deactivated successfully. Sep 9 00:08:47.799642 systemd[1]: session-28.scope: Deactivated successfully. Sep 9 00:08:47.800089 systemd-logind[1362]: Session 28 logged out. Waiting for processes to exit. Sep 9 00:08:47.800774 systemd-logind[1362]: Removed session 28. Sep 9 00:08:48.895601 systemd-networkd[1306]: veth0fdbc8f: Gained IPv6LL