Apr 29 23:48:51.945933 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Apr 29 23:48:51.945956 kernel: Linux version 6.6.88-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Tue Apr 29 22:24:03 -00 2025 Apr 29 23:48:51.945965 kernel: KASLR enabled Apr 29 23:48:51.945971 kernel: efi: EFI v2.7 by EDK II Apr 29 23:48:51.945977 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbbf018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40d98 Apr 29 23:48:51.945982 kernel: random: crng init done Apr 29 23:48:51.945989 kernel: secureboot: Secure boot disabled Apr 29 23:48:51.945995 kernel: ACPI: Early table checksum verification disabled Apr 29 23:48:51.946002 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) Apr 29 23:48:51.946009 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) Apr 29 23:48:51.946015 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946021 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946027 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946033 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946040 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946048 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946054 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946060 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946067 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 29 23:48:51.946073 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Apr 29 23:48:51.946079 kernel: NUMA: Failed to initialise from firmware Apr 29 23:48:51.946085 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Apr 29 23:48:51.946092 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] Apr 29 23:48:51.946098 kernel: Zone ranges: Apr 29 23:48:51.946104 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Apr 29 23:48:51.946112 kernel: DMA32 empty Apr 29 23:48:51.946118 kernel: Normal empty Apr 29 23:48:51.946124 kernel: Movable zone start for each node Apr 29 23:48:51.946131 kernel: Early memory node ranges Apr 29 23:48:51.946137 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Apr 29 23:48:51.946143 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Apr 29 23:48:51.946150 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Apr 29 23:48:51.946156 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Apr 29 23:48:51.946162 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Apr 29 23:48:51.946168 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Apr 29 23:48:51.946175 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Apr 29 23:48:51.946181 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Apr 29 23:48:51.946189 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Apr 29 23:48:51.946195 kernel: psci: probing for conduit method from ACPI. Apr 29 23:48:51.946202 kernel: psci: PSCIv1.1 detected in firmware. Apr 29 23:48:51.946211 kernel: psci: Using standard PSCI v0.2 function IDs Apr 29 23:48:51.946218 kernel: psci: Trusted OS migration not required Apr 29 23:48:51.946225 kernel: psci: SMC Calling Convention v1.1 Apr 29 23:48:51.946241 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Apr 29 23:48:51.946249 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Apr 29 23:48:51.946256 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Apr 29 23:48:51.946263 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Apr 29 23:48:51.946270 kernel: Detected PIPT I-cache on CPU0 Apr 29 23:48:51.946277 kernel: CPU features: detected: GIC system register CPU interface Apr 29 23:48:51.946284 kernel: CPU features: detected: Hardware dirty bit management Apr 29 23:48:51.946290 kernel: CPU features: detected: Spectre-v4 Apr 29 23:48:51.946297 kernel: CPU features: detected: Spectre-BHB Apr 29 23:48:51.946304 kernel: CPU features: kernel page table isolation forced ON by KASLR Apr 29 23:48:51.946313 kernel: CPU features: detected: Kernel page table isolation (KPTI) Apr 29 23:48:51.946320 kernel: CPU features: detected: ARM erratum 1418040 Apr 29 23:48:51.946326 kernel: CPU features: detected: SSBS not fully self-synchronizing Apr 29 23:48:51.946333 kernel: alternatives: applying boot alternatives Apr 29 23:48:51.946341 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=6e9bced8073e517a5f5178e5412663c3084f53d67852b3dfe0380ce71e6d0edd Apr 29 23:48:51.946348 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Apr 29 23:48:51.946354 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 29 23:48:51.946361 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 29 23:48:51.946368 kernel: Fallback order for Node 0: 0 Apr 29 23:48:51.946375 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Apr 29 23:48:51.946381 kernel: Policy zone: DMA Apr 29 23:48:51.946389 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 29 23:48:51.946396 kernel: software IO TLB: area num 4. Apr 29 23:48:51.946403 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Apr 29 23:48:51.946410 kernel: Memory: 2386192K/2572288K available (10304K kernel code, 2186K rwdata, 8104K rodata, 39744K init, 897K bss, 186096K reserved, 0K cma-reserved) Apr 29 23:48:51.946417 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Apr 29 23:48:51.946424 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 29 23:48:51.946431 kernel: rcu: RCU event tracing is enabled. Apr 29 23:48:51.946438 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Apr 29 23:48:51.946446 kernel: Trampoline variant of Tasks RCU enabled. Apr 29 23:48:51.946453 kernel: Tracing variant of Tasks RCU enabled. Apr 29 23:48:51.946459 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 29 23:48:51.946466 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Apr 29 23:48:51.946476 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 29 23:48:51.946486 kernel: GICv3: 256 SPIs implemented Apr 29 23:48:51.946495 kernel: GICv3: 0 Extended SPIs implemented Apr 29 23:48:51.946502 kernel: Root IRQ handler: gic_handle_irq Apr 29 23:48:51.946509 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Apr 29 23:48:51.946515 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Apr 29 23:48:51.946522 kernel: ITS [mem 0x08080000-0x0809ffff] Apr 29 23:48:51.946530 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) Apr 29 23:48:51.946537 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) Apr 29 23:48:51.946543 kernel: GICv3: using LPI property table @0x00000000400f0000 Apr 29 23:48:51.946550 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Apr 29 23:48:51.946558 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 29 23:48:51.946565 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 29 23:48:51.946572 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Apr 29 23:48:51.946579 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Apr 29 23:48:51.946585 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Apr 29 23:48:51.946592 kernel: arm-pv: using stolen time PV Apr 29 23:48:51.946599 kernel: Console: colour dummy device 80x25 Apr 29 23:48:51.946606 kernel: ACPI: Core revision 20230628 Apr 29 23:48:51.946613 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Apr 29 23:48:51.946620 kernel: pid_max: default: 32768 minimum: 301 Apr 29 23:48:51.946629 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 29 23:48:51.946635 kernel: landlock: Up and running. Apr 29 23:48:51.946642 kernel: SELinux: Initializing. Apr 29 23:48:51.946650 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:48:51.946657 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 29 23:48:51.946663 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 29 23:48:51.946670 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. Apr 29 23:48:51.946677 kernel: rcu: Hierarchical SRCU implementation. Apr 29 23:48:51.946684 kernel: rcu: Max phase no-delay instances is 400. Apr 29 23:48:51.946692 kernel: Platform MSI: ITS@0x8080000 domain created Apr 29 23:48:51.946699 kernel: PCI/MSI: ITS@0x8080000 domain created Apr 29 23:48:51.946706 kernel: Remapping and enabling EFI services. Apr 29 23:48:51.946712 kernel: smp: Bringing up secondary CPUs ... Apr 29 23:48:51.946719 kernel: Detected PIPT I-cache on CPU1 Apr 29 23:48:51.946726 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Apr 29 23:48:51.946733 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Apr 29 23:48:51.946739 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 29 23:48:51.946746 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Apr 29 23:48:51.946753 kernel: Detected PIPT I-cache on CPU2 Apr 29 23:48:51.946761 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Apr 29 23:48:51.946768 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Apr 29 23:48:51.946780 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 29 23:48:51.946788 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Apr 29 23:48:51.946795 kernel: Detected PIPT I-cache on CPU3 Apr 29 23:48:51.946802 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Apr 29 23:48:51.946809 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Apr 29 23:48:51.946816 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 29 23:48:51.946823 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Apr 29 23:48:51.946840 kernel: smp: Brought up 1 node, 4 CPUs Apr 29 23:48:51.946847 kernel: SMP: Total of 4 processors activated. Apr 29 23:48:51.946854 kernel: CPU features: detected: 32-bit EL0 Support Apr 29 23:48:51.946861 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Apr 29 23:48:51.946869 kernel: CPU features: detected: Common not Private translations Apr 29 23:48:51.946875 kernel: CPU features: detected: CRC32 instructions Apr 29 23:48:51.946883 kernel: CPU features: detected: Enhanced Virtualization Traps Apr 29 23:48:51.946890 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Apr 29 23:48:51.946898 kernel: CPU features: detected: LSE atomic instructions Apr 29 23:48:51.946905 kernel: CPU features: detected: Privileged Access Never Apr 29 23:48:51.946912 kernel: CPU features: detected: RAS Extension Support Apr 29 23:48:51.946919 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Apr 29 23:48:51.946926 kernel: CPU: All CPU(s) started at EL1 Apr 29 23:48:51.946933 kernel: alternatives: applying system-wide alternatives Apr 29 23:48:51.946940 kernel: devtmpfs: initialized Apr 29 23:48:51.946947 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 29 23:48:51.946954 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Apr 29 23:48:51.946963 kernel: pinctrl core: initialized pinctrl subsystem Apr 29 23:48:51.946970 kernel: SMBIOS 3.0.0 present. Apr 29 23:48:51.946977 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 Apr 29 23:48:51.946984 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 29 23:48:51.946991 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 29 23:48:51.946998 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 29 23:48:51.947005 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 29 23:48:51.947012 kernel: audit: initializing netlink subsys (disabled) Apr 29 23:48:51.947019 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1 Apr 29 23:48:51.947027 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 29 23:48:51.947035 kernel: cpuidle: using governor menu Apr 29 23:48:51.947042 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 29 23:48:51.947049 kernel: ASID allocator initialised with 32768 entries Apr 29 23:48:51.947056 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 29 23:48:51.947063 kernel: Serial: AMBA PL011 UART driver Apr 29 23:48:51.947070 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Apr 29 23:48:51.947077 kernel: Modules: 0 pages in range for non-PLT usage Apr 29 23:48:51.947084 kernel: Modules: 508928 pages in range for PLT usage Apr 29 23:48:51.947092 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 29 23:48:51.947099 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 29 23:48:51.947106 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 29 23:48:51.947113 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 29 23:48:51.947120 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 29 23:48:51.947127 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 29 23:48:51.947134 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 29 23:48:51.947141 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 29 23:48:51.947148 kernel: ACPI: Added _OSI(Module Device) Apr 29 23:48:51.947156 kernel: ACPI: Added _OSI(Processor Device) Apr 29 23:48:51.947163 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Apr 29 23:48:51.947170 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 29 23:48:51.947177 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 29 23:48:51.947184 kernel: ACPI: Interpreter enabled Apr 29 23:48:51.947191 kernel: ACPI: Using GIC for interrupt routing Apr 29 23:48:51.947198 kernel: ACPI: MCFG table detected, 1 entries Apr 29 23:48:51.947205 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Apr 29 23:48:51.947212 kernel: printk: console [ttyAMA0] enabled Apr 29 23:48:51.947220 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 29 23:48:51.947353 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 29 23:48:51.947429 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 29 23:48:51.947493 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 29 23:48:51.947557 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Apr 29 23:48:51.947620 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Apr 29 23:48:51.947630 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Apr 29 23:48:51.947639 kernel: PCI host bridge to bus 0000:00 Apr 29 23:48:51.947710 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Apr 29 23:48:51.947770 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 29 23:48:51.947839 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Apr 29 23:48:51.947900 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 29 23:48:51.947980 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Apr 29 23:48:51.948054 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Apr 29 23:48:51.948124 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Apr 29 23:48:51.948190 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Apr 29 23:48:51.948266 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Apr 29 23:48:51.948333 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Apr 29 23:48:51.948403 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Apr 29 23:48:51.948493 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Apr 29 23:48:51.948554 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Apr 29 23:48:51.948614 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 29 23:48:51.948671 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Apr 29 23:48:51.948680 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 29 23:48:51.948688 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 29 23:48:51.948695 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 29 23:48:51.948702 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 29 23:48:51.948709 kernel: iommu: Default domain type: Translated Apr 29 23:48:51.948716 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 29 23:48:51.948725 kernel: efivars: Registered efivars operations Apr 29 23:48:51.948732 kernel: vgaarb: loaded Apr 29 23:48:51.948739 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 29 23:48:51.948746 kernel: VFS: Disk quotas dquot_6.6.0 Apr 29 23:48:51.948753 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 29 23:48:51.948761 kernel: pnp: PnP ACPI init Apr 29 23:48:51.948847 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Apr 29 23:48:51.948858 kernel: pnp: PnP ACPI: found 1 devices Apr 29 23:48:51.948867 kernel: NET: Registered PF_INET protocol family Apr 29 23:48:51.948874 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 29 23:48:51.948881 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 29 23:48:51.948889 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 29 23:48:51.948896 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 29 23:48:51.948903 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 29 23:48:51.948910 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 29 23:48:51.948917 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:48:51.948924 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 29 23:48:51.948933 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 29 23:48:51.948940 kernel: PCI: CLS 0 bytes, default 64 Apr 29 23:48:51.948947 kernel: kvm [1]: HYP mode not available Apr 29 23:48:51.948954 kernel: Initialise system trusted keyrings Apr 29 23:48:51.948961 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 29 23:48:51.948968 kernel: Key type asymmetric registered Apr 29 23:48:51.948975 kernel: Asymmetric key parser 'x509' registered Apr 29 23:48:51.948982 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 29 23:48:51.948989 kernel: io scheduler mq-deadline registered Apr 29 23:48:51.948998 kernel: io scheduler kyber registered Apr 29 23:48:51.949005 kernel: io scheduler bfq registered Apr 29 23:48:51.949012 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 29 23:48:51.949019 kernel: ACPI: button: Power Button [PWRB] Apr 29 23:48:51.949026 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 29 23:48:51.949093 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Apr 29 23:48:51.949103 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 29 23:48:51.949110 kernel: thunder_xcv, ver 1.0 Apr 29 23:48:51.949117 kernel: thunder_bgx, ver 1.0 Apr 29 23:48:51.949126 kernel: nicpf, ver 1.0 Apr 29 23:48:51.949133 kernel: nicvf, ver 1.0 Apr 29 23:48:51.949204 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 29 23:48:51.949274 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-04-29T23:48:51 UTC (1745970531) Apr 29 23:48:51.949284 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 29 23:48:51.949292 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Apr 29 23:48:51.949299 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 29 23:48:51.949306 kernel: watchdog: Hard watchdog permanently disabled Apr 29 23:48:51.949315 kernel: NET: Registered PF_INET6 protocol family Apr 29 23:48:51.949322 kernel: Segment Routing with IPv6 Apr 29 23:48:51.949329 kernel: In-situ OAM (IOAM) with IPv6 Apr 29 23:48:51.949336 kernel: NET: Registered PF_PACKET protocol family Apr 29 23:48:51.949343 kernel: Key type dns_resolver registered Apr 29 23:48:51.949350 kernel: registered taskstats version 1 Apr 29 23:48:51.949357 kernel: Loading compiled-in X.509 certificates Apr 29 23:48:51.949364 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.88-flatcar: bbef389676bd9584646af24e9e264c7789f8630f' Apr 29 23:48:51.949371 kernel: Key type .fscrypt registered Apr 29 23:48:51.949380 kernel: Key type fscrypt-provisioning registered Apr 29 23:48:51.949387 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 29 23:48:51.949394 kernel: ima: Allocated hash algorithm: sha1 Apr 29 23:48:51.949401 kernel: ima: No architecture policies found Apr 29 23:48:51.949408 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 29 23:48:51.949415 kernel: clk: Disabling unused clocks Apr 29 23:48:51.949422 kernel: Freeing unused kernel memory: 39744K Apr 29 23:48:51.949429 kernel: Run /init as init process Apr 29 23:48:51.949436 kernel: with arguments: Apr 29 23:48:51.949444 kernel: /init Apr 29 23:48:51.949451 kernel: with environment: Apr 29 23:48:51.949458 kernel: HOME=/ Apr 29 23:48:51.949465 kernel: TERM=linux Apr 29 23:48:51.949472 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Apr 29 23:48:51.949481 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) Apr 29 23:48:51.949491 systemd[1]: Detected virtualization kvm. Apr 29 23:48:51.949498 systemd[1]: Detected architecture arm64. Apr 29 23:48:51.949507 systemd[1]: Running in initrd. Apr 29 23:48:51.949515 systemd[1]: No hostname configured, using default hostname. Apr 29 23:48:51.949522 systemd[1]: Hostname set to . Apr 29 23:48:51.949530 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:48:51.949537 systemd[1]: Queued start job for default target initrd.target. Apr 29 23:48:51.949545 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:48:51.949553 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:48:51.949561 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 29 23:48:51.949570 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:48:51.949578 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 29 23:48:51.949586 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 29 23:48:51.949594 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 29 23:48:51.949602 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 29 23:48:51.949610 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:48:51.949618 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:48:51.949627 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:48:51.949634 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:48:51.949642 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:48:51.949650 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:48:51.949657 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:48:51.949665 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:48:51.949673 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 29 23:48:51.949680 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 29 23:48:51.949690 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:48:51.949698 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:48:51.949705 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:48:51.949714 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:48:51.949721 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 29 23:48:51.949729 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:48:51.949737 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 29 23:48:51.949744 systemd[1]: Starting systemd-fsck-usr.service... Apr 29 23:48:51.949752 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:48:51.949762 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:48:51.949769 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:48:51.949777 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 29 23:48:51.949785 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:48:51.949792 systemd[1]: Finished systemd-fsck-usr.service. Apr 29 23:48:51.949816 systemd-journald[238]: Collecting audit messages is disabled. Apr 29 23:48:51.949851 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 29 23:48:51.949859 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 29 23:48:51.949869 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:48:51.949878 systemd-journald[238]: Journal started Apr 29 23:48:51.949896 systemd-journald[238]: Runtime Journal (/run/log/journal/6ce2921aa50b437d8583783ba59a985f) is 5.9M, max 47.3M, 41.4M free. Apr 29 23:48:51.932876 systemd-modules-load[239]: Inserted module 'overlay' Apr 29 23:48:51.952139 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:48:51.952161 kernel: Bridge firewalling registered Apr 29 23:48:51.953533 systemd-modules-load[239]: Inserted module 'br_netfilter' Apr 29 23:48:51.954582 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 29 23:48:51.956044 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:48:51.973049 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:48:51.974890 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:48:51.978529 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:48:51.981969 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:48:51.986332 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:48:51.988748 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:48:51.990153 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:48:51.993770 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 29 23:48:51.995052 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:48:51.998943 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:48:52.008186 dracut-cmdline[276]: dracut-dracut-053 Apr 29 23:48:52.010779 dracut-cmdline[276]: 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=6e9bced8073e517a5f5178e5412663c3084f53d67852b3dfe0380ce71e6d0edd Apr 29 23:48:52.026078 systemd-resolved[280]: Positive Trust Anchors: Apr 29 23:48:52.026151 systemd-resolved[280]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:48:52.026183 systemd-resolved[280]: 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 Apr 29 23:48:52.030938 systemd-resolved[280]: Defaulting to hostname 'linux'. Apr 29 23:48:52.035199 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:48:52.036460 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:48:52.084857 kernel: SCSI subsystem initialized Apr 29 23:48:52.089849 kernel: Loading iSCSI transport class v2.0-870. Apr 29 23:48:52.098871 kernel: iscsi: registered transport (tcp) Apr 29 23:48:52.110851 kernel: iscsi: registered transport (qla4xxx) Apr 29 23:48:52.110869 kernel: QLogic iSCSI HBA Driver Apr 29 23:48:52.156306 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 29 23:48:52.170016 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 29 23:48:52.188913 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 29 23:48:52.188959 kernel: device-mapper: uevent: version 1.0.3 Apr 29 23:48:52.190066 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 29 23:48:52.234874 kernel: raid6: neonx8 gen() 15758 MB/s Apr 29 23:48:52.251850 kernel: raid6: neonx4 gen() 15634 MB/s Apr 29 23:48:52.268849 kernel: raid6: neonx2 gen() 13176 MB/s Apr 29 23:48:52.285851 kernel: raid6: neonx1 gen() 10472 MB/s Apr 29 23:48:52.302850 kernel: raid6: int64x8 gen() 6944 MB/s Apr 29 23:48:52.319851 kernel: raid6: int64x4 gen() 7344 MB/s Apr 29 23:48:52.336846 kernel: raid6: int64x2 gen() 6123 MB/s Apr 29 23:48:52.353944 kernel: raid6: int64x1 gen() 5052 MB/s Apr 29 23:48:52.353960 kernel: raid6: using algorithm neonx8 gen() 15758 MB/s Apr 29 23:48:52.371953 kernel: raid6: .... xor() 11904 MB/s, rmw enabled Apr 29 23:48:52.371972 kernel: raid6: using neon recovery algorithm Apr 29 23:48:52.377914 kernel: xor: measuring software checksum speed Apr 29 23:48:52.377937 kernel: 8regs : 19821 MB/sec Apr 29 23:48:52.379202 kernel: 32regs : 19697 MB/sec Apr 29 23:48:52.379217 kernel: arm64_neon : 26804 MB/sec Apr 29 23:48:52.379239 kernel: xor: using function: arm64_neon (26804 MB/sec) Apr 29 23:48:52.430857 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 29 23:48:52.442898 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:48:52.453032 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:48:52.465218 systemd-udevd[463]: Using default interface naming scheme 'v255'. Apr 29 23:48:52.468376 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:48:52.480021 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 29 23:48:52.491286 dracut-pre-trigger[471]: rd.md=0: removing MD RAID activation Apr 29 23:48:52.517581 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:48:52.529978 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:48:52.568883 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:48:52.580044 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 29 23:48:52.592338 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 29 23:48:52.594539 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:48:52.596760 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:48:52.601779 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:48:52.607949 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Apr 29 23:48:52.619556 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Apr 29 23:48:52.619664 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 29 23:48:52.609996 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 29 23:48:52.621296 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:48:52.621409 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:48:52.623957 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:48:52.625529 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:48:52.625808 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:48:52.628054 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:48:52.637082 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:48:52.638612 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:48:52.647821 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:48:52.653038 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (523) Apr 29 23:48:52.653060 kernel: BTRFS: device fsid 9647859b-527c-478f-8aa1-9dfa3fa871e3 devid 1 transid 43 /dev/vda3 scanned by (udev-worker) (518) Apr 29 23:48:52.655903 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Apr 29 23:48:52.660312 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Apr 29 23:48:52.669924 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 29 23:48:52.673821 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Apr 29 23:48:52.676932 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Apr 29 23:48:52.690977 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 29 23:48:52.692790 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 29 23:48:52.703103 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 29 23:48:52.715549 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:48:53.812879 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Apr 29 23:48:53.813600 disk-uuid[553]: The operation has completed successfully. Apr 29 23:48:53.835038 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 29 23:48:53.835135 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 29 23:48:53.859038 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 29 23:48:53.864571 sh[573]: Success Apr 29 23:48:53.881851 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 29 23:48:53.931324 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 29 23:48:53.933320 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 29 23:48:53.935095 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 29 23:48:53.948711 kernel: BTRFS info (device dm-0): first mount of filesystem 9647859b-527c-478f-8aa1-9dfa3fa871e3 Apr 29 23:48:53.948766 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:48:53.948786 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 29 23:48:53.950605 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 29 23:48:53.950624 kernel: BTRFS info (device dm-0): using free space tree Apr 29 23:48:53.956818 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 29 23:48:53.958945 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 29 23:48:53.973061 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 29 23:48:53.974887 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 29 23:48:53.982105 kernel: BTRFS info (device vda6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:48:53.982158 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:48:53.982168 kernel: BTRFS info (device vda6): using free space tree Apr 29 23:48:53.984722 kernel: BTRFS info (device vda6): auto enabling async discard Apr 29 23:48:53.992744 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 29 23:48:53.995859 kernel: BTRFS info (device vda6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:48:54.002428 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 29 23:48:54.009030 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 29 23:48:54.082749 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:48:54.094038 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:48:54.119647 systemd-networkd[762]: lo: Link UP Apr 29 23:48:54.119659 systemd-networkd[762]: lo: Gained carrier Apr 29 23:48:54.120718 systemd-networkd[762]: Enumeration completed Apr 29 23:48:54.120813 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:48:54.121372 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:48:54.121375 systemd-networkd[762]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:48:54.122090 systemd-networkd[762]: eth0: Link UP Apr 29 23:48:54.122093 systemd-networkd[762]: eth0: Gained carrier Apr 29 23:48:54.122099 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:48:54.122751 systemd[1]: Reached target network.target - Network. Apr 29 23:48:54.133660 ignition[669]: Ignition 2.20.0 Apr 29 23:48:54.133669 ignition[669]: Stage: fetch-offline Apr 29 23:48:54.133704 ignition[669]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:54.133713 ignition[669]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:54.133931 ignition[669]: parsed url from cmdline: "" Apr 29 23:48:54.133935 ignition[669]: no config URL provided Apr 29 23:48:54.133939 ignition[669]: reading system config file "/usr/lib/ignition/user.ign" Apr 29 23:48:54.133946 ignition[669]: no config at "/usr/lib/ignition/user.ign" Apr 29 23:48:54.133973 ignition[669]: op(1): [started] loading QEMU firmware config module Apr 29 23:48:54.133978 ignition[669]: op(1): executing: "modprobe" "qemu_fw_cfg" Apr 29 23:48:54.140871 systemd-networkd[762]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 29 23:48:54.146614 ignition[669]: op(1): [finished] loading QEMU firmware config module Apr 29 23:48:54.146644 ignition[669]: QEMU firmware config was not found. Ignoring... Apr 29 23:48:54.150604 ignition[669]: parsing config with SHA512: b63cc94c69bd4e0080cf86a7c29676ad21f49a2a59a362aa7497e5566c69cdfa22f4f361b8a4970fc9de6ac170dc357bc1d3efeac0fe68e1314f61fb6655d085 Apr 29 23:48:54.157027 unknown[669]: fetched base config from "system" Apr 29 23:48:54.157037 unknown[669]: fetched user config from "qemu" Apr 29 23:48:54.157411 ignition[669]: fetch-offline: fetch-offline passed Apr 29 23:48:54.158837 ignition[669]: Ignition finished successfully Apr 29 23:48:54.160653 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:48:54.162201 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Apr 29 23:48:54.172013 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 29 23:48:54.182413 ignition[774]: Ignition 2.20.0 Apr 29 23:48:54.182423 ignition[774]: Stage: kargs Apr 29 23:48:54.182583 ignition[774]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:54.182595 ignition[774]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:54.183282 ignition[774]: kargs: kargs passed Apr 29 23:48:54.186367 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 29 23:48:54.183326 ignition[774]: Ignition finished successfully Apr 29 23:48:54.196983 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 29 23:48:54.207598 ignition[783]: Ignition 2.20.0 Apr 29 23:48:54.207610 ignition[783]: Stage: disks Apr 29 23:48:54.207790 ignition[783]: no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:54.207801 ignition[783]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:54.210899 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 29 23:48:54.208463 ignition[783]: disks: disks passed Apr 29 23:48:54.212615 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 29 23:48:54.208509 ignition[783]: Ignition finished successfully Apr 29 23:48:54.214239 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 29 23:48:54.216218 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:48:54.218205 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:48:54.219952 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:48:54.234029 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 29 23:48:54.246923 systemd-fsck[793]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 29 23:48:54.251397 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 29 23:48:54.253641 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 29 23:48:54.306847 kernel: EXT4-fs (vda9): mounted filesystem cd2ccabc-5b27-4350-bc86-21c9a8411827 r/w with ordered data mode. Quota mode: none. Apr 29 23:48:54.307089 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 29 23:48:54.308529 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 29 23:48:54.319923 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:48:54.322445 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 29 23:48:54.323541 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 29 23:48:54.323586 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 29 23:48:54.323610 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:48:54.330022 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 29 23:48:54.332931 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 29 23:48:54.337708 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (801) Apr 29 23:48:54.337737 kernel: BTRFS info (device vda6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:48:54.337748 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:48:54.338738 kernel: BTRFS info (device vda6): using free space tree Apr 29 23:48:54.341935 kernel: BTRFS info (device vda6): auto enabling async discard Apr 29 23:48:54.343648 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:48:54.389663 initrd-setup-root[825]: cut: /sysroot/etc/passwd: No such file or directory Apr 29 23:48:54.394219 initrd-setup-root[832]: cut: /sysroot/etc/group: No such file or directory Apr 29 23:48:54.397743 initrd-setup-root[839]: cut: /sysroot/etc/shadow: No such file or directory Apr 29 23:48:54.401298 initrd-setup-root[846]: cut: /sysroot/etc/gshadow: No such file or directory Apr 29 23:48:54.484680 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 29 23:48:54.496013 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 29 23:48:54.498886 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 29 23:48:54.503844 kernel: BTRFS info (device vda6): last unmount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:48:54.517690 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 29 23:48:54.522187 ignition[914]: INFO : Ignition 2.20.0 Apr 29 23:48:54.522187 ignition[914]: INFO : Stage: mount Apr 29 23:48:54.523948 ignition[914]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:54.523948 ignition[914]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:54.523948 ignition[914]: INFO : mount: mount passed Apr 29 23:48:54.523948 ignition[914]: INFO : Ignition finished successfully Apr 29 23:48:54.524323 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 29 23:48:54.536974 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 29 23:48:54.946975 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 29 23:48:54.963032 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 29 23:48:54.972545 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (928) Apr 29 23:48:54.972580 kernel: BTRFS info (device vda6): first mount of filesystem 1a221b5e-9ac2-4c84-b127-2e52009cde8a Apr 29 23:48:54.972598 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Apr 29 23:48:54.974163 kernel: BTRFS info (device vda6): using free space tree Apr 29 23:48:54.976838 kernel: BTRFS info (device vda6): auto enabling async discard Apr 29 23:48:54.977647 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 29 23:48:54.998519 ignition[945]: INFO : Ignition 2.20.0 Apr 29 23:48:54.998519 ignition[945]: INFO : Stage: files Apr 29 23:48:55.000327 ignition[945]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:55.000327 ignition[945]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:55.000327 ignition[945]: DEBUG : files: compiled without relabeling support, skipping Apr 29 23:48:55.000327 ignition[945]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 29 23:48:55.000327 ignition[945]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 29 23:48:55.006789 ignition[945]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 29 23:48:55.006789 ignition[945]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 29 23:48:55.006789 ignition[945]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 29 23:48:55.006789 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:48:55.006789 ignition[945]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(4): [started] processing unit "coreos-metadata.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(4): op(5): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(4): op(5): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(4): [finished] processing unit "coreos-metadata.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(6): [started] processing unit "docker.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(6): [finished] processing unit "docker.service" Apr 29 23:48:55.006789 ignition[945]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Apr 29 23:48:55.003091 unknown[945]: wrote ssh authorized keys file for user: core Apr 29 23:48:55.029102 ignition[945]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Apr 29 23:48:55.032509 ignition[945]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Apr 29 23:48:55.034747 ignition[945]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Apr 29 23:48:55.034747 ignition[945]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Apr 29 23:48:55.034747 ignition[945]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Apr 29 23:48:55.034747 ignition[945]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:48:55.034747 ignition[945]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 29 23:48:55.034747 ignition[945]: INFO : files: files passed Apr 29 23:48:55.034747 ignition[945]: INFO : Ignition finished successfully Apr 29 23:48:55.035598 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 29 23:48:55.046499 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 29 23:48:55.048472 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 29 23:48:55.050185 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 29 23:48:55.050282 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 29 23:48:55.056535 initrd-setup-root-after-ignition[974]: grep: /sysroot/oem/oem-release: No such file or directory Apr 29 23:48:55.059045 initrd-setup-root-after-ignition[976]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:48:55.059045 initrd-setup-root-after-ignition[976]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:48:55.062290 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 29 23:48:55.066557 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:48:55.069594 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 29 23:48:55.082117 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 29 23:48:55.102713 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 29 23:48:55.102882 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 29 23:48:55.105570 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 29 23:48:55.107173 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 29 23:48:55.109020 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 29 23:48:55.109940 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 29 23:48:55.127311 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:48:55.136015 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 29 23:48:55.143867 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:48:55.145187 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:48:55.147385 systemd[1]: Stopped target timers.target - Timer Units. Apr 29 23:48:55.149218 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 29 23:48:55.149382 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 29 23:48:55.151960 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 29 23:48:55.154029 systemd[1]: Stopped target basic.target - Basic System. Apr 29 23:48:55.155705 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 29 23:48:55.157493 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 29 23:48:55.159501 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 29 23:48:55.161601 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 29 23:48:55.163541 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 29 23:48:55.165530 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 29 23:48:55.167611 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 29 23:48:55.169448 systemd[1]: Stopped target swap.target - Swaps. Apr 29 23:48:55.170939 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 29 23:48:55.171072 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 29 23:48:55.173626 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:48:55.175813 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:48:55.177973 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 29 23:48:55.178893 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:48:55.180180 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 29 23:48:55.180307 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 29 23:48:55.183192 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 29 23:48:55.183317 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 29 23:48:55.185322 systemd[1]: Stopped target paths.target - Path Units. Apr 29 23:48:55.186929 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 29 23:48:55.191870 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:48:55.193352 systemd[1]: Stopped target slices.target - Slice Units. Apr 29 23:48:55.195622 systemd[1]: Stopped target sockets.target - Socket Units. Apr 29 23:48:55.197302 systemd[1]: iscsid.socket: Deactivated successfully. Apr 29 23:48:55.197403 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 29 23:48:55.198983 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 29 23:48:55.199059 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 29 23:48:55.200708 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 29 23:48:55.200810 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 29 23:48:55.202676 systemd[1]: ignition-files.service: Deactivated successfully. Apr 29 23:48:55.202776 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 29 23:48:55.215014 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 29 23:48:55.215976 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 29 23:48:55.216104 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:48:55.219382 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 29 23:48:55.221069 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 29 23:48:55.221202 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:48:55.227394 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 29 23:48:55.250135 ignition[1000]: INFO : Ignition 2.20.0 Apr 29 23:48:55.250135 ignition[1000]: INFO : Stage: umount Apr 29 23:48:55.250135 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 29 23:48:55.250135 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Apr 29 23:48:55.250135 ignition[1000]: INFO : umount: umount passed Apr 29 23:48:55.250135 ignition[1000]: INFO : Ignition finished successfully Apr 29 23:48:55.227552 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 29 23:48:55.254422 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 29 23:48:55.255100 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 29 23:48:55.256861 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 29 23:48:55.258764 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 29 23:48:55.258880 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 29 23:48:55.261126 systemd[1]: Stopped target network.target - Network. Apr 29 23:48:55.263626 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 29 23:48:55.263695 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 29 23:48:55.265288 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 29 23:48:55.265331 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 29 23:48:55.267079 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 29 23:48:55.267121 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 29 23:48:55.268794 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 29 23:48:55.268849 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 29 23:48:55.270551 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 29 23:48:55.270595 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 29 23:48:55.272501 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 29 23:48:55.274050 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 29 23:48:55.275905 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 29 23:48:55.275999 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 29 23:48:55.282924 systemd-networkd[762]: eth0: DHCPv6 lease lost Apr 29 23:48:55.283308 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 29 23:48:55.283970 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 29 23:48:55.286942 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 29 23:48:55.287060 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 29 23:48:55.289719 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 29 23:48:55.289768 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:48:55.298963 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 29 23:48:55.299856 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 29 23:48:55.299916 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 29 23:48:55.302318 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 29 23:48:55.302359 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:48:55.304276 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 29 23:48:55.304321 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 29 23:48:55.306461 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 29 23:48:55.306504 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:48:55.308627 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:48:55.318377 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 29 23:48:55.318505 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 29 23:48:55.322510 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 29 23:48:55.322653 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:48:55.325087 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 29 23:48:55.325140 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 29 23:48:55.327011 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 29 23:48:55.327048 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:48:55.328765 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 29 23:48:55.328814 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 29 23:48:55.331654 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 29 23:48:55.331701 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 29 23:48:55.334330 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 29 23:48:55.334371 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 29 23:48:55.346965 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 29 23:48:55.348037 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 29 23:48:55.348094 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:48:55.350436 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 29 23:48:55.350482 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:48:55.352743 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 29 23:48:55.352862 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 29 23:48:55.355153 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 29 23:48:55.357651 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 29 23:48:55.368049 systemd[1]: Switching root. Apr 29 23:48:55.398154 systemd-journald[238]: Journal stopped Apr 29 23:48:56.093282 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Apr 29 23:48:56.093339 kernel: SELinux: policy capability network_peer_controls=1 Apr 29 23:48:56.093355 kernel: SELinux: policy capability open_perms=1 Apr 29 23:48:56.093369 kernel: SELinux: policy capability extended_socket_class=1 Apr 29 23:48:56.093378 kernel: SELinux: policy capability always_check_network=0 Apr 29 23:48:56.093387 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 29 23:48:56.093399 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 29 23:48:56.093408 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 29 23:48:56.093417 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 29 23:48:56.093427 kernel: audit: type=1403 audit(1745970535.521:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 29 23:48:56.093438 systemd[1]: Successfully loaded SELinux policy in 32.051ms. Apr 29 23:48:56.093456 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 10.683ms. Apr 29 23:48:56.093467 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) Apr 29 23:48:56.093478 systemd[1]: Detected virtualization kvm. Apr 29 23:48:56.093488 systemd[1]: Detected architecture arm64. Apr 29 23:48:56.093502 systemd[1]: Detected first boot. Apr 29 23:48:56.093512 systemd[1]: Initializing machine ID from VM UUID. Apr 29 23:48:56.093522 zram_generator::config[1044]: No configuration found. Apr 29 23:48:56.093534 systemd[1]: Populated /etc with preset unit settings. Apr 29 23:48:56.093546 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 29 23:48:56.093556 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 29 23:48:56.093566 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 29 23:48:56.093577 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 29 23:48:56.093587 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 29 23:48:56.093598 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 29 23:48:56.093608 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 29 23:48:56.093618 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 29 23:48:56.093629 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 29 23:48:56.093641 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 29 23:48:56.093658 systemd[1]: Created slice user.slice - User and Session Slice. Apr 29 23:48:56.093668 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 29 23:48:56.093679 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 29 23:48:56.093690 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 29 23:48:56.093702 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 29 23:48:56.093712 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 29 23:48:56.093723 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 29 23:48:56.093733 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Apr 29 23:48:56.093743 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 29 23:48:56.093753 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 29 23:48:56.093764 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 29 23:48:56.093775 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 29 23:48:56.093787 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 29 23:48:56.093797 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 29 23:48:56.093808 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 29 23:48:56.093818 systemd[1]: Reached target slices.target - Slice Units. Apr 29 23:48:56.093838 systemd[1]: Reached target swap.target - Swaps. Apr 29 23:48:56.093850 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 29 23:48:56.093860 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 29 23:48:56.093872 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 29 23:48:56.093882 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 29 23:48:56.093895 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 29 23:48:56.093906 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 29 23:48:56.093916 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 29 23:48:56.093927 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 29 23:48:56.093937 systemd[1]: Mounting media.mount - External Media Directory... Apr 29 23:48:56.093948 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 29 23:48:56.093959 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 29 23:48:56.093969 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 29 23:48:56.093993 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). Apr 29 23:48:56.094007 systemd[1]: Reached target machines.target - Containers. Apr 29 23:48:56.094018 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 29 23:48:56.094030 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:48:56.094040 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 29 23:48:56.094051 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 29 23:48:56.094062 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:48:56.094073 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:48:56.094115 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:48:56.094132 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 29 23:48:56.094143 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:48:56.094156 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 29 23:48:56.094167 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 29 23:48:56.094178 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 29 23:48:56.094188 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 29 23:48:56.094198 systemd[1]: Stopped systemd-fsck-usr.service. Apr 29 23:48:56.094208 kernel: fuse: init (API version 7.39) Apr 29 23:48:56.094223 kernel: loop: module loaded Apr 29 23:48:56.094237 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 29 23:48:56.094248 kernel: ACPI: bus type drm_connector registered Apr 29 23:48:56.094257 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 29 23:48:56.094267 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 29 23:48:56.094277 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 29 23:48:56.094307 systemd-journald[1111]: Collecting audit messages is disabled. Apr 29 23:48:56.094332 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 29 23:48:56.094344 systemd-journald[1111]: Journal started Apr 29 23:48:56.096135 systemd-journald[1111]: Runtime Journal (/run/log/journal/6ce2921aa50b437d8583783ba59a985f) is 5.9M, max 47.3M, 41.4M free. Apr 29 23:48:55.889277 systemd[1]: Queued start job for default target multi-user.target. Apr 29 23:48:55.903885 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Apr 29 23:48:55.904272 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 29 23:48:56.097966 systemd[1]: verity-setup.service: Deactivated successfully. Apr 29 23:48:56.098006 systemd[1]: Stopped verity-setup.service. Apr 29 23:48:56.102301 systemd[1]: Started systemd-journald.service - Journal Service. Apr 29 23:48:56.102904 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 29 23:48:56.104152 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 29 23:48:56.105477 systemd[1]: Mounted media.mount - External Media Directory. Apr 29 23:48:56.106672 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 29 23:48:56.107948 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 29 23:48:56.109282 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 29 23:48:56.111861 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 29 23:48:56.113319 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 29 23:48:56.114791 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 29 23:48:56.114942 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 29 23:48:56.116526 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:48:56.116660 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:48:56.118123 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:48:56.118277 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:48:56.119716 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:48:56.119879 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:48:56.123195 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 29 23:48:56.123353 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 29 23:48:56.125049 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:48:56.125177 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:48:56.126569 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 29 23:48:56.128199 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 29 23:48:56.129755 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 29 23:48:56.142906 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 29 23:48:56.156957 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 29 23:48:56.159297 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 29 23:48:56.160463 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 29 23:48:56.160516 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 29 23:48:56.162539 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 29 23:48:56.164947 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 29 23:48:56.167075 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 29 23:48:56.168244 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:48:56.169705 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 29 23:48:56.171967 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 29 23:48:56.173365 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:48:56.177051 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 29 23:48:56.179434 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:48:56.180601 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 29 23:48:56.182070 systemd-journald[1111]: Time spent on flushing to /var/log/journal/6ce2921aa50b437d8583783ba59a985f is 15.388ms for 825 entries. Apr 29 23:48:56.182070 systemd-journald[1111]: System Journal (/var/log/journal/6ce2921aa50b437d8583783ba59a985f) is 8.0M, max 195.6M, 187.6M free. Apr 29 23:48:56.202620 systemd-journald[1111]: Received client request to flush runtime journal. Apr 29 23:48:56.186030 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 29 23:48:56.193441 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 29 23:48:56.199292 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 29 23:48:56.200799 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 29 23:48:56.202202 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 29 23:48:56.206214 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 29 23:48:56.207818 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 29 23:48:56.209634 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 29 23:48:56.214523 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 29 23:48:56.216895 kernel: loop0: detected capacity change from 0 to 116808 Apr 29 23:48:56.226075 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 29 23:48:56.233862 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 29 23:48:56.234686 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 29 23:48:56.239266 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 29 23:48:56.241339 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 29 23:48:56.246634 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 29 23:48:56.247375 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 29 23:48:56.255277 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 29 23:48:56.257917 udevadm[1171]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Apr 29 23:48:56.276888 kernel: loop1: detected capacity change from 0 to 113536 Apr 29 23:48:56.277770 systemd-tmpfiles[1176]: ACLs are not supported, ignoring. Apr 29 23:48:56.277789 systemd-tmpfiles[1176]: ACLs are not supported, ignoring. Apr 29 23:48:56.282169 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 29 23:48:56.306870 kernel: loop2: detected capacity change from 0 to 116808 Apr 29 23:48:56.311844 kernel: loop3: detected capacity change from 0 to 113536 Apr 29 23:48:56.315122 (sd-merge)[1180]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Apr 29 23:48:56.315460 (sd-merge)[1180]: Merged extensions into '/usr'. Apr 29 23:48:56.319846 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 29 23:48:56.328990 systemd[1]: Starting ensure-sysext.service... Apr 29 23:48:56.331991 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 29 23:48:56.341547 systemd[1]: Reloading requested from client PID 1182 ('systemctl') (unit ensure-sysext.service)... Apr 29 23:48:56.341578 systemd[1]: Reloading... Apr 29 23:48:56.348638 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 29 23:48:56.349237 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 29 23:48:56.349988 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 29 23:48:56.350358 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Apr 29 23:48:56.350467 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Apr 29 23:48:56.353983 systemd-tmpfiles[1183]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:48:56.354084 systemd-tmpfiles[1183]: Skipping /boot Apr 29 23:48:56.361037 systemd-tmpfiles[1183]: Detected autofs mount point /boot during canonicalization of boot. Apr 29 23:48:56.361132 systemd-tmpfiles[1183]: Skipping /boot Apr 29 23:48:56.389947 zram_generator::config[1210]: No configuration found. Apr 29 23:48:56.469904 ldconfig[1151]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 29 23:48:56.492106 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. Apr 29 23:48:56.526817 systemd[1]: Reloading finished in 183 ms. Apr 29 23:48:56.557231 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 29 23:48:56.558875 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 29 23:48:56.572966 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:48:56.575325 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 29 23:48:56.580061 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 29 23:48:56.586682 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 29 23:48:56.589928 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 29 23:48:56.595354 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:48:56.607134 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:48:56.614104 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:48:56.617019 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:48:56.618424 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:48:56.620865 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 29 23:48:56.625181 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:48:56.625321 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:48:56.628865 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:48:56.629874 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:48:56.631522 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:48:56.631649 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:48:56.633707 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 29 23:48:56.640054 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:48:56.658230 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:48:56.660841 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:48:56.663253 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:48:56.664500 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:48:56.666711 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 29 23:48:56.667775 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). Apr 29 23:48:56.669113 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 29 23:48:56.671173 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:48:56.672876 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:48:56.674616 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:48:56.674899 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:48:56.676625 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:48:56.676823 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:48:56.685890 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 29 23:48:56.687071 augenrules[1288]: No rules Apr 29 23:48:56.696090 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 29 23:48:56.700104 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 29 23:48:56.702614 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 29 23:48:56.709019 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 29 23:48:56.710124 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 29 23:48:56.710285 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). Apr 29 23:48:56.711096 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 29 23:48:56.712725 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:48:56.713879 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:48:56.715360 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 29 23:48:56.715499 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 29 23:48:56.717130 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 29 23:48:56.717274 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 29 23:48:56.718863 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 29 23:48:56.718987 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 29 23:48:56.720759 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 29 23:48:56.720912 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 29 23:48:56.726916 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 29 23:48:56.728492 systemd[1]: Finished ensure-sysext.service. Apr 29 23:48:56.731435 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 29 23:48:56.731498 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 29 23:48:56.740976 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 29 23:48:56.743251 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 29 23:48:56.745331 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 29 23:48:56.754463 systemd-resolved[1252]: Positive Trust Anchors: Apr 29 23:48:56.754538 systemd-resolved[1252]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 29 23:48:56.754569 systemd-resolved[1252]: 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 Apr 29 23:48:56.762545 systemd-resolved[1252]: Defaulting to hostname 'linux'. Apr 29 23:48:56.765838 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 29 23:48:56.767158 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 29 23:48:56.769166 systemd-udevd[1310]: Using default interface naming scheme 'v255'. Apr 29 23:48:56.773090 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 29 23:48:56.790155 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 29 23:48:56.801065 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 29 23:48:56.805159 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 29 23:48:56.808411 systemd[1]: Reached target time-set.target - System Time Set. Apr 29 23:48:56.824542 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Apr 29 23:48:56.847205 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 43 scanned by (udev-worker) (1329) Apr 29 23:48:56.870757 systemd-networkd[1322]: lo: Link UP Apr 29 23:48:56.870765 systemd-networkd[1322]: lo: Gained carrier Apr 29 23:48:56.873485 systemd-networkd[1322]: Enumeration completed Apr 29 23:48:56.873586 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 29 23:48:56.874846 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:48:56.874849 systemd-networkd[1322]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 29 23:48:56.875896 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:48:56.875933 systemd-networkd[1322]: eth0: Link UP Apr 29 23:48:56.875935 systemd-networkd[1322]: eth0: Gained carrier Apr 29 23:48:56.875943 systemd-networkd[1322]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 29 23:48:56.876879 systemd[1]: Reached target network.target - Network. Apr 29 23:48:56.882017 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 29 23:48:56.890066 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Apr 29 23:48:56.890886 systemd-networkd[1322]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 Apr 29 23:48:56.893271 systemd-timesyncd[1309]: Network configuration changed, trying to establish connection. Apr 29 23:48:56.893433 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 29 23:48:56.895990 systemd-timesyncd[1309]: Contacted time server 10.0.0.1:123 (10.0.0.1). Apr 29 23:48:56.896048 systemd-timesyncd[1309]: Initial clock synchronization to Tue 2025-04-29 23:48:57.284179 UTC. Apr 29 23:48:56.916136 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 29 23:48:56.938302 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 29 23:48:56.948246 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 29 23:48:56.951626 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 29 23:48:56.972118 lvm[1350]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:48:56.988968 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 29 23:48:57.008947 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 29 23:48:57.010496 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 29 23:48:57.011752 systemd[1]: Reached target sysinit.target - System Initialization. Apr 29 23:48:57.013108 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 29 23:48:57.014453 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 29 23:48:57.015979 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 29 23:48:57.017341 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 29 23:48:57.018710 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 29 23:48:57.020121 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 29 23:48:57.020165 systemd[1]: Reached target paths.target - Path Units. Apr 29 23:48:57.021118 systemd[1]: Reached target timers.target - Timer Units. Apr 29 23:48:57.023486 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 29 23:48:57.026121 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 29 23:48:57.036039 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 29 23:48:57.038547 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 29 23:48:57.040297 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 29 23:48:57.041602 systemd[1]: Reached target sockets.target - Socket Units. Apr 29 23:48:57.042698 systemd[1]: Reached target basic.target - Basic System. Apr 29 23:48:57.043774 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:48:57.043812 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 29 23:48:57.044792 systemd[1]: Starting containerd.service - containerd container runtime... Apr 29 23:48:57.047911 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 29 23:48:57.047053 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 29 23:48:57.050400 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 29 23:48:57.056195 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 29 23:48:57.057369 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). Apr 29 23:48:57.061124 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 29 23:48:57.062962 jq[1362]: false Apr 29 23:48:57.063498 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 29 23:48:57.068215 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 29 23:48:57.072398 extend-filesystems[1363]: Found loop2 Apr 29 23:48:57.072398 extend-filesystems[1363]: Found loop3 Apr 29 23:48:57.072398 extend-filesystems[1363]: Found vda Apr 29 23:48:57.072398 extend-filesystems[1363]: Found vda1 Apr 29 23:48:57.072398 extend-filesystems[1363]: Found vda2 Apr 29 23:48:57.072398 extend-filesystems[1363]: Found vda3 Apr 29 23:48:57.081819 extend-filesystems[1363]: Found usr Apr 29 23:48:57.081819 extend-filesystems[1363]: Found vda4 Apr 29 23:48:57.081819 extend-filesystems[1363]: Found vda6 Apr 29 23:48:57.081819 extend-filesystems[1363]: Found vda7 Apr 29 23:48:57.081819 extend-filesystems[1363]: Found vda9 Apr 29 23:48:57.081819 extend-filesystems[1363]: Checking size of /dev/vda9 Apr 29 23:48:57.080233 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 29 23:48:57.088853 extend-filesystems[1363]: Old size kept for /dev/vda9 Apr 29 23:48:57.085792 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 29 23:48:57.086352 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 29 23:48:57.088083 systemd[1]: Starting update-engine.service - Update Engine... Apr 29 23:48:57.093513 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 29 23:48:57.096811 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 29 23:48:57.098615 jq[1381]: true Apr 29 23:48:57.100557 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 29 23:48:57.100741 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 29 23:48:57.101051 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 29 23:48:57.101212 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 29 23:48:57.105460 systemd[1]: motdgen.service: Deactivated successfully. Apr 29 23:48:57.105633 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 29 23:48:57.107164 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 29 23:48:57.107833 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 29 23:48:57.114415 dbus-daemon[1361]: [system] SELinux support is enabled Apr 29 23:48:57.115287 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 29 23:48:57.118110 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 43 scanned by (udev-worker) (1316) Apr 29 23:48:57.128515 jq[1384]: true Apr 29 23:48:57.137516 (ntainerd)[1385]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 29 23:48:57.140303 systemd-logind[1368]: Watching system buttons on /dev/input/event0 (Power Button) Apr 29 23:48:57.140638 systemd-logind[1368]: New seat seat0. Apr 29 23:48:57.142483 systemd[1]: Started systemd-logind.service - User Login Management. Apr 29 23:48:57.147904 dbus-daemon[1361]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 29 23:48:57.148541 update_engine[1378]: I20250429 23:48:57.148394 1378 main.cc:92] Flatcar Update Engine starting Apr 29 23:48:57.152910 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). Apr 29 23:48:57.153081 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 29 23:48:57.154717 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). Apr 29 23:48:57.154887 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 29 23:48:57.159074 update_engine[1378]: I20250429 23:48:57.157569 1378 update_check_scheduler.cc:74] Next update check in 4m48s Apr 29 23:48:57.159434 systemd[1]: Started update-engine.service - Update Engine. Apr 29 23:48:57.164173 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 29 23:48:57.224117 bash[1411]: Updated "/home/core/.ssh/authorized_keys" Apr 29 23:48:57.228954 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 29 23:48:57.231334 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Apr 29 23:48:57.258705 locksmithd[1397]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 29 23:48:57.365141 containerd[1385]: time="2025-04-29T23:48:57.365009116Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 29 23:48:57.390533 containerd[1385]: time="2025-04-29T23:48:57.390459997Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393313 containerd[1385]: time="2025-04-29T23:48:57.393224228Z" 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.88-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393313 containerd[1385]: time="2025-04-29T23:48:57.393260340Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 29 23:48:57.393313 containerd[1385]: time="2025-04-29T23:48:57.393278291Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 29 23:48:57.393477 containerd[1385]: time="2025-04-29T23:48:57.393453690Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 29 23:48:57.393477 containerd[1385]: time="2025-04-29T23:48:57.393471179Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393546 containerd[1385]: time="2025-04-29T23:48:57.393526961Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393572 containerd[1385]: time="2025-04-29T23:48:57.393544661Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393740 containerd[1385]: time="2025-04-29T23:48:57.393707687Z" 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 Apr 29 23:48:57.393740 containerd[1385]: time="2025-04-29T23:48:57.393728406Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393783 containerd[1385]: time="2025-04-29T23:48:57.393741408Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393783 containerd[1385]: time="2025-04-29T23:48:57.393751222Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.393838 containerd[1385]: time="2025-04-29T23:48:57.393823781Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.394063 containerd[1385]: time="2025-04-29T23:48:57.394037640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:48:57.394185 containerd[1385]: time="2025-04-29T23:48:57.394143081Z" 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 Apr 29 23:48:57.394185 containerd[1385]: time="2025-04-29T23:48:57.394159396Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 29 23:48:57.394299 containerd[1385]: time="2025-04-29T23:48:57.394233422Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 29 23:48:57.394299 containerd[1385]: time="2025-04-29T23:48:57.394276790Z" level=info msg="metadata content store policy set" policy=shared Apr 29 23:48:57.394590 sshd_keygen[1382]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 29 23:48:57.399411 containerd[1385]: time="2025-04-29T23:48:57.399289332Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 29 23:48:57.399411 containerd[1385]: time="2025-04-29T23:48:57.399351909Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 29 23:48:57.399411 containerd[1385]: time="2025-04-29T23:48:57.399370573Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 29 23:48:57.399411 containerd[1385]: time="2025-04-29T23:48:57.399389320Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 29 23:48:57.399411 containerd[1385]: time="2025-04-29T23:48:57.399405636Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 29 23:48:57.399618 containerd[1385]: time="2025-04-29T23:48:57.399578728Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 29 23:48:57.399879 containerd[1385]: time="2025-04-29T23:48:57.399836542Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 29 23:48:57.400004 containerd[1385]: time="2025-04-29T23:48:57.399978387Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 29 23:48:57.400031 containerd[1385]: time="2025-04-29T23:48:57.400002504Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 29 23:48:57.400031 containerd[1385]: time="2025-04-29T23:48:57.400019113Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 29 23:48:57.400081 containerd[1385]: time="2025-04-29T23:48:57.400033708Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400081 containerd[1385]: time="2025-04-29T23:48:57.400048094Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400081 containerd[1385]: time="2025-04-29T23:48:57.400062648Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400081 containerd[1385]: time="2025-04-29T23:48:57.400077705Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400155 containerd[1385]: time="2025-04-29T23:48:57.400093181Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400155 containerd[1385]: time="2025-04-29T23:48:57.400106602Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400155 containerd[1385]: time="2025-04-29T23:48:57.400119856Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400155 containerd[1385]: time="2025-04-29T23:48:57.400133109Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 29 23:48:57.400155 containerd[1385]: time="2025-04-29T23:48:57.400154751Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400170144Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400182768Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400195644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400207387Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400222067Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400245 containerd[1385]: time="2025-04-29T23:48:57.400235446Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400249832Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400265057Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400280533Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400293367Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400307795Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400327046Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400354 containerd[1385]: time="2025-04-29T23:48:57.400343068Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 29 23:48:57.400483 containerd[1385]: time="2025-04-29T23:48:57.400369533Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400483 containerd[1385]: time="2025-04-29T23:48:57.400387945Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400483 containerd[1385]: time="2025-04-29T23:48:57.400399731Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 29 23:48:57.400844 containerd[1385]: time="2025-04-29T23:48:57.400819396Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400841919Z" 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 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400853579Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400868719Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400893800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400907641Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400919301Z" level=info msg="NRI interface is disabled by configuration." Apr 29 23:48:57.400943 containerd[1385]: time="2025-04-29T23:48:57.400937252Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 29 23:48:57.401455 containerd[1385]: time="2025-04-29T23:48:57.401396594Z" 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}" Apr 29 23:48:57.401455 containerd[1385]: time="2025-04-29T23:48:57.401452963Z" level=info msg="Connect containerd service" Apr 29 23:48:57.401580 containerd[1385]: time="2025-04-29T23:48:57.401489662Z" level=info msg="using legacy CRI server" Apr 29 23:48:57.401580 containerd[1385]: time="2025-04-29T23:48:57.401497295Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 29 23:48:57.401899 containerd[1385]: time="2025-04-29T23:48:57.401867680Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 29 23:48:57.402728 containerd[1385]: time="2025-04-29T23:48:57.402700720Z" 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" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403149241Z" level=info msg="Start subscribing containerd event" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403220374Z" level=info msg="Start recovering state" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403293897Z" level=info msg="Start event monitor" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403309499Z" level=info msg="Start snapshots syncer" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403319188Z" level=info msg="Start cni network conf syncer for default" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403330889Z" level=info msg="Start streaming server" Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403508511Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403551921Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 29 23:48:57.403694 containerd[1385]: time="2025-04-29T23:48:57.403606067Z" level=info msg="containerd successfully booted in 0.040113s" Apr 29 23:48:57.403717 systemd[1]: Started containerd.service - containerd container runtime. Apr 29 23:48:57.416982 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 29 23:48:57.436209 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 29 23:48:57.442268 systemd[1]: issuegen.service: Deactivated successfully. Apr 29 23:48:57.442486 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 29 23:48:57.445600 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 29 23:48:57.459931 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 29 23:48:57.470190 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 29 23:48:57.472609 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Apr 29 23:48:57.474135 systemd[1]: Reached target getty.target - Login Prompts. Apr 29 23:48:58.750962 systemd-networkd[1322]: eth0: Gained IPv6LL Apr 29 23:48:58.753354 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 29 23:48:58.755132 systemd[1]: Reached target network-online.target - Network is Online. Apr 29 23:48:58.766108 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Apr 29 23:48:58.768273 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 29 23:48:58.784718 systemd[1]: coreos-metadata.service: Deactivated successfully. Apr 29 23:48:58.784995 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Apr 29 23:48:58.787159 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 29 23:48:58.799960 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 29 23:48:58.801717 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 29 23:48:58.806943 systemd[1]: Startup finished in 655ms (kernel) + 3.797s (initrd) + 3.319s (userspace) = 7.773s. Apr 29 23:49:04.711699 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 29 23:49:04.712888 systemd[1]: Started sshd@0-10.0.0.15:22-10.0.0.1:51398.service - OpenSSH per-connection server daemon (10.0.0.1:51398). Apr 29 23:49:04.779604 sshd[1461]: Accepted publickey for core from 10.0.0.1 port 51398 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:04.783707 sshd-session[1461]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:04.798494 systemd-logind[1368]: New session 1 of user core. Apr 29 23:49:04.799560 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 29 23:49:04.814156 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 29 23:49:04.824118 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 29 23:49:04.826436 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 29 23:49:04.833406 (systemd)[1465]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 29 23:49:04.909455 systemd[1465]: Queued start job for default target default.target. Apr 29 23:49:04.917936 systemd[1465]: Created slice app.slice - User Application Slice. Apr 29 23:49:04.917971 systemd[1465]: Reached target paths.target - Paths. Apr 29 23:49:04.918004 systemd[1465]: Reached target timers.target - Timers. Apr 29 23:49:04.919348 systemd[1465]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 29 23:49:04.930092 systemd[1465]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 29 23:49:04.930217 systemd[1465]: Reached target sockets.target - Sockets. Apr 29 23:49:04.930231 systemd[1465]: Reached target basic.target - Basic System. Apr 29 23:49:04.930269 systemd[1465]: Reached target default.target - Main User Target. Apr 29 23:49:04.930297 systemd[1465]: Startup finished in 90ms. Apr 29 23:49:04.930482 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 29 23:49:04.932014 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 29 23:49:04.996969 systemd[1]: Started sshd@1-10.0.0.15:22-10.0.0.1:51404.service - OpenSSH per-connection server daemon (10.0.0.1:51404). Apr 29 23:49:05.039081 sshd[1476]: Accepted publickey for core from 10.0.0.1 port 51404 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.040511 sshd-session[1476]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.044696 systemd-logind[1368]: New session 2 of user core. Apr 29 23:49:05.052102 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 29 23:49:05.104866 sshd[1478]: Connection closed by 10.0.0.1 port 51404 Apr 29 23:49:05.105387 sshd-session[1476]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:05.118315 systemd[1]: sshd@1-10.0.0.15:22-10.0.0.1:51404.service: Deactivated successfully. Apr 29 23:49:05.119718 systemd[1]: session-2.scope: Deactivated successfully. Apr 29 23:49:05.121954 systemd-logind[1368]: Session 2 logged out. Waiting for processes to exit. Apr 29 23:49:05.122568 systemd[1]: Started sshd@2-10.0.0.15:22-10.0.0.1:51408.service - OpenSSH per-connection server daemon (10.0.0.1:51408). Apr 29 23:49:05.124591 systemd-logind[1368]: Removed session 2. Apr 29 23:49:05.163962 sshd[1483]: Accepted publickey for core from 10.0.0.1 port 51408 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.165224 sshd-session[1483]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.169417 systemd-logind[1368]: New session 3 of user core. Apr 29 23:49:05.181023 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 29 23:49:05.229742 sshd[1485]: Connection closed by 10.0.0.1 port 51408 Apr 29 23:49:05.230168 sshd-session[1483]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:05.239430 systemd[1]: sshd@2-10.0.0.15:22-10.0.0.1:51408.service: Deactivated successfully. Apr 29 23:49:05.241127 systemd[1]: session-3.scope: Deactivated successfully. Apr 29 23:49:05.244489 systemd-logind[1368]: Session 3 logged out. Waiting for processes to exit. Apr 29 23:49:05.245760 systemd[1]: Started sshd@3-10.0.0.15:22-10.0.0.1:51416.service - OpenSSH per-connection server daemon (10.0.0.1:51416). Apr 29 23:49:05.246647 systemd-logind[1368]: Removed session 3. Apr 29 23:49:05.287145 sshd[1490]: Accepted publickey for core from 10.0.0.1 port 51416 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.288428 sshd-session[1490]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.292472 systemd-logind[1368]: New session 4 of user core. Apr 29 23:49:05.308021 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 29 23:49:05.360916 sshd[1492]: Connection closed by 10.0.0.1 port 51416 Apr 29 23:49:05.361612 sshd-session[1490]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:05.379392 systemd[1]: sshd@3-10.0.0.15:22-10.0.0.1:51416.service: Deactivated successfully. Apr 29 23:49:05.380902 systemd[1]: session-4.scope: Deactivated successfully. Apr 29 23:49:05.384134 systemd-logind[1368]: Session 4 logged out. Waiting for processes to exit. Apr 29 23:49:05.385458 systemd[1]: Started sshd@4-10.0.0.15:22-10.0.0.1:51430.service - OpenSSH per-connection server daemon (10.0.0.1:51430). Apr 29 23:49:05.386263 systemd-logind[1368]: Removed session 4. Apr 29 23:49:05.428396 sshd[1497]: Accepted publickey for core from 10.0.0.1 port 51430 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.429705 sshd-session[1497]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.436712 systemd-logind[1368]: New session 5 of user core. Apr 29 23:49:05.453067 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 29 23:49:05.514376 sudo[1500]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Apr 29 23:49:05.514679 sudo[1500]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:49:05.532022 sudo[1500]: pam_unix(sudo:session): session closed for user root Apr 29 23:49:05.533589 sshd[1499]: Connection closed by 10.0.0.1 port 51430 Apr 29 23:49:05.534086 sshd-session[1497]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:05.548647 systemd[1]: sshd@4-10.0.0.15:22-10.0.0.1:51430.service: Deactivated successfully. Apr 29 23:49:05.551281 systemd[1]: session-5.scope: Deactivated successfully. Apr 29 23:49:05.552713 systemd-logind[1368]: Session 5 logged out. Waiting for processes to exit. Apr 29 23:49:05.561277 systemd[1]: Started sshd@5-10.0.0.15:22-10.0.0.1:51440.service - OpenSSH per-connection server daemon (10.0.0.1:51440). Apr 29 23:49:05.562203 systemd-logind[1368]: Removed session 5. Apr 29 23:49:05.598836 sshd[1505]: Accepted publickey for core from 10.0.0.1 port 51440 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.600247 sshd-session[1505]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.604367 systemd-logind[1368]: New session 6 of user core. Apr 29 23:49:05.611051 systemd[1]: Started session-6.scope - Session 6 of User core. Apr 29 23:49:05.664665 sudo[1509]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Apr 29 23:49:05.664989 sudo[1509]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:49:05.668449 sudo[1509]: pam_unix(sudo:session): session closed for user root Apr 29 23:49:05.673837 sudo[1508]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Apr 29 23:49:05.674147 sudo[1508]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:49:05.689175 systemd[1]: Starting audit-rules.service - Load Audit Rules... Apr 29 23:49:05.714088 augenrules[1531]: No rules Apr 29 23:49:05.715398 systemd[1]: audit-rules.service: Deactivated successfully. Apr 29 23:49:05.715618 systemd[1]: Finished audit-rules.service - Load Audit Rules. Apr 29 23:49:05.716663 sudo[1508]: pam_unix(sudo:session): session closed for user root Apr 29 23:49:05.717921 sshd[1507]: Connection closed by 10.0.0.1 port 51440 Apr 29 23:49:05.718368 sshd-session[1505]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:05.724542 systemd[1]: sshd@5-10.0.0.15:22-10.0.0.1:51440.service: Deactivated successfully. Apr 29 23:49:05.726184 systemd[1]: session-6.scope: Deactivated successfully. Apr 29 23:49:05.727487 systemd-logind[1368]: Session 6 logged out. Waiting for processes to exit. Apr 29 23:49:05.728756 systemd[1]: Started sshd@6-10.0.0.15:22-10.0.0.1:51448.service - OpenSSH per-connection server daemon (10.0.0.1:51448). Apr 29 23:49:05.730249 systemd-logind[1368]: Removed session 6. Apr 29 23:49:05.769877 sshd[1539]: Accepted publickey for core from 10.0.0.1 port 51448 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:05.771179 sshd-session[1539]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:05.776301 systemd-logind[1368]: New session 7 of user core. Apr 29 23:49:05.782054 systemd[1]: Started session-7.scope - Session 7 of User core. Apr 29 23:49:05.845257 (dockerd)[1543]: 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 Apr 29 23:49:05.845428 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 29 23:49:06.102190 dockerd[1543]: time="2025-04-29T23:49:06.102060283Z" level=info msg="Starting up" Apr 29 23:49:06.189511 dockerd[1543]: time="2025-04-29T23:49:06.189114911Z" level=info msg="Loading containers: start." Apr 29 23:49:06.338948 kernel: Initializing XFRM netlink socket Apr 29 23:49:06.419669 systemd-networkd[1322]: docker0: Link UP Apr 29 23:49:06.455966 dockerd[1543]: time="2025-04-29T23:49:06.455287226Z" level=info msg="Loading containers: done." Apr 29 23:49:06.472774 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck894794646-merged.mount: Deactivated successfully. Apr 29 23:49:06.476546 dockerd[1543]: time="2025-04-29T23:49:06.476083287Z" 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 Apr 29 23:49:06.476546 dockerd[1543]: time="2025-04-29T23:49:06.476200452Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Apr 29 23:49:06.476546 dockerd[1543]: time="2025-04-29T23:49:06.476328169Z" level=info msg="Daemon has completed initialization" Apr 29 23:49:06.512310 dockerd[1543]: time="2025-04-29T23:49:06.512256753Z" level=info msg="API listen on /run/docker.sock" Apr 29 23:49:06.512378 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 29 23:49:06.522943 sshd[1541]: Connection closed by 10.0.0.1 port 51448 Apr 29 23:49:06.523338 sshd-session[1539]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:06.532335 systemd[1]: sshd@6-10.0.0.15:22-10.0.0.1:51448.service: Deactivated successfully. Apr 29 23:49:06.533827 systemd[1]: session-7.scope: Deactivated successfully. Apr 29 23:49:06.536427 systemd-logind[1368]: Session 7 logged out. Waiting for processes to exit. Apr 29 23:49:06.539175 systemd[1]: Started sshd@7-10.0.0.15:22-10.0.0.1:51458.service - OpenSSH per-connection server daemon (10.0.0.1:51458). Apr 29 23:49:06.540619 systemd-logind[1368]: Removed session 7. Apr 29 23:49:06.579359 sshd[1733]: Accepted publickey for core from 10.0.0.1 port 51458 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:06.580721 sshd-session[1733]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:06.584591 systemd-logind[1368]: New session 8 of user core. Apr 29 23:49:06.597039 systemd[1]: Started session-8.scope - Session 8 of User core. Apr 29 23:49:07.849284 systemd[1]: var-lib-docker-overlay2-319459b39c61685701e4b26786d7baa5b14a7cf3621b8c487bde99f5056d7498\x2dinit-merged.mount: Deactivated successfully. Apr 29 23:49:07.866316 systemd[1]: var-lib-docker-overlay2-319459b39c61685701e4b26786d7baa5b14a7cf3621b8c487bde99f5056d7498-merged.mount: Deactivated successfully. Apr 29 23:49:07.879951 kernel: docker0: port 1(vethf47dc38) entered blocking state Apr 29 23:49:07.880046 kernel: docker0: port 1(vethf47dc38) entered disabled state Apr 29 23:49:07.880075 kernel: vethf47dc38: entered allmulticast mode Apr 29 23:49:07.880093 kernel: vethf47dc38: entered promiscuous mode Apr 29 23:49:07.880655 systemd-networkd[1322]: vethf47dc38: Link UP Apr 29 23:49:07.979956 containerd[1385]: time="2025-04-29T23:49:07.979755701Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 29 23:49:07.979956 containerd[1385]: time="2025-04-29T23:49:07.979900891Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 29 23:49:07.979956 containerd[1385]: time="2025-04-29T23:49:07.979914787Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:07.980478 containerd[1385]: time="2025-04-29T23:49:07.980018778Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:08.009077 systemd[1]: Started docker-2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f.scope - libcontainer container 2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f. Apr 29 23:49:08.061876 kernel: eth0: renamed from veth439a67b Apr 29 23:49:08.073239 kernel: docker0: port 1(vethf47dc38) entered blocking state Apr 29 23:49:08.073281 kernel: docker0: port 1(vethf47dc38) entered forwarding state Apr 29 23:49:08.073389 systemd-networkd[1322]: vethf47dc38: Gained carrier Apr 29 23:49:08.073823 systemd-networkd[1322]: docker0: Gained carrier Apr 29 23:49:08.075456 systemd-resolved[1252]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 29 23:49:08.101993 sshd[1735]: Connection closed by 10.0.0.1 port 51458 Apr 29 23:49:08.102981 sshd-session[1733]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:08.115376 systemd[1]: sshd@7-10.0.0.15:22-10.0.0.1:51458.service: Deactivated successfully. Apr 29 23:49:08.116914 systemd[1]: session-8.scope: Deactivated successfully. Apr 29 23:49:08.117463 systemd-logind[1368]: Session 8 logged out. Waiting for processes to exit. Apr 29 23:49:08.124152 systemd[1]: Started sshd@8-10.0.0.15:22-10.0.0.1:51468.service - OpenSSH per-connection server daemon (10.0.0.1:51468). Apr 29 23:49:08.125265 systemd-logind[1368]: Removed session 8. Apr 29 23:49:08.161425 sshd[1814]: Accepted publickey for core from 10.0.0.1 port 51468 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:08.162827 sshd-session[1814]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:08.166833 systemd-logind[1368]: New session 9 of user core. Apr 29 23:49:08.175039 systemd[1]: Started session-9.scope - Session 9 of User core. Apr 29 23:49:08.231036 sshd[1816]: Connection closed by 10.0.0.1 port 51468 Apr 29 23:49:08.231427 sshd-session[1814]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:08.250312 systemd[1]: sshd@8-10.0.0.15:22-10.0.0.1:51468.service: Deactivated successfully. Apr 29 23:49:08.253068 systemd[1]: session-9.scope: Deactivated successfully. Apr 29 23:49:08.253800 systemd-logind[1368]: Session 9 logged out. Waiting for processes to exit. Apr 29 23:49:08.265498 systemd[1]: Started sshd@9-10.0.0.15:22-10.0.0.1:51484.service - OpenSSH per-connection server daemon (10.0.0.1:51484). Apr 29 23:49:08.266577 systemd-logind[1368]: Removed session 9. Apr 29 23:49:08.302285 sshd[1821]: Accepted publickey for core from 10.0.0.1 port 51484 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:08.303562 sshd-session[1821]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:08.307463 systemd-logind[1368]: New session 10 of user core. Apr 29 23:49:08.322031 systemd[1]: Started session-10.scope - Session 10 of User core. Apr 29 23:49:08.373828 sudo[1824]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGTERM 1385 Apr 29 23:49:08.374175 sudo[1824]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:49:08.379770 sudo[1824]: pam_unix(sudo:session): session closed for user root Apr 29 23:49:08.380863 containerd[1385]: time="2025-04-29T23:49:08.380065018Z" level=info msg="Stop CRI service" Apr 29 23:49:08.380947 dockerd[1543]: time="2025-04-29T23:49:08.380303452Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Apr 29 23:49:08.380947 dockerd[1543]: time="2025-04-29T23:49:08.380344021Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Apr 29 23:49:08.380947 dockerd[1543]: time="2025-04-29T23:49:08.380573759Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Apr 29 23:49:08.380947 dockerd[1543]: time="2025-04-29T23:49:08.380588482Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Apr 29 23:49:08.382879 sshd[1823]: Connection closed by 10.0.0.1 port 51484 Apr 29 23:49:08.383530 sshd-session[1821]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:08.392454 systemd[1]: containerd.service: Deactivated successfully. Apr 29 23:49:08.392673 systemd[1]: containerd.service: Unit process 1769 (containerd-shim) remains running after unit stopped. Apr 29 23:49:08.393312 systemd[1]: sshd@9-10.0.0.15:22-10.0.0.1:51484.service: Deactivated successfully. Apr 29 23:49:08.394875 systemd[1]: session-10.scope: Deactivated successfully. Apr 29 23:49:08.396124 systemd-logind[1368]: Session 10 logged out. Waiting for processes to exit. Apr 29 23:49:08.398253 systemd[1]: Started sshd@10-10.0.0.15:22-10.0.0.1:51494.service - OpenSSH per-connection server daemon (10.0.0.1:51494). Apr 29 23:49:08.399609 systemd-logind[1368]: Removed session 10. Apr 29 23:49:08.440205 sshd[1830]: Accepted publickey for core from 10.0.0.1 port 51494 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:08.441547 sshd-session[1830]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:08.445443 systemd-logind[1368]: New session 11 of user core. Apr 29 23:49:08.454027 systemd[1]: Started session-11.scope - Session 11 of User core. Apr 29 23:49:08.507889 sshd[1832]: Connection closed by 10.0.0.1 port 51494 Apr 29 23:49:08.508166 sshd-session[1830]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:08.511342 systemd[1]: sshd@10-10.0.0.15:22-10.0.0.1:51494.service: Deactivated successfully. Apr 29 23:49:08.513047 systemd[1]: session-11.scope: Deactivated successfully. Apr 29 23:49:08.513612 systemd-logind[1368]: Session 11 logged out. Waiting for processes to exit. Apr 29 23:49:08.514458 systemd-logind[1368]: Removed session 11. Apr 29 23:49:09.562755 systemd-networkd[1322]: vethf47dc38: Gained IPv6LL Apr 29 23:49:09.563064 systemd-networkd[1322]: docker0: Gained IPv6LL Apr 29 23:49:13.643024 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Apr 29 23:49:13.643456 systemd[1]: Stopping docker.service - Docker Application Container Engine... Apr 29 23:49:13.643653 dockerd[1543]: time="2025-04-29T23:49:13.643484942Z" level=info msg="Processing signal 'terminated'" Apr 29 23:49:14.566089 systemd[1]: Started sshd@11-10.0.0.15:22-10.0.0.1:52812.service - OpenSSH per-connection server daemon (10.0.0.1:52812). Apr 29 23:49:14.605180 sshd[1837]: Accepted publickey for core from 10.0.0.1 port 52812 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:14.606436 sshd-session[1837]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:14.609881 systemd-logind[1368]: New session 12 of user core. Apr 29 23:49:14.627023 systemd[1]: Started session-12.scope - Session 12 of User core. Apr 29 23:49:14.679660 sshd[1839]: Connection closed by 10.0.0.1 port 52812 Apr 29 23:49:14.680012 sshd-session[1837]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:14.683650 systemd[1]: sshd@11-10.0.0.15:22-10.0.0.1:52812.service: Deactivated successfully. Apr 29 23:49:14.685201 systemd[1]: session-12.scope: Deactivated successfully. Apr 29 23:49:14.686392 systemd-logind[1368]: Session 12 logged out. Waiting for processes to exit. Apr 29 23:49:14.687316 systemd-logind[1368]: Removed session 12. Apr 29 23:49:15.644931 dockerd[1543]: time="2025-04-29T23:49:15.644846246Z" level=error msg="Error sending stop (signal 15) to container" container=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f error="Cannot kill container 2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Apr 29 23:49:15.644931 dockerd[1543]: time="2025-04-29T23:49:15.644895702Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f Apr 29 23:49:20.711040 systemd[1]: Started sshd@12-10.0.0.15:22-10.0.0.1:52828.service - OpenSSH per-connection server daemon (10.0.0.1:52828). Apr 29 23:49:20.765132 sshd[1844]: Accepted publickey for core from 10.0.0.1 port 52828 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:20.766404 sshd-session[1844]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:20.771576 systemd-logind[1368]: New session 13 of user core. Apr 29 23:49:20.784021 systemd[1]: Started session-13.scope - Session 13 of User core. Apr 29 23:49:20.838851 sshd[1846]: Connection closed by 10.0.0.1 port 52828 Apr 29 23:49:20.838729 sshd-session[1844]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:20.842485 systemd[1]: sshd@12-10.0.0.15:22-10.0.0.1:52828.service: Deactivated successfully. Apr 29 23:49:20.843990 systemd[1]: session-13.scope: Deactivated successfully. Apr 29 23:49:20.844614 systemd-logind[1368]: Session 13 logged out. Waiting for processes to exit. Apr 29 23:49:20.845523 systemd-logind[1368]: Removed session 13. Apr 29 23:49:25.645332 dockerd[1543]: time="2025-04-29T23:49:25.645067253Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f error="context deadline exceeded" Apr 29 23:49:25.646194 systemd[1]: docker-2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f.scope: Deactivated successfully. Apr 29 23:49:26.860047 systemd[1]: Started sshd@13-10.0.0.15:22-10.0.0.1:59858.service - OpenSSH per-connection server daemon (10.0.0.1:59858). Apr 29 23:49:26.901340 sshd[1851]: Accepted publickey for core from 10.0.0.1 port 59858 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:26.901853 sshd-session[1851]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:26.908005 systemd-logind[1368]: New session 14 of user core. Apr 29 23:49:26.917043 systemd[1]: Started session-14.scope - Session 14 of User core. Apr 29 23:49:26.978624 sshd[1853]: Connection closed by 10.0.0.1 port 59858 Apr 29 23:49:26.977859 sshd-session[1851]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:26.982651 systemd[1]: sshd@13-10.0.0.15:22-10.0.0.1:59858.service: Deactivated successfully. Apr 29 23:49:26.984132 systemd[1]: session-14.scope: Deactivated successfully. Apr 29 23:49:26.986454 systemd-logind[1368]: Session 14 logged out. Waiting for processes to exit. Apr 29 23:49:26.987494 systemd-logind[1368]: Removed session 14. Apr 29 23:49:28.645021 dockerd[1543]: time="2025-04-29T23:49:28.644901073Z" level=error msg="Force shutdown daemon" Apr 29 23:49:28.646852 dockerd[1543]: time="2025-04-29T23:49:28.645474997Z" level=info msg="Daemon shutdown complete" Apr 29 23:49:28.649411 systemd[1]: docker.service: Deactivated successfully. Apr 29 23:49:28.649669 systemd[1]: Stopped docker.service - Docker Application Container Engine. Apr 29 23:49:28.650670 systemd[1]: docker.socket: Deactivated successfully. Apr 29 23:49:28.651032 systemd[1]: Closed docker.socket - Docker Socket for the API. Apr 29 23:49:28.651075 systemd[1]: Stopping docker.socket - Docker Socket for the API... Apr 29 23:49:28.652550 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 29 23:49:28.652719 systemd[1]: containerd.service: Found left-over process 1769 (containerd-shim) in control group while starting unit. Ignoring. Apr 29 23:49:28.652728 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Apr 29 23:49:28.668280 systemd[1]: Starting containerd.service - containerd container runtime... Apr 29 23:49:28.669608 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 29 23:49:28.679159 systemd[1]: containerd.service: Found left-over process 1769 (containerd-shim) in control group while starting unit. Ignoring. Apr 29 23:49:28.679169 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Apr 29 23:49:28.683651 (ntainerd)[1862]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 29 23:49:28.704604 containerd[1862]: time="2025-04-29T23:49:28.704540352Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 29 23:49:28.738112 containerd[1862]: time="2025-04-29T23:49:28.738052284Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739689509Z" 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.88-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739730381Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739748515Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739790227Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739802557Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739846991Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:28.739852 containerd[1862]: time="2025-04-29T23:49:28.739859200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740056 containerd[1862]: time="2025-04-29T23:49:28.740008356Z" 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 Apr 29 23:49:28.740056 containerd[1862]: time="2025-04-29T23:49:28.740021726Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740056 containerd[1862]: time="2025-04-29T23:49:28.740032855Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740056 containerd[1862]: time="2025-04-29T23:49:28.740043743Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740129 containerd[1862]: time="2025-04-29T23:49:28.740066280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740218 containerd[1862]: time="2025-04-29T23:49:28.740181690Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:28.740298 containerd[1862]: time="2025-04-29T23:49:28.740282567Z" 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 Apr 29 23:49:28.740368 containerd[1862]: time="2025-04-29T23:49:28.740298059Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 29 23:49:28.740368 containerd[1862]: time="2025-04-29T23:49:28.740325120Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 29 23:49:28.740368 containerd[1862]: time="2025-04-29T23:49:28.740349819Z" level=info msg="metadata content store policy set" policy=shared Apr 29 23:49:28.740592 containerd[1862]: time="2025-04-29T23:49:28.740548653Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 29 23:49:28.740682 containerd[1862]: time="2025-04-29T23:49:28.740612622Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 29 23:49:28.740716 containerd[1862]: time="2025-04-29T23:49:28.740691083Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 29 23:49:28.740716 containerd[1862]: time="2025-04-29T23:49:28.740709978Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 29 23:49:28.740755 containerd[1862]: time="2025-04-29T23:49:28.740746926Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 29 23:49:28.740839 containerd[1862]: time="2025-04-29T23:49:28.740817020Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 29 23:49:28.741166 containerd[1862]: time="2025-04-29T23:49:28.741136948Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 29 23:49:28.749649 containerd[1862]: time="2025-04-29T23:49:28.749602048Z" level=info msg="cleaning leaked shim process" id=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f namespace=moby Apr 29 23:49:28.758512 containerd[1862]: time="2025-04-29T23:49:28.758340239Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Apr 29 23:49:28.763732 containerd[1862]: time="2025-04-29T23:49:28.763657267Z" level=info msg="shim disconnected" id=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f namespace=moby Apr 29 23:49:28.763977 containerd[1862]: time="2025-04-29T23:49:28.763840569Z" level=warning msg="cleaning up after shim disconnected" id=2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f namespace=moby Apr 29 23:49:28.763977 containerd[1862]: time="2025-04-29T23:49:28.763855420Z" level=info msg="cleaning up dead shim" namespace=moby Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778663502Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778706575Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778724669Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778739680Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778753251Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778766261Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778780472Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778795323Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778807413Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778819742Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778853648Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778877587Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778897923Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780420 containerd[1862]: time="2025-04-29T23:49:28.778911853Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778923943Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778935752Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778949242Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778961812Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778974582Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.778992916Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779008128Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779021018Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779032747Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779045397Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779060408Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779084066Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779096956Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780823 containerd[1862]: time="2025-04-29T23:49:28.779107965Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779160966Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779179580Z" 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 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779203359Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779215688Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779225616Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779240627Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779250595Z" level=info msg="NRI interface is disabled by configuration." Apr 29 23:49:28.781106 containerd[1862]: time="2025-04-29T23:49:28.779261644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 29 23:49:28.780841 systemd[1]: Started containerd.service - containerd container runtime. Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.779536656Z" 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}" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.779581211Z" level=info msg="Connect containerd service" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.779613876Z" level=info msg="using legacy CRI server" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.779620761Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.779735530Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780246765Z" 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" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780499400Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780546156Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780575619Z" level=info msg="Start subscribing containerd event" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780605842Z" level=info msg="Start recovering state" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780652558Z" level=info msg="Start event monitor" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780664648Z" level=info msg="Start snapshots syncer" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780673815Z" level=info msg="Start cni network conf syncer for default" Apr 29 23:49:28.781325 containerd[1862]: time="2025-04-29T23:49:28.780682742Z" level=info msg="Start streaming server" Apr 29 23:49:28.781910 containerd[1862]: time="2025-04-29T23:49:28.781882028Z" level=info msg="containerd successfully booted in 0.077929s" Apr 29 23:49:28.793087 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 29 23:49:28.793229 (dockerd)[1898]: 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 Apr 29 23:49:28.821065 dockerd[1898]: time="2025-04-29T23:49:28.820981277Z" level=info msg="Starting up" Apr 29 23:49:28.848067 dockerd[1898]: time="2025-04-29T23:49:28.848004316Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Apr 29 23:49:28.854286 dockerd[1898]: time="2025-04-29T23:49:28.854231087Z" level=info msg="Loading containers: start." Apr 29 23:49:28.867564 systemd[1]: var-lib-docker-overlay2-319459b39c61685701e4b26786d7baa5b14a7cf3621b8c487bde99f5056d7498-merged.mount: Deactivated successfully. Apr 29 23:49:29.165857 dockerd[1898]: time="2025-04-29T23:49:29.165506803Z" level=info msg="Removing stale sandbox 61fc1ac7aa9edda8c523a0f8e2fa2a0b83ff3472e8d6931c43adb010f4179b92 (2c304f08447e5173ae845073bcd9f2727cf9bdc53441960b8978680b7cc82d9f)" Apr 29 23:49:29.171101 systemd-networkd[1322]: vethf47dc38: Link DOWN Apr 29 23:49:29.171111 systemd-networkd[1322]: vethf47dc38: Lost carrier Apr 29 23:49:29.173331 kernel: docker0: port 1(vethf47dc38) entered disabled state Apr 29 23:49:29.173391 kernel: vethf47dc38 (unregistering): left allmulticast mode Apr 29 23:49:29.173411 kernel: vethf47dc38 (unregistering): left promiscuous mode Apr 29 23:49:29.175005 kernel: docker0: port 1(vethf47dc38) entered disabled state Apr 29 23:49:29.189421 systemd-networkd[1322]: docker0: Lost carrier Apr 29 23:49:29.294978 dockerd[1898]: time="2025-04-29T23:49:29.294900138Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint f0fa8f4f4a658f4c02b1ff3d7e14261a054b968cab6dfc965b8ed82b0b83114c 17b8c6477bf283da94f1a8a5c566844234092c7008be869cbbb6da71524af652], retrying...." Apr 29 23:49:29.532006 dockerd[1898]: time="2025-04-29T23:49:29.531873877Z" 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" Apr 29 23:49:29.612082 dockerd[1898]: time="2025-04-29T23:49:29.612026502Z" level=warning msg="error locating sandbox id 61fc1ac7aa9edda8c523a0f8e2fa2a0b83ff3472e8d6931c43adb010f4179b92: sandbox 61fc1ac7aa9edda8c523a0f8e2fa2a0b83ff3472e8d6931c43adb010f4179b92 not found" Apr 29 23:49:29.612209 dockerd[1898]: time="2025-04-29T23:49:29.612139151Z" level=info msg="Loading containers: done." Apr 29 23:49:29.640176 dockerd[1898]: time="2025-04-29T23:49:29.640114640Z" 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 Apr 29 23:49:29.640413 dockerd[1898]: time="2025-04-29T23:49:29.640276287Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Apr 29 23:49:29.640413 dockerd[1898]: time="2025-04-29T23:49:29.640324245Z" level=info msg="Daemon has completed initialization" Apr 29 23:49:29.672451 dockerd[1898]: time="2025-04-29T23:49:29.671952443Z" level=info msg="API listen on /run/docker.sock" Apr 29 23:49:29.672143 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 29 23:49:29.838160 systemd[1]: run-docker-netns-61fc1ac7aa9e.mount: Deactivated successfully. Apr 29 23:49:32.998041 systemd[1]: Started sshd@14-10.0.0.15:22-10.0.0.1:54774.service - OpenSSH per-connection server daemon (10.0.0.1:54774). Apr 29 23:49:33.043414 sshd[2097]: Accepted publickey for core from 10.0.0.1 port 54774 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.044650 sshd-session[2097]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.049583 systemd-logind[1368]: New session 15 of user core. Apr 29 23:49:33.056015 systemd[1]: Started session-15.scope - Session 15 of User core. Apr 29 23:49:33.110172 sshd[2099]: Connection closed by 10.0.0.1 port 54774 Apr 29 23:49:33.110800 sshd-session[2097]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.127494 systemd[1]: sshd@14-10.0.0.15:22-10.0.0.1:54774.service: Deactivated successfully. Apr 29 23:49:33.129673 systemd[1]: session-15.scope: Deactivated successfully. Apr 29 23:49:33.130858 systemd-logind[1368]: Session 15 logged out. Waiting for processes to exit. Apr 29 23:49:33.138163 systemd[1]: Started sshd@15-10.0.0.15:22-10.0.0.1:54784.service - OpenSSH per-connection server daemon (10.0.0.1:54784). Apr 29 23:49:33.139349 systemd-logind[1368]: Removed session 15. Apr 29 23:49:33.177630 sshd[2104]: Accepted publickey for core from 10.0.0.1 port 54784 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.178897 sshd-session[2104]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.183229 systemd-logind[1368]: New session 16 of user core. Apr 29 23:49:33.204090 systemd[1]: Started session-16.scope - Session 16 of User core. Apr 29 23:49:33.258364 sshd[2106]: Connection closed by 10.0.0.1 port 54784 Apr 29 23:49:33.259679 sshd-session[2104]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.272510 systemd[1]: sshd@15-10.0.0.15:22-10.0.0.1:54784.service: Deactivated successfully. Apr 29 23:49:33.279172 systemd[1]: session-16.scope: Deactivated successfully. Apr 29 23:49:33.280456 systemd-logind[1368]: Session 16 logged out. Waiting for processes to exit. Apr 29 23:49:33.291120 systemd[1]: Started sshd@16-10.0.0.15:22-10.0.0.1:54798.service - OpenSSH per-connection server daemon (10.0.0.1:54798). Apr 29 23:49:33.292074 systemd-logind[1368]: Removed session 16. Apr 29 23:49:33.331879 sshd[2111]: Accepted publickey for core from 10.0.0.1 port 54798 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.333260 sshd-session[2111]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.337424 systemd-logind[1368]: New session 17 of user core. Apr 29 23:49:33.351047 systemd[1]: Started session-17.scope - Session 17 of User core. Apr 29 23:49:33.417407 sshd[2113]: Connection closed by 10.0.0.1 port 54798 Apr 29 23:49:33.417761 sshd-session[2111]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.433439 systemd[1]: sshd@16-10.0.0.15:22-10.0.0.1:54798.service: Deactivated successfully. Apr 29 23:49:33.435583 systemd[1]: session-17.scope: Deactivated successfully. Apr 29 23:49:33.439039 systemd-logind[1368]: Session 17 logged out. Waiting for processes to exit. Apr 29 23:49:33.446435 systemd[1]: Started sshd@17-10.0.0.15:22-10.0.0.1:54810.service - OpenSSH per-connection server daemon (10.0.0.1:54810). Apr 29 23:49:33.449980 systemd-logind[1368]: Removed session 17. Apr 29 23:49:33.484093 sshd[2125]: Accepted publickey for core from 10.0.0.1 port 54810 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.485506 sshd-session[2125]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.489631 systemd-logind[1368]: New session 18 of user core. Apr 29 23:49:33.499027 systemd[1]: Started session-18.scope - Session 18 of User core. Apr 29 23:49:33.572919 systemd[1]: var-lib-docker-overlay2-4819c290fc057e021f6f62d4d540875af1fb11039d69adc9366dc632772d8229\x2dinit-merged.mount: Deactivated successfully. Apr 29 23:49:33.600260 kernel: docker0: port 1(vethd85d6b7) entered blocking state Apr 29 23:49:33.600402 kernel: docker0: port 1(vethd85d6b7) entered disabled state Apr 29 23:49:33.600425 kernel: vethd85d6b7: entered allmulticast mode Apr 29 23:49:33.600441 kernel: vethd85d6b7: entered promiscuous mode Apr 29 23:49:33.601404 systemd-networkd[1322]: vethd85d6b7: Link UP Apr 29 23:49:33.639577 containerd[1862]: time="2025-04-29T23:49:33.639080077Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 29 23:49:33.639577 containerd[1862]: time="2025-04-29T23:49:33.639143609Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 29 23:49:33.639577 containerd[1862]: time="2025-04-29T23:49:33.639169951Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:33.639577 containerd[1862]: time="2025-04-29T23:49:33.639480329Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:33.655017 systemd[1]: Started docker-3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a.scope - libcontainer container 3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a. Apr 29 23:49:33.706884 kernel: eth0: renamed from veth769c252 Apr 29 23:49:33.715068 kernel: docker0: port 1(vethd85d6b7) entered blocking state Apr 29 23:49:33.715159 kernel: docker0: port 1(vethd85d6b7) entered forwarding state Apr 29 23:49:33.715200 systemd-networkd[1322]: vethd85d6b7: Gained carrier Apr 29 23:49:33.715434 systemd-networkd[1322]: docker0: Gained carrier Apr 29 23:49:33.717694 systemd-resolved[1252]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 29 23:49:33.742396 sshd[2127]: Connection closed by 10.0.0.1 port 54810 Apr 29 23:49:33.742953 sshd-session[2125]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.751378 systemd[1]: sshd@17-10.0.0.15:22-10.0.0.1:54810.service: Deactivated successfully. Apr 29 23:49:33.752808 systemd[1]: session-18.scope: Deactivated successfully. Apr 29 23:49:33.755419 systemd-logind[1368]: Session 18 logged out. Waiting for processes to exit. Apr 29 23:49:33.756216 systemd[1]: Started sshd@18-10.0.0.15:22-10.0.0.1:54820.service - OpenSSH per-connection server daemon (10.0.0.1:54820). Apr 29 23:49:33.758669 systemd-logind[1368]: Removed session 18. Apr 29 23:49:33.796241 sshd[2200]: Accepted publickey for core from 10.0.0.1 port 54820 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.797481 sshd-session[2200]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.801787 systemd-logind[1368]: New session 19 of user core. Apr 29 23:49:33.812064 systemd[1]: Started session-19.scope - Session 19 of User core. Apr 29 23:49:33.864952 sshd[2202]: Connection closed by 10.0.0.1 port 54820 Apr 29 23:49:33.865449 sshd-session[2200]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.880280 systemd[1]: sshd@18-10.0.0.15:22-10.0.0.1:54820.service: Deactivated successfully. Apr 29 23:49:33.881682 systemd[1]: session-19.scope: Deactivated successfully. Apr 29 23:49:33.882247 systemd-logind[1368]: Session 19 logged out. Waiting for processes to exit. Apr 29 23:49:33.884144 systemd[1]: Started sshd@19-10.0.0.15:22-10.0.0.1:54824.service - OpenSSH per-connection server daemon (10.0.0.1:54824). Apr 29 23:49:33.884911 systemd-logind[1368]: Removed session 19. Apr 29 23:49:33.924009 sshd[2207]: Accepted publickey for core from 10.0.0.1 port 54824 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:33.925288 sshd-session[2207]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:33.929057 systemd-logind[1368]: New session 20 of user core. Apr 29 23:49:33.936020 systemd[1]: Started session-20.scope - Session 20 of User core. Apr 29 23:49:33.986327 sudo[2210]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/kill -SIGHUP 1862 Apr 29 23:49:33.986608 sudo[2210]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 29 23:49:33.989528 sudo[2210]: pam_unix(sudo:session): session closed for user root Apr 29 23:49:33.990583 sshd[2209]: Connection closed by 10.0.0.1 port 54824 Apr 29 23:49:33.991251 sshd-session[2207]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:33.992104 dockerd[1898]: time="2025-04-29T23:49:33.991693957Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Apr 29 23:49:33.992104 dockerd[1898]: time="2025-04-29T23:49:33.991746480Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Apr 29 23:49:33.992104 dockerd[1898]: time="2025-04-29T23:49:33.991742036Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Apr 29 23:49:33.992104 dockerd[1898]: time="2025-04-29T23:49:33.991964501Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Apr 29 23:49:34.000461 systemd[1]: containerd.service: Deactivated successfully. Apr 29 23:49:34.000530 systemd[1]: containerd.service: Unit process 2154 (containerd-shim) remains running after unit stopped. Apr 29 23:49:34.001157 systemd[1]: sshd@19-10.0.0.15:22-10.0.0.1:54824.service: Deactivated successfully. Apr 29 23:49:34.002872 systemd[1]: session-20.scope: Deactivated successfully. Apr 29 23:49:34.005504 systemd-logind[1368]: Session 20 logged out. Waiting for processes to exit. Apr 29 23:49:34.015125 systemd[1]: Started sshd@20-10.0.0.15:22-10.0.0.1:54826.service - OpenSSH per-connection server daemon (10.0.0.1:54826). Apr 29 23:49:34.016100 systemd-logind[1368]: Removed session 20. Apr 29 23:49:34.051394 sshd[2216]: Accepted publickey for core from 10.0.0.1 port 54826 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:34.052706 sshd-session[2216]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:34.056903 systemd-logind[1368]: New session 21 of user core. Apr 29 23:49:34.069020 systemd[1]: Started session-21.scope - Session 21 of User core. Apr 29 23:49:34.122339 sshd[2218]: Connection closed by 10.0.0.1 port 54826 Apr 29 23:49:34.122592 sshd-session[2216]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:34.125683 systemd[1]: sshd@20-10.0.0.15:22-10.0.0.1:54826.service: Deactivated successfully. Apr 29 23:49:34.127262 systemd[1]: session-21.scope: Deactivated successfully. Apr 29 23:49:34.128283 systemd-logind[1368]: Session 21 logged out. Waiting for processes to exit. Apr 29 23:49:34.129203 systemd-logind[1368]: Removed session 21. Apr 29 23:49:34.905078 systemd-networkd[1322]: vethd85d6b7: Gained IPv6LL Apr 29 23:49:39.156585 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Apr 29 23:49:39.157045 systemd[1]: Stopping docker.service - Docker Application Container Engine... Apr 29 23:49:39.157302 dockerd[1898]: time="2025-04-29T23:49:39.157199054Z" level=info msg="Processing signal 'terminated'" Apr 29 23:49:40.137533 systemd[1]: Started sshd@21-10.0.0.15:22-10.0.0.1:54838.service - OpenSSH per-connection server daemon (10.0.0.1:54838). Apr 29 23:49:40.177441 sshd[2223]: Accepted publickey for core from 10.0.0.1 port 54838 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:40.178706 sshd-session[2223]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:40.183286 systemd-logind[1368]: New session 22 of user core. Apr 29 23:49:40.194065 systemd[1]: Started session-22.scope - Session 22 of User core. Apr 29 23:49:40.249420 sshd[2225]: Connection closed by 10.0.0.1 port 54838 Apr 29 23:49:40.249741 sshd-session[2223]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:40.252748 systemd[1]: sshd@21-10.0.0.15:22-10.0.0.1:54838.service: Deactivated successfully. Apr 29 23:49:40.255688 systemd[1]: session-22.scope: Deactivated successfully. Apr 29 23:49:40.256493 systemd-logind[1368]: Session 22 logged out. Waiting for processes to exit. Apr 29 23:49:40.257398 systemd-logind[1368]: Removed session 22. Apr 29 23:49:41.158883 dockerd[1898]: time="2025-04-29T23:49:41.158772434Z" level=error msg="Error sending stop (signal 15) to container" container=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a error="Cannot kill container 3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a: Unavailable: connection error: desc = \"transport: Error while dialing: dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Apr 29 23:49:41.158883 dockerd[1898]: time="2025-04-29T23:49:41.158874249Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a Apr 29 23:49:42.036163 update_engine[1378]: I20250429 23:49:42.036051 1378 update_attempter.cc:509] Updating boot flags... Apr 29 23:49:42.058894 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 43 scanned by (udev-worker) (2236) Apr 29 23:49:46.263173 systemd[1]: Started sshd@22-10.0.0.15:22-10.0.0.1:34092.service - OpenSSH per-connection server daemon (10.0.0.1:34092). Apr 29 23:49:46.302564 sshd[2243]: Accepted publickey for core from 10.0.0.1 port 34092 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:46.303704 sshd-session[2243]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:46.308212 systemd-logind[1368]: New session 23 of user core. Apr 29 23:49:46.325060 systemd[1]: Started session-23.scope - Session 23 of User core. Apr 29 23:49:46.379659 sshd[2245]: Connection closed by 10.0.0.1 port 34092 Apr 29 23:49:46.380184 sshd-session[2243]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:46.383548 systemd[1]: sshd@22-10.0.0.15:22-10.0.0.1:34092.service: Deactivated successfully. Apr 29 23:49:46.385300 systemd[1]: session-23.scope: Deactivated successfully. Apr 29 23:49:46.387166 systemd-logind[1368]: Session 23 logged out. Waiting for processes to exit. Apr 29 23:49:46.388078 systemd-logind[1368]: Removed session 23. Apr 29 23:49:51.159513 dockerd[1898]: time="2025-04-29T23:49:51.159404419Z" level=warning msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a error="context deadline exceeded" Apr 29 23:49:51.160494 systemd[1]: docker-3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a.scope: Deactivated successfully. Apr 29 23:49:52.396403 systemd[1]: Started sshd@23-10.0.0.15:22-10.0.0.1:34104.service - OpenSSH per-connection server daemon (10.0.0.1:34104). Apr 29 23:49:52.443898 sshd[2250]: Accepted publickey for core from 10.0.0.1 port 34104 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:52.445425 sshd-session[2250]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:52.450038 systemd-logind[1368]: New session 24 of user core. Apr 29 23:49:52.459056 systemd[1]: Started session-24.scope - Session 24 of User core. Apr 29 23:49:52.512821 sshd[2252]: Connection closed by 10.0.0.1 port 34104 Apr 29 23:49:52.513184 sshd-session[2250]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:52.515877 systemd[1]: sshd@23-10.0.0.15:22-10.0.0.1:34104.service: Deactivated successfully. Apr 29 23:49:52.517518 systemd[1]: session-24.scope: Deactivated successfully. Apr 29 23:49:52.520442 systemd-logind[1368]: Session 24 logged out. Waiting for processes to exit. Apr 29 23:49:52.521572 systemd-logind[1368]: Removed session 24. Apr 29 23:49:54.158029 dockerd[1898]: time="2025-04-29T23:49:54.157947418Z" level=error msg="Force shutdown daemon" Apr 29 23:49:54.158380 dockerd[1898]: time="2025-04-29T23:49:54.158095141Z" level=info msg="Daemon shutdown complete" Apr 29 23:49:54.161322 systemd[1]: docker.service: Deactivated successfully. Apr 29 23:49:54.162906 systemd[1]: Stopped docker.service - Docker Application Container Engine. Apr 29 23:49:54.163411 systemd[1]: docker.socket: Deactivated successfully. Apr 29 23:49:54.163651 systemd[1]: Closed docker.socket - Docker Socket for the API. Apr 29 23:49:54.163685 systemd[1]: Stopping docker.socket - Docker Socket for the API... Apr 29 23:49:54.165126 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 29 23:49:54.165285 systemd[1]: containerd.service: Found left-over process 2154 (containerd-shim) in control group while starting unit. Ignoring. Apr 29 23:49:54.165293 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Apr 29 23:49:54.177702 systemd[1]: Starting containerd.service - containerd container runtime... Apr 29 23:49:54.178442 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 29 23:49:54.184945 systemd[1]: containerd.service: Found left-over process 2154 (containerd-shim) in control group while starting unit. Ignoring. Apr 29 23:49:54.184956 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Apr 29 23:49:54.188895 (ntainerd)[2262]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 29 23:49:54.203002 containerd[2262]: time="2025-04-29T23:49:54.202950741Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Apr 29 23:49:54.239012 containerd[2262]: time="2025-04-29T23:49:54.238949327Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240362 containerd[2262]: time="2025-04-29T23:49:54.240326094Z" 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.88-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240362 containerd[2262]: time="2025-04-29T23:49:54.240356863Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 29 23:49:54.240417 containerd[2262]: time="2025-04-29T23:49:54.240373268Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 29 23:49:54.240440 containerd[2262]: time="2025-04-29T23:49:54.240414840Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 29 23:49:54.240440 containerd[2262]: time="2025-04-29T23:49:54.240430444Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240479 containerd[2262]: time="2025-04-29T23:49:54.240455252Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240479 containerd[2262]: time="2025-04-29T23:49:54.240465775Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240646 containerd[2262]: time="2025-04-29T23:49:54.240618100Z" 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 Apr 29 23:49:54.240646 containerd[2262]: time="2025-04-29T23:49:54.240638506Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240691 containerd[2262]: time="2025-04-29T23:49:54.240651750Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240691 containerd[2262]: time="2025-04-29T23:49:54.240661072Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240691 containerd[2262]: time="2025-04-29T23:49:54.240687880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240816 containerd[2262]: time="2025-04-29T23:49:54.240792631Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 29 23:49:54.240937 containerd[2262]: time="2025-04-29T23:49:54.240913627Z" 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 Apr 29 23:49:54.240937 containerd[2262]: time="2025-04-29T23:49:54.240931552Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 29 23:49:54.240988 containerd[2262]: time="2025-04-29T23:49:54.240959280Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 29 23:49:54.240988 containerd[2262]: time="2025-04-29T23:49:54.240976165Z" level=info msg="metadata content store policy set" policy=shared Apr 29 23:49:54.241144 containerd[2262]: time="2025-04-29T23:49:54.241123009Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 29 23:49:54.241167 containerd[2262]: time="2025-04-29T23:49:54.241152978Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 29 23:49:54.241189 containerd[2262]: time="2025-04-29T23:49:54.241171503Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 29 23:49:54.241208 containerd[2262]: time="2025-04-29T23:49:54.241186988Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 29 23:49:54.241208 containerd[2262]: time="2025-04-29T23:49:54.241202552Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 29 23:49:54.241278 containerd[2262]: time="2025-04-29T23:49:54.241263690Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 29 23:49:54.242022 containerd[2262]: time="2025-04-29T23:49:54.241803410Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 29 23:49:54.249412 containerd[2262]: time="2025-04-29T23:49:54.249382207Z" level=info msg="cleaning leaked shim process" id=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a namespace=moby Apr 29 23:49:54.257661 containerd[2262]: time="2025-04-29T23:49:54.257581107Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Apr 29 23:49:54.258126 containerd[2262]: time="2025-04-29T23:49:54.258051446Z" level=info msg="shim disconnected" id=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a namespace=moby Apr 29 23:49:54.258126 containerd[2262]: time="2025-04-29T23:49:54.258105502Z" level=warning msg="cleaning up after shim disconnected" id=3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a namespace=moby Apr 29 23:49:54.258126 containerd[2262]: time="2025-04-29T23:49:54.258113864Z" level=info msg="cleaning up dead shim" namespace=moby Apr 29 23:49:54.269279 containerd[2262]: time="2025-04-29T23:49:54.269231506Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 29 23:49:54.269279 containerd[2262]: time="2025-04-29T23:49:54.269267636Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 29 23:49:54.269279 containerd[2262]: time="2025-04-29T23:49:54.269285922Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269300566Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269317371Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269330815Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269344739Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269364785Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269377269Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269392913Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269420 containerd[2262]: time="2025-04-29T23:49:54.269404917Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269427724Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269441088Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269453131Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269469456Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269481019Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269493423Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269504466Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269520391Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269532595Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269546999Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269558962Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269571 containerd[2262]: time="2025-04-29T23:49:54.269570526Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269583890Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269598774Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269620621Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269632784Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269646468Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269699284Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269717729Z" 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 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269728612Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269740976Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269750579Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269762542Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269782868Z" level=info msg="NRI interface is disabled by configuration." Apr 29 23:49:54.269806 containerd[2262]: time="2025-04-29T23:49:54.269793191Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 29 23:49:54.270154 containerd[2262]: time="2025-04-29T23:49:54.270106844Z" 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}" Apr 29 23:49:54.270231 containerd[2262]: time="2025-04-29T23:49:54.270158419Z" level=info msg="Connect containerd service" Apr 29 23:49:54.270231 containerd[2262]: time="2025-04-29T23:49:54.270193230Z" level=info msg="using legacy CRI server" Apr 29 23:49:54.270231 containerd[2262]: time="2025-04-29T23:49:54.270200152Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 29 23:49:54.270319 containerd[2262]: time="2025-04-29T23:49:54.270304622Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 29 23:49:54.270757 containerd[2262]: time="2025-04-29T23:49:54.270698339Z" 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" Apr 29 23:49:54.270912 containerd[2262]: time="2025-04-29T23:49:54.270842301Z" level=info msg="Start subscribing containerd event" Apr 29 23:49:54.270963 containerd[2262]: time="2025-04-29T23:49:54.270901839Z" level=info msg="Start recovering state" Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.270995386Z" level=info msg="Start event monitor" Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.271011111Z" level=info msg="Start snapshots syncer" Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.271022034Z" level=info msg="Start cni network conf syncer for default" Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.271031717Z" level=info msg="Start streaming server" Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.270999868Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 29 23:49:54.271143 containerd[2262]: time="2025-04-29T23:49:54.271139029Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 29 23:49:54.271300 containerd[2262]: time="2025-04-29T23:49:54.271185923Z" level=info msg="containerd successfully booted in 0.068709s" Apr 29 23:49:54.271443 systemd[1]: Started containerd.service - containerd container runtime. Apr 29 23:49:54.284143 (dockerd)[2297]: 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 Apr 29 23:49:54.284391 systemd[1]: Starting docker.service - Docker Application Container Engine... Apr 29 23:49:54.316433 dockerd[2297]: time="2025-04-29T23:49:54.316381783Z" level=info msg="Starting up" Apr 29 23:49:54.347858 dockerd[2297]: time="2025-04-29T23:49:54.346864381Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Apr 29 23:49:54.352911 dockerd[2297]: time="2025-04-29T23:49:54.352815858Z" level=info msg="Loading containers: start." Apr 29 23:49:54.370466 systemd[1]: var-lib-docker-overlay2-4819c290fc057e021f6f62d4d540875af1fb11039d69adc9366dc632772d8229-merged.mount: Deactivated successfully. Apr 29 23:49:54.672865 dockerd[2297]: time="2025-04-29T23:49:54.672141914Z" level=info msg="Removing stale sandbox a4a338833914bd3bb275eae601687897dbb77469bb6bb999db7d8eb22aea9725 (3242a1175cf775a44f9206e170a40debeda9e29bc2fd6b960f0e615c00a23a7a)" Apr 29 23:49:54.673191 systemd[1]: run-docker-netns-a4a338833914.mount: Deactivated successfully. Apr 29 23:49:54.682660 systemd-networkd[1322]: vethd85d6b7: Link DOWN Apr 29 23:49:54.683000 kernel: docker0: port 1(vethd85d6b7) entered disabled state Apr 29 23:49:54.682673 systemd-networkd[1322]: vethd85d6b7: Lost carrier Apr 29 23:49:54.685061 kernel: vethd85d6b7 (unregistering): left allmulticast mode Apr 29 23:49:54.685149 kernel: vethd85d6b7 (unregistering): left promiscuous mode Apr 29 23:49:54.685173 kernel: docker0: port 1(vethd85d6b7) entered disabled state Apr 29 23:49:54.691858 systemd-networkd[1322]: docker0: Lost carrier Apr 29 23:49:54.728584 dockerd[2297]: time="2025-04-29T23:49:54.727215931Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 24e8d489ec0d3dc1dd5f4e2d7459485c6d8af0f9d3facac74505d268c9d966c9 ef7e211fabd33997210756b96626a59098bf2be4838d348f9a4c0eab0310e3b5], retrying...." Apr 29 23:49:55.034523 dockerd[2297]: time="2025-04-29T23:49:55.034388515Z" 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" Apr 29 23:49:55.179841 dockerd[2297]: time="2025-04-29T23:49:55.177179605Z" level=warning msg="error locating sandbox id 61fc1ac7aa9edda8c523a0f8e2fa2a0b83ff3472e8d6931c43adb010f4179b92: sandbox 61fc1ac7aa9edda8c523a0f8e2fa2a0b83ff3472e8d6931c43adb010f4179b92 not found" Apr 29 23:49:55.179841 dockerd[2297]: time="2025-04-29T23:49:55.177227699Z" level=warning msg="error locating sandbox id a4a338833914bd3bb275eae601687897dbb77469bb6bb999db7d8eb22aea9725: sandbox a4a338833914bd3bb275eae601687897dbb77469bb6bb999db7d8eb22aea9725 not found" Apr 29 23:49:55.179841 dockerd[2297]: time="2025-04-29T23:49:55.177264749Z" level=info msg="Loading containers: done." Apr 29 23:49:55.261917 dockerd[2297]: time="2025-04-29T23:49:55.261803081Z" 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 Apr 29 23:49:55.262101 dockerd[2297]: time="2025-04-29T23:49:55.261938039Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 Apr 29 23:49:55.262101 dockerd[2297]: time="2025-04-29T23:49:55.261983372Z" level=info msg="Daemon has completed initialization" Apr 29 23:49:55.326663 dockerd[2297]: time="2025-04-29T23:49:55.326513110Z" level=info msg="API listen on /run/docker.sock" Apr 29 23:49:55.327012 systemd[1]: Started docker.service - Docker Application Container Engine. Apr 29 23:49:58.531403 systemd[1]: Started sshd@24-10.0.0.15:22-10.0.0.1:53882.service - OpenSSH per-connection server daemon (10.0.0.1:53882). Apr 29 23:49:58.578576 sshd[2495]: Accepted publickey for core from 10.0.0.1 port 53882 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:58.579850 sshd-session[2495]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:58.583737 systemd-logind[1368]: New session 25 of user core. Apr 29 23:49:58.595129 systemd[1]: Started session-25.scope - Session 25 of User core. Apr 29 23:49:58.648914 sshd[2497]: Connection closed by 10.0.0.1 port 53882 Apr 29 23:49:58.649350 sshd-session[2495]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:58.664233 systemd[1]: sshd@24-10.0.0.15:22-10.0.0.1:53882.service: Deactivated successfully. Apr 29 23:49:58.667296 systemd[1]: session-25.scope: Deactivated successfully. Apr 29 23:49:58.668513 systemd-logind[1368]: Session 25 logged out. Waiting for processes to exit. Apr 29 23:49:58.670703 systemd[1]: Started sshd@25-10.0.0.15:22-10.0.0.1:53886.service - OpenSSH per-connection server daemon (10.0.0.1:53886). Apr 29 23:49:58.671469 systemd-logind[1368]: Removed session 25. Apr 29 23:49:58.717819 sshd[2502]: Accepted publickey for core from 10.0.0.1 port 53886 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:58.719154 sshd-session[2502]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:58.723368 systemd-logind[1368]: New session 26 of user core. Apr 29 23:49:58.731378 systemd[1]: Started session-26.scope - Session 26 of User core. Apr 29 23:49:58.785020 sshd[2504]: Connection closed by 10.0.0.1 port 53886 Apr 29 23:49:58.785506 sshd-session[2502]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:58.795236 systemd[1]: sshd@25-10.0.0.15:22-10.0.0.1:53886.service: Deactivated successfully. Apr 29 23:49:58.796641 systemd[1]: session-26.scope: Deactivated successfully. Apr 29 23:49:58.797844 systemd-logind[1368]: Session 26 logged out. Waiting for processes to exit. Apr 29 23:49:58.798995 systemd[1]: Started sshd@26-10.0.0.15:22-10.0.0.1:53902.service - OpenSSH per-connection server daemon (10.0.0.1:53902). Apr 29 23:49:58.799729 systemd-logind[1368]: Removed session 26. Apr 29 23:49:58.847320 sshd[2509]: Accepted publickey for core from 10.0.0.1 port 53902 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:58.849070 sshd-session[2509]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:58.856453 systemd-logind[1368]: New session 27 of user core. Apr 29 23:49:58.866030 systemd[1]: Started session-27.scope - Session 27 of User core. Apr 29 23:49:58.930097 sshd[2511]: Connection closed by 10.0.0.1 port 53902 Apr 29 23:49:58.930612 sshd-session[2509]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:58.948508 systemd[1]: sshd@26-10.0.0.15:22-10.0.0.1:53902.service: Deactivated successfully. Apr 29 23:49:58.951928 systemd[1]: session-27.scope: Deactivated successfully. Apr 29 23:49:58.953251 systemd-logind[1368]: Session 27 logged out. Waiting for processes to exit. Apr 29 23:49:58.954496 systemd[1]: Started sshd@27-10.0.0.15:22-10.0.0.1:53918.service - OpenSSH per-connection server daemon (10.0.0.1:53918). Apr 29 23:49:58.955241 systemd-logind[1368]: Removed session 27. Apr 29 23:49:58.995340 sshd[2523]: Accepted publickey for core from 10.0.0.1 port 53918 ssh2: RSA SHA256:zkGkOea9Md/Gy5pSC8YV7FyThSdabJqqYiI+4lXRQbg Apr 29 23:49:58.996708 sshd-session[2523]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 29 23:49:59.000879 systemd-logind[1368]: New session 28 of user core. Apr 29 23:49:59.011058 systemd[1]: Started session-28.scope - Session 28 of User core. Apr 29 23:49:59.087121 systemd[1]: var-lib-docker-overlay2-051a32621f1b8f936ea2b9676ef8da3665d5505c80e19ca823b352b1c4a31f91\x2dinit-merged.mount: Deactivated successfully. Apr 29 23:49:59.117180 kernel: docker0: port 1(veth1202813) entered blocking state Apr 29 23:49:59.117319 kernel: docker0: port 1(veth1202813) entered disabled state Apr 29 23:49:59.117338 kernel: veth1202813: entered allmulticast mode Apr 29 23:49:59.118414 kernel: veth1202813: entered promiscuous mode Apr 29 23:49:59.119272 systemd-networkd[1322]: veth1202813: Link UP Apr 29 23:49:59.155300 containerd[2262]: time="2025-04-29T23:49:59.154976572Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 29 23:49:59.155300 containerd[2262]: time="2025-04-29T23:49:59.155033145Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 29 23:49:59.155300 containerd[2262]: time="2025-04-29T23:49:59.155047949Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:59.155300 containerd[2262]: time="2025-04-29T23:49:59.155140292Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 29 23:49:59.179032 systemd[1]: Started docker-6123ca1aaf41f19ff8adaff5abbae344245779d0583cfc6ca39015e94c2b8ab9.scope - libcontainer container 6123ca1aaf41f19ff8adaff5abbae344245779d0583cfc6ca39015e94c2b8ab9. Apr 29 23:49:59.228867 kernel: eth0: renamed from veth69cf6e1 Apr 29 23:49:59.239026 kernel: docker0: port 1(veth1202813) entered blocking state Apr 29 23:49:59.239218 kernel: docker0: port 1(veth1202813) entered forwarding state Apr 29 23:49:59.239327 systemd-networkd[1322]: veth1202813: Gained carrier Apr 29 23:49:59.239603 systemd-networkd[1322]: docker0: Gained carrier Apr 29 23:49:59.242636 systemd-resolved[1252]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Apr 29 23:49:59.270771 sshd[2525]: Connection closed by 10.0.0.1 port 53918 Apr 29 23:49:59.270386 sshd-session[2523]: pam_unix(sshd:session): session closed for user core Apr 29 23:49:59.275511 systemd[1]: sshd@27-10.0.0.15:22-10.0.0.1:53918.service: Deactivated successfully. Apr 29 23:49:59.277198 systemd[1]: session-28.scope: Deactivated successfully. Apr 29 23:49:59.278723 systemd-logind[1368]: Session 28 logged out. Waiting for processes to exit. Apr 29 23:49:59.280224 systemd-logind[1368]: Removed session 28. Apr 29 23:50:00.084441 systemd[1]: run-docker-runtime\x2drunc-moby-6123ca1aaf41f19ff8adaff5abbae344245779d0583cfc6ca39015e94c2b8ab9-runc.npYp1o.mount: Deactivated successfully. Apr 29 23:50:00.505049 systemd-networkd[1322]: veth1202813: Gained IPv6LL